builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-004 starttime: 1475815582.0 results: success (0) buildid: 20161006214101 builduid: 833269e28bd444af96e1a2c1f299061f revision: b5c1f385ee5209796b4808cc9c40c0cb0cb4521a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-06 21:46:22.000289) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-06 21:46:22.000883) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-06 21:46:22.001279) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-06 21:46:22.016127) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 21:46:22.016439) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=c6927cf182745ad25b1d38b9000001fe-1475815581.533826-388927631 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-06 21:46:22-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 80.9M=0s 2016-10-06 21:46:22 (80.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.117496 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 21:46:22.149304) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 21:46:22.149651) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=c6927cf182745ad25b1d38b9000001fe-1475815581.533826-388927631 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020189 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 21:46:22.200085) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 21:46:22.200463) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev b5c1f385ee5209796b4808cc9c40c0cb0cb4521a --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev b5c1f385ee5209796b4808cc9c40c0cb0cb4521a --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=c6927cf182745ad25b1d38b9000001fe-1475815581.533826-388927631 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-06 21:46:22,460 truncating revision to first 12 chars 2016-10-06 21:46:22,460 Setting DEBUG logging. 2016-10-06 21:46:22,460 attempt 1/10 2016-10-06 21:46:22,460 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/b5c1f385ee52?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-06 21:46:22,986 unpacking tar archive at: fx-team-b5c1f385ee52/testing/mozharness/ program finished with exit code 0 elapsedTime=0.833828 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 21:46:23.048119) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-06 21:46:23.048551) ========= script_repo_revision: b5c1f385ee5209796b4808cc9c40c0cb0cb4521a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-06 21:46:23.049080) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-06 21:46:23.049386) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-06 21:46:23.058326) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-10-06 21:46:23.058628) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=c6927cf182745ad25b1d38b9000001fe-1475815581.533826-388927631 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 21:46:23 INFO - MultiFileLogger online at 20161006 21:46:23 in /builds/slave/test 21:46:23 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 21:46:23 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:46:23 INFO - {'append_to_log': False, 21:46:23 INFO - 'base_work_dir': '/builds/slave/test', 21:46:23 INFO - 'blob_upload_branch': 'Fx-Team', 21:46:23 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:46:23 INFO - 'branch': 'Fx-Team', 21:46:23 INFO - 'buildbot_json_path': 'buildprops.json', 21:46:23 INFO - 'config_files': ('talos/linux_config.py',), 21:46:23 INFO - 'default_actions': ('clobber', 21:46:23 INFO - 'read-buildbot-config', 21:46:23 INFO - 'download-and-extract', 21:46:23 INFO - 'populate-webroot', 21:46:23 INFO - 'create-virtualenv', 21:46:23 INFO - 'install', 21:46:23 INFO - 'run-tests'), 21:46:23 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:46:23 INFO - 'download_minidump_stackwalk': True, 21:46:23 INFO - 'download_symbols': 'ondemand', 21:46:23 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:46:23 INFO - 'tooltool.py': '/tools/tooltool.py', 21:46:23 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:46:23 INFO - '/tools/misc-python/virtualenv.py')}, 21:46:23 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:46:23 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:46:23 INFO - 'installer_path': 'installer.exe', 21:46:23 INFO - 'log_level': 'info', 21:46:23 INFO - 'log_name': 'talos', 21:46:23 INFO - 'log_to_console': True, 21:46:23 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 21:46:23 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 21:46:23 INFO - 'opt_config_files': (), 21:46:23 INFO - 'pip_index': False, 21:46:23 INFO - 'sps_profile': False, 21:46:23 INFO - 'sps_profile_interval': 0, 21:46:23 INFO - 'suite': 'dromaeojs', 21:46:23 INFO - 'system_bits': '32', 21:46:23 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:46:23 INFO - 'title': 'talos-linux64-ix-004', 21:46:23 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:46:23 INFO - 'use_talos_json': True, 21:46:23 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:46:23 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:46:23 INFO - 'work_dir': 'build'} 21:46:23 INFO - [mozharness: 2016-10-07 04:46:23.413229Z] Running clobber step. 21:46:23 INFO - Running pre-action listener: _resource_record_pre_action 21:46:23 INFO - Running main action method: clobber 21:46:23 INFO - rmtree: /builds/slave/test/build 21:46:23 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:46:23 INFO - Running post-action listener: _resource_record_post_action 21:46:23 INFO - [mozharness: 2016-10-07 04:46:23.879269Z] Finished clobber step (success) 21:46:23 INFO - [mozharness: 2016-10-07 04:46:23.879369Z] Running read-buildbot-config step. 21:46:23 INFO - Running pre-action listener: _resource_record_pre_action 21:46:23 INFO - Running main action method: read_buildbot_config 21:46:23 INFO - Using buildbot properties: 21:46:23 INFO - { 21:46:23 INFO - "project": "", 21:46:23 INFO - "product": "firefox", 21:46:23 INFO - "script_repo_revision": "production", 21:46:23 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 21:46:23 INFO - "repository": "", 21:46:23 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 21:46:23 INFO - "buildid": "20161006214101", 21:46:23 INFO - "stage_platform": "linux64-pgo", 21:46:23 INFO - "basedir": "/builds/slave/test", 21:46:23 INFO - "buildnumber": 512, 21:46:23 INFO - "platform": "ubuntu64_hw", 21:46:23 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 21:46:23 INFO - "slavebuilddir": "test", 21:46:23 INFO - "branch": "fx-team", 21:46:23 INFO - "revision": "b5c1f385ee5209796b4808cc9c40c0cb0cb4521a", 21:46:23 INFO - "slavename": "talos-linux64-ix-004", 21:46:23 INFO - "builduid": "833269e28bd444af96e1a2c1f299061f", 21:46:23 INFO - "repo_path": "integration/fx-team" 21:46:23 INFO - } 21:46:23 INFO - Found installer url https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1475803800/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 21:46:23 INFO - Found a test packages url https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1475803800/firefox-52.0a1.en-US.linux-x86_64.test_packages.json. 21:46:23 INFO - Running post-action listener: _resource_record_post_action 21:46:23 INFO - [mozharness: 2016-10-07 04:46:23.881748Z] Finished read-buildbot-config step (success) 21:46:23 INFO - [mozharness: 2016-10-07 04:46:23.881835Z] Running download-and-extract step. 21:46:23 INFO - Running pre-action listener: _resource_record_pre_action 21:46:23 INFO - Running main action method: download_and_extract 21:46:23 INFO - mkdir: /builds/slave/test/build/tests 21:46:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:46:23 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1475803800/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 21:46:23 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1475803800/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 21:46:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1475803800/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 21:46:23 INFO - Downloaded 1361 bytes. 21:46:23 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 21:46:23 INFO - Using the following test package requirements: 21:46:23 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 21:46:23 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:46:23 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 21:46:23 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:46:23 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 21:46:23 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:46:23 INFO - u'jsshell-linux-x86_64.zip'], 21:46:23 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:46:23 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 21:46:23 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 21:46:23 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:46:23 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 21:46:23 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:46:23 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 21:46:23 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:46:23 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 21:46:23 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:46:23 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 21:46:23 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 21:46:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1475803800/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 21:46:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1475803800/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 21:46:23 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1475803800/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 21:46:23 INFO - Http code: 200 21:46:23 INFO - via: 1.1 73fa5a1ee49cf827e596b502b5927eab.cloudfront.net (CloudFront) 21:46:23 INFO - x-amz-cf-id: C4TUj5nmOcY2QpQRbUIlacuG7AQax_9XZcTafPGkDw5H_vIXh_xzsQ== 21:46:23 INFO - x-amz-replication-status: COMPLETED 21:46:23 INFO - x-amz-version-id: p6kTVKRIzHD4VOsN5jGg4cgyUJAov8ob 21:46:24 INFO - Expected file size: 22018133 21:46:24 INFO - Obtained file size: 22018133 21:46:28 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 21:46:28 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1475803800/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 21:46:28 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1475803800/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 21:46:28 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1475803800/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 21:46:28 INFO - Http code: 200 21:46:28 INFO - via: 1.1 d2bd759914e30b1d5aee2929535c55f9.cloudfront.net (CloudFront) 21:46:28 INFO - x-amz-cf-id: aJGWIKNe7HTl_4-yFF004FKjkHk5TnwVzafvWz5wMGXXLuhHvFHEsw== 21:46:28 INFO - x-amz-replication-status: COMPLETED 21:46:28 INFO - x-amz-version-id: p6kTVKRIzHD4VOsN5jGg4cgyUJAov8ob 21:46:28 INFO - Expected file size: 22018133 21:46:28 INFO - Obtained file size: 22018133 21:46:33 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1475803800/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 21:46:33 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1475803800/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 21:46:33 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1475803800/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 21:46:33 INFO - Http code: 200 21:46:33 INFO - via: 1.1 ccaa055c9a26ce13da709353563e04a5.cloudfront.net (CloudFront) 21:46:33 INFO - x-amz-cf-id: 8OV3LYfJj2AqUDxs9nfE353MA2PYUjA07yy2HzPBYNOGhGgdU099oA== 21:46:33 INFO - x-amz-replication-status: COMPLETED 21:46:33 INFO - x-amz-version-id: SXh85qPMvA4RMcjjuz_9cmF3fpzccuV_ 21:46:33 INFO - Expected file size: 14409006 21:46:33 INFO - Obtained file size: 14409006 21:46:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:46:33 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1475803800/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 21:46:33 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1475803800/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 21:46:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1475803800/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 21:46:34 INFO - Downloaded 59705489 bytes. 21:46:34 INFO - Setting buildbot property build_url to https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1475803800/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 21:46:34 INFO - mkdir: /builds/slave/test/properties 21:46:34 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:46:34 INFO - Writing to file /builds/slave/test/properties/build_url 21:46:34 INFO - Contents: 21:46:34 INFO - build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1475803800/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 21:46:34 INFO - Running post-action listener: _resource_record_post_action 21:46:34 INFO - Running post-action listener: set_extra_try_arguments 21:46:34 INFO - [mozharness: 2016-10-07 04:46:34.542484Z] Finished download-and-extract step (success) 21:46:34 INFO - [mozharness: 2016-10-07 04:46:34.542712Z] Running populate-webroot step. 21:46:34 INFO - Running pre-action listener: _resource_record_pre_action 21:46:34 INFO - Running main action method: populate_webroot 21:46:34 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:46:34 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:46:34 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:46:34 INFO - '--tppagecycles', 21:46:34 INFO - '7'], 21:46:34 INFO - 'tests': ['tsvgm']}}, 21:46:34 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 21:46:34 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:46:34 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:46:34 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 21:46:34 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:46:34 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:46:34 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:46:34 INFO - 'talos_options': ['--disable-e10s'], 21:46:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:46:34 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:46:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:46:34 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:46:34 INFO - 'talos_options': ['--disable-e10s'], 21:46:34 INFO - 'tests': ['damp', 'tps']}, 21:46:34 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:46:34 INFO - 'tests': ['damp', 'tps']}, 21:46:34 INFO - 'g3': {'talos_options': ['--disable-e10s'], 21:46:34 INFO - 'tests': ['dromaeo_dom']}, 21:46:34 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:46:34 INFO - 'g4': {'talos_options': ['--disable-e10s'], 21:46:34 INFO - 'tests': ['basic_compositor_video']}, 21:46:34 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 21:46:34 INFO - 'other': {'talos_options': ['--disable-e10s'], 21:46:34 INFO - 'tests': ['a11yr', 21:46:34 INFO - 'ts_paint', 21:46:34 INFO - 'tpaint', 21:46:34 INFO - 'sessionrestore', 21:46:34 INFO - 'sessionrestore_no_auto_restore', 21:46:34 INFO - 'tabpaint']}, 21:46:34 INFO - 'other-e10s': {'tests': ['a11yr', 21:46:34 INFO - 'ts_paint', 21:46:34 INFO - 'tpaint', 21:46:34 INFO - 'sessionrestore', 21:46:34 INFO - 'sessionrestore_no_auto_restore', 21:46:34 INFO - 'tabpaint']}, 21:46:34 INFO - 'other-e10s_l64': {'tests': ['a11yr', 21:46:34 INFO - 'ts_paint', 21:46:34 INFO - 'tpaint', 21:46:34 INFO - 'sessionrestore', 21:46:34 INFO - 'sessionrestore_no_auto_restore', 21:46:34 INFO - 'tabpaint']}, 21:46:34 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 21:46:34 INFO - 'ts_paint', 21:46:34 INFO - 'tpaint', 21:46:34 INFO - 'sessionrestore', 21:46:34 INFO - 'sessionrestore_no_auto_restore', 21:46:34 INFO - 'tabpaint']}, 21:46:34 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 21:46:34 INFO - 'tests': ['a11yr', 21:46:34 INFO - 'ts_paint', 21:46:34 INFO - 'tpaint', 21:46:34 INFO - 'sessionrestore', 21:46:34 INFO - 'sessionrestore_no_auto_restore', 21:46:34 INFO - 'tabpaint']}, 21:46:34 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 21:46:34 INFO - 'tests': ['a11yr', 21:46:34 INFO - 'ts_paint', 21:46:34 INFO - 'tpaint', 21:46:34 INFO - 'sessionrestore', 21:46:34 INFO - 'sessionrestore_no_auto_restore', 21:46:34 INFO - 'tabpaint']}, 21:46:34 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 21:46:34 INFO - 'tests': ['tsvgx', 21:46:34 INFO - 'tsvgr_opacity', 21:46:34 INFO - 'tart', 21:46:34 INFO - 'tscrollx', 21:46:34 INFO - 'cart']}, 21:46:34 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:46:34 INFO - 'tsvgr_opacity', 21:46:34 INFO - 'tart', 21:46:34 INFO - 'tscrollx', 21:46:34 INFO - 'cart']}, 21:46:34 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:46:34 INFO - 'talos_options': ['--disable-e10s'], 21:46:34 INFO - 'tests': ['tp5o']}, 21:46:34 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:46:34 INFO - 'tests': ['tp5o']}, 21:46:34 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:46:34 INFO - 'talos_options': ['--disable-e10s', 21:46:34 INFO - '--xperf_path', 21:46:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:46:34 INFO - 'tests': ['tp5n']}, 21:46:34 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:46:34 INFO - 'talos_options': ['--xperf_path', 21:46:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:46:34 INFO - 'tests': ['tp5n']}}, 21:46:34 INFO - 'talos.zip': {'path': '', 21:46:34 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:46:34 INFO - Running post-action listener: _resource_record_post_action 21:46:34 INFO - [mozharness: 2016-10-07 04:46:34.565247Z] Finished populate-webroot step (success) 21:46:34 INFO - [mozharness: 2016-10-07 04:46:34.565335Z] Running create-virtualenv step. 21:46:34 INFO - Running pre-action listener: _resource_record_pre_action 21:46:34 INFO - Running main action method: create_virtualenv 21:46:34 INFO - Creating virtualenv /builds/slave/test/build/venv 21:46:34 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 21:46:34 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:46:34 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:46:34 INFO - Using real prefix '/usr' 21:46:34 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:46:35 INFO - Installing distribute.............................................................................................................................................................................................done. 21:46:37 INFO - Installing pip.................done. 21:46:37 INFO - Return code: 0 21:46:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 21:46:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 21:46:37 INFO - Reading from file tmpfile_stdout 21:46:37 INFO - Output received: 21:46:37 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 21:46:37 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:46:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:46:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:46:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:46:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:46:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:46:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:46:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2b295e8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x274d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28197b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28a8790>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28a9690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28a9b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1475815581.533826-388927631', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:46:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 21:46:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 21:46:37 INFO - Using env: {'DISPLAY': ':0', 21:46:37 INFO - 'HOME': '/home/cltbld', 21:46:37 INFO - 'LANG': 'en_US.UTF-8', 21:46:37 INFO - 'LANGUAGE': 'en_US:en', 21:46:37 INFO - 'LOGNAME': 'cltbld', 21:46:37 INFO - 'MAIL': '/var/mail/cltbld', 21:46:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:46:37 INFO - 'MOZ_NO_REMOTE': '1', 21:46:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:46:37 INFO - 'NO_EM_RESTART': '1', 21:46:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:46:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:46:37 INFO - 'PWD': '/builds/slave/test', 21:46:37 INFO - 'SHELL': '/bin/bash', 21:46:37 INFO - 'SHLVL': '1', 21:46:37 INFO - 'TERM': 'linux', 21:46:37 INFO - 'TMOUT': '86400', 21:46:37 INFO - 'USER': 'cltbld', 21:46:37 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1475815581.533826-388927631', 21:46:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:46:37 INFO - '_': '/tools/buildbot/bin/python'} 21:46:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:46:37 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 21:46:37 INFO - Cleaning up... 21:46:37 INFO - Return code: 0 21:46:37 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 21:46:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:46:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:46:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:46:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:46:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:46:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:46:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2b295e8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x274d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28197b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28a8790>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28a9690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28a9b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1475815581.533826-388927631', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:46:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 21:46:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 21:46:37 INFO - Using env: {'DISPLAY': ':0', 21:46:37 INFO - 'HOME': '/home/cltbld', 21:46:37 INFO - 'LANG': 'en_US.UTF-8', 21:46:37 INFO - 'LANGUAGE': 'en_US:en', 21:46:37 INFO - 'LOGNAME': 'cltbld', 21:46:37 INFO - 'MAIL': '/var/mail/cltbld', 21:46:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:46:37 INFO - 'MOZ_NO_REMOTE': '1', 21:46:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:46:37 INFO - 'NO_EM_RESTART': '1', 21:46:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:46:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:46:37 INFO - 'PWD': '/builds/slave/test', 21:46:37 INFO - 'SHELL': '/bin/bash', 21:46:37 INFO - 'SHLVL': '1', 21:46:37 INFO - 'TERM': 'linux', 21:46:37 INFO - 'TMOUT': '86400', 21:46:37 INFO - 'USER': 'cltbld', 21:46:37 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1475815581.533826-388927631', 21:46:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:46:37 INFO - '_': '/tools/buildbot/bin/python'} 21:46:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:46:37 INFO - Downloading/unpacking psutil>=3.1.1 21:46:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:46:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:46:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:46:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:46:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:46:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:46:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:46:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:46:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:46:39 INFO - Installing collected packages: psutil 21:46:39 INFO - Running setup.py install for psutil 21:46:39 INFO - building 'psutil._psutil_linux' extension 21:46:39 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 21:46:40 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 21:46:40 INFO - building 'psutil._psutil_posix' extension 21:46:40 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 21:46:40 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 21:46:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:46:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:46:40 INFO - Successfully installed psutil 21:46:40 INFO - Cleaning up... 21:46:40 INFO - Return code: 0 21:46:40 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 21:46:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:46:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:46:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:46:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:46:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:46:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:46:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2b295e8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x274d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28197b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28a8790>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28a9690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28a9b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1475815581.533826-388927631', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:46:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 21:46:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 21:46:40 INFO - Using env: {'DISPLAY': ':0', 21:46:40 INFO - 'HOME': '/home/cltbld', 21:46:40 INFO - 'LANG': 'en_US.UTF-8', 21:46:40 INFO - 'LANGUAGE': 'en_US:en', 21:46:40 INFO - 'LOGNAME': 'cltbld', 21:46:40 INFO - 'MAIL': '/var/mail/cltbld', 21:46:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:46:40 INFO - 'MOZ_NO_REMOTE': '1', 21:46:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:46:40 INFO - 'NO_EM_RESTART': '1', 21:46:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:46:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:46:40 INFO - 'PWD': '/builds/slave/test', 21:46:40 INFO - 'SHELL': '/bin/bash', 21:46:40 INFO - 'SHLVL': '1', 21:46:40 INFO - 'TERM': 'linux', 21:46:40 INFO - 'TMOUT': '86400', 21:46:40 INFO - 'USER': 'cltbld', 21:46:40 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1475815581.533826-388927631', 21:46:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:46:40 INFO - '_': '/tools/buildbot/bin/python'} 21:46:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:46:40 INFO - Downloading/unpacking mozsystemmonitor==0.3 21:46:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:46:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:46:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:46:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:46:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:46:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:46:42 INFO - Downloading mozsystemmonitor-0.3.tar.gz 21:46:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:46:42 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 21:46:42 INFO - Installing collected packages: mozsystemmonitor 21:46:42 INFO - Running setup.py install for mozsystemmonitor 21:46:42 INFO - Successfully installed mozsystemmonitor 21:46:42 INFO - Cleaning up... 21:46:42 INFO - Return code: 0 21:46:42 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 21:46:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:46:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:46:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:46:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:46:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:46:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:46:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2b295e8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x274d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28197b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28a8790>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28a9690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28a9b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1475815581.533826-388927631', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:46:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 21:46:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 21:46:42 INFO - Using env: {'DISPLAY': ':0', 21:46:42 INFO - 'HOME': '/home/cltbld', 21:46:42 INFO - 'LANG': 'en_US.UTF-8', 21:46:42 INFO - 'LANGUAGE': 'en_US:en', 21:46:42 INFO - 'LOGNAME': 'cltbld', 21:46:42 INFO - 'MAIL': '/var/mail/cltbld', 21:46:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:46:42 INFO - 'MOZ_NO_REMOTE': '1', 21:46:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:46:42 INFO - 'NO_EM_RESTART': '1', 21:46:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:46:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:46:42 INFO - 'PWD': '/builds/slave/test', 21:46:42 INFO - 'SHELL': '/bin/bash', 21:46:42 INFO - 'SHLVL': '1', 21:46:42 INFO - 'TERM': 'linux', 21:46:42 INFO - 'TMOUT': '86400', 21:46:42 INFO - 'USER': 'cltbld', 21:46:42 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1475815581.533826-388927631', 21:46:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:46:42 INFO - '_': '/tools/buildbot/bin/python'} 21:46:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:46:42 INFO - Downloading/unpacking jsonschema==2.5.1 21:46:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:46:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:46:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:46:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:46:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:46:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:46:44 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:46:44 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 21:46:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:46:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:46:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:46:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:46:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:46:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:46:45 INFO - Downloading functools32-3.2.3-2.tar.gz 21:46:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:46:45 INFO - warning: no files found matching '*.txt' 21:46:45 INFO - no previously-included directories found matching 'build' 21:46:45 INFO - no previously-included directories found matching 'dist' 21:46:45 INFO - no previously-included directories found matching '.git*' 21:46:45 INFO - Installing collected packages: jsonschema, functools32 21:46:45 INFO - Running setup.py install for functools32 21:46:45 INFO - warning: no files found matching '*.txt' 21:46:45 INFO - no previously-included directories found matching 'build' 21:46:45 INFO - no previously-included directories found matching 'dist' 21:46:45 INFO - no previously-included directories found matching '.git*' 21:46:45 INFO - Successfully installed jsonschema functools32 21:46:45 INFO - Cleaning up... 21:46:45 INFO - Return code: 0 21:46:45 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 21:46:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:46:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:46:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:46:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:46:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:46:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:46:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2b295e8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x274d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28197b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28a8790>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28a9690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28a9b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1475815581.533826-388927631', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:46:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 21:46:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 21:46:45 INFO - Using env: {'DISPLAY': ':0', 21:46:45 INFO - 'HOME': '/home/cltbld', 21:46:45 INFO - 'LANG': 'en_US.UTF-8', 21:46:45 INFO - 'LANGUAGE': 'en_US:en', 21:46:45 INFO - 'LOGNAME': 'cltbld', 21:46:45 INFO - 'MAIL': '/var/mail/cltbld', 21:46:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:46:45 INFO - 'MOZ_NO_REMOTE': '1', 21:46:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:46:45 INFO - 'NO_EM_RESTART': '1', 21:46:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:46:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:46:45 INFO - 'PWD': '/builds/slave/test', 21:46:45 INFO - 'SHELL': '/bin/bash', 21:46:45 INFO - 'SHLVL': '1', 21:46:45 INFO - 'TERM': 'linux', 21:46:45 INFO - 'TMOUT': '86400', 21:46:45 INFO - 'USER': 'cltbld', 21:46:45 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1475815581.533826-388927631', 21:46:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:46:45 INFO - '_': '/tools/buildbot/bin/python'} 21:46:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:46:45 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 21:46:45 INFO - Cleaning up... 21:46:45 INFO - Return code: 0 21:46:45 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:46:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:46:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:46:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:46:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:46:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:46:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:46:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2b295e8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x274d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28197b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28a8790>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28a9690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28a9b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1475815581.533826-388927631', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:46:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 21:46:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 21:46:45 INFO - Using env: {'DISPLAY': ':0', 21:46:45 INFO - 'HOME': '/home/cltbld', 21:46:45 INFO - 'LANG': 'en_US.UTF-8', 21:46:45 INFO - 'LANGUAGE': 'en_US:en', 21:46:45 INFO - 'LOGNAME': 'cltbld', 21:46:45 INFO - 'MAIL': '/var/mail/cltbld', 21:46:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:46:45 INFO - 'MOZ_NO_REMOTE': '1', 21:46:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:46:45 INFO - 'NO_EM_RESTART': '1', 21:46:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:46:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:46:45 INFO - 'PWD': '/builds/slave/test', 21:46:45 INFO - 'SHELL': '/bin/bash', 21:46:45 INFO - 'SHLVL': '1', 21:46:45 INFO - 'TERM': 'linux', 21:46:45 INFO - 'TMOUT': '86400', 21:46:45 INFO - 'USER': 'cltbld', 21:46:45 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1475815581.533826-388927631', 21:46:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:46:45 INFO - '_': '/tools/buildbot/bin/python'} 21:46:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:46:45 INFO - Downloading/unpacking blobuploader==1.2.4 21:46:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:46:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:46:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:46:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:46:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:46:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:46:47 INFO - Downloading blobuploader-1.2.4.tar.gz 21:46:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:46:47 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:46:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:46:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:46:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:46:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:46:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:46:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:46:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:46:48 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:46:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:46:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:46:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:46:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:46:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:46:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:46:48 INFO - Downloading docopt-0.6.1.tar.gz 21:46:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:46:48 INFO - Installing collected packages: blobuploader, requests, docopt 21:46:48 INFO - Running setup.py install for blobuploader 21:46:48 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:46:48 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:46:48 INFO - Running setup.py install for requests 21:46:48 INFO - Running setup.py install for docopt 21:46:48 INFO - Successfully installed blobuploader requests docopt 21:46:48 INFO - Cleaning up... 21:46:49 INFO - Return code: 0 21:46:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:46:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:46:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:46:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:46:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:46:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:46:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:46:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2b295e8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x274d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28197b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28a8790>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28a9690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28a9b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1475815581.533826-388927631', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:46:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 21:46:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 21:46:49 INFO - Using env: {'DISPLAY': ':0', 21:46:49 INFO - 'HOME': '/home/cltbld', 21:46:49 INFO - 'LANG': 'en_US.UTF-8', 21:46:49 INFO - 'LANGUAGE': 'en_US:en', 21:46:49 INFO - 'LOGNAME': 'cltbld', 21:46:49 INFO - 'MAIL': '/var/mail/cltbld', 21:46:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:46:49 INFO - 'MOZ_NO_REMOTE': '1', 21:46:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:46:49 INFO - 'NO_EM_RESTART': '1', 21:46:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:46:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:46:49 INFO - 'PWD': '/builds/slave/test', 21:46:49 INFO - 'SHELL': '/bin/bash', 21:46:49 INFO - 'SHLVL': '1', 21:46:49 INFO - 'TERM': 'linux', 21:46:49 INFO - 'TMOUT': '86400', 21:46:49 INFO - 'USER': 'cltbld', 21:46:49 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1475815581.533826-388927631', 21:46:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:46:49 INFO - '_': '/tools/buildbot/bin/python'} 21:46:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:46:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:46:49 INFO - Running setup.py (path:/tmp/pip-NaShpf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:46:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:46:49 INFO - Running setup.py (path:/tmp/pip-VN3ofr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:46:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:46:49 INFO - Running setup.py (path:/tmp/pip-x0bUDj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:46:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:46:49 INFO - Running setup.py (path:/tmp/pip-nSK357-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:46:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:46:49 INFO - Running setup.py (path:/tmp/pip-DZuA28-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:46:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:46:49 INFO - Running setup.py (path:/tmp/pip-HT_X_Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:46:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:46:49 INFO - Running setup.py (path:/tmp/pip-WFXxqW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:46:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:46:49 INFO - Running setup.py (path:/tmp/pip-NosfZX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:46:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:46:49 INFO - Running setup.py (path:/tmp/pip-DSvG0A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:46:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:46:49 INFO - Running setup.py (path:/tmp/pip-RrJaTp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:46:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:46:49 INFO - Running setup.py (path:/tmp/pip-em9QYe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:46:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:46:50 INFO - Running setup.py (path:/tmp/pip-yL6llK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:46:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:46:50 INFO - Running setup.py (path:/tmp/pip-DP33NS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:46:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:46:50 INFO - Running setup.py (path:/tmp/pip-0h0IJ6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:46:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:46:50 INFO - Running setup.py (path:/tmp/pip-xVe8Kb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:46:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:46:50 INFO - Running setup.py (path:/tmp/pip-Lx8oGG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:46:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:46:50 INFO - Running setup.py (path:/tmp/pip-UkWSAz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:46:50 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:46:50 INFO - Running setup.py install for manifestparser 21:46:50 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:46:50 INFO - Running setup.py install for mozcrash 21:46:50 INFO - Running setup.py install for mozdebug 21:46:50 INFO - Running setup.py install for mozdevice 21:46:50 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 21:46:50 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:46:50 INFO - Running setup.py install for mozfile 21:46:51 INFO - Running setup.py install for mozhttpd 21:46:51 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:46:51 INFO - Running setup.py install for mozinfo 21:46:51 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:46:51 INFO - Running setup.py install for mozInstall 21:46:51 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:46:51 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:46:51 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:46:51 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:46:51 INFO - Running setup.py install for mozleak 21:46:51 INFO - Running setup.py install for mozlog 21:46:51 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:46:51 INFO - Running setup.py install for moznetwork 21:46:51 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:46:51 INFO - Running setup.py install for mozprocess 21:46:51 INFO - Running setup.py install for mozprofile 21:46:51 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:46:51 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:46:51 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:46:51 INFO - Running setup.py install for mozrunner 21:46:51 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:46:51 INFO - Running setup.py install for mozscreenshot 21:46:52 INFO - Running setup.py install for moztest 21:46:52 INFO - Running setup.py install for mozversion 21:46:52 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:46:52 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:46:52 INFO - Cleaning up... 21:46:52 INFO - Return code: 0 21:46:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:46:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:46:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:46:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:46:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:46:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:46:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:46:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2b295e8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x274d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28197b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28a8790>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28a9690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28a9b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1475815581.533826-388927631', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:46:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 21:46:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 21:46:52 INFO - Using env: {'DISPLAY': ':0', 21:46:52 INFO - 'HOME': '/home/cltbld', 21:46:52 INFO - 'LANG': 'en_US.UTF-8', 21:46:52 INFO - 'LANGUAGE': 'en_US:en', 21:46:52 INFO - 'LOGNAME': 'cltbld', 21:46:52 INFO - 'MAIL': '/var/mail/cltbld', 21:46:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:46:52 INFO - 'MOZ_NO_REMOTE': '1', 21:46:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:46:52 INFO - 'NO_EM_RESTART': '1', 21:46:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:46:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:46:52 INFO - 'PWD': '/builds/slave/test', 21:46:52 INFO - 'SHELL': '/bin/bash', 21:46:52 INFO - 'SHLVL': '1', 21:46:52 INFO - 'TERM': 'linux', 21:46:52 INFO - 'TMOUT': '86400', 21:46:52 INFO - 'USER': 'cltbld', 21:46:52 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1475815581.533826-388927631', 21:46:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:46:52 INFO - '_': '/tools/buildbot/bin/python'} 21:46:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:46:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:46:52 INFO - Running setup.py (path:/tmp/pip-60tCOC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:46:52 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 21:46:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:46:52 INFO - Running setup.py (path:/tmp/pip-X4qR5P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:46:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 21:46:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:46:52 INFO - Running setup.py (path:/tmp/pip-VLmxCx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:46:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 21:46:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:46:52 INFO - Running setup.py (path:/tmp/pip-dqDk59-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:46:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 21:46:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:46:52 INFO - Running setup.py (path:/tmp/pip-Pl_hVa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:46:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 21:46:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:46:52 INFO - Running setup.py (path:/tmp/pip-Udb6Oo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:46:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 21:46:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:46:52 INFO - Running setup.py (path:/tmp/pip-J9H_Ux-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:46:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 21:46:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:46:53 INFO - Running setup.py (path:/tmp/pip-7hUbBY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:46:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 21:46:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:46:53 INFO - Running setup.py (path:/tmp/pip-bNMDzi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:46:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 21:46:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:46:53 INFO - Running setup.py (path:/tmp/pip-0rBJMV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:46:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:46:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:46:53 INFO - Running setup.py (path:/tmp/pip-4xKDUe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:46:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 21:46:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:46:53 INFO - Running setup.py (path:/tmp/pip-QH01h3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:46:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 21:46:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:46:53 INFO - Running setup.py (path:/tmp/pip-A1t7cU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:46:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 21:46:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:46:53 INFO - Running setup.py (path:/tmp/pip-7qDo3R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:46:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 21:46:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:46:53 INFO - Running setup.py (path:/tmp/pip-BXZuvB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:46:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 21:46:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:46:53 INFO - Running setup.py (path:/tmp/pip-lsNm6u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:46:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 21:46:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:46:53 INFO - Running setup.py (path:/tmp/pip-THKgQK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:46:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 21:46:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 21:46:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 21:46:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 21:46:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 21:46:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 21:46:53 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:46:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:46:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:46:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:46:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:46:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:46:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:46:55 INFO - Downloading blessings-1.6.tar.gz 21:46:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:46:55 INFO - Installing collected packages: blessings 21:46:55 INFO - Running setup.py install for blessings 21:46:55 INFO - Successfully installed blessings 21:46:55 INFO - Cleaning up... 21:46:55 INFO - Return code: 0 21:46:55 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:46:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:46:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:46:56 INFO - Reading from file tmpfile_stdout 21:46:56 INFO - Current package versions: 21:46:56 INFO - argparse == 1.2.1 21:46:56 INFO - blessings == 1.6 21:46:56 INFO - blobuploader == 1.2.4 21:46:56 INFO - docopt == 0.6.1 21:46:56 INFO - functools32 == 3.2.3-2 21:46:56 INFO - jsonschema == 2.5.1 21:46:56 INFO - manifestparser == 1.1 21:46:56 INFO - mozInstall == 1.12 21:46:56 INFO - mozcrash == 0.17 21:46:56 INFO - mozdebug == 0.1 21:46:56 INFO - mozdevice == 0.48 21:46:56 INFO - mozfile == 1.2 21:46:56 INFO - mozhttpd == 0.7 21:46:56 INFO - mozinfo == 0.9 21:46:56 INFO - mozleak == 0.1 21:46:56 INFO - mozlog == 3.4 21:46:56 INFO - moznetwork == 0.27 21:46:56 INFO - mozprocess == 0.23 21:46:56 INFO - mozprofile == 0.28 21:46:56 INFO - mozrunner == 6.12 21:46:56 INFO - mozscreenshot == 0.1 21:46:56 INFO - mozsystemmonitor == 0.3 21:46:56 INFO - moztest == 0.7 21:46:56 INFO - mozversion == 1.4 21:46:56 INFO - psutil == 3.1.1 21:46:56 INFO - requests == 1.2.3 21:46:56 INFO - wsgiref == 0.1.2 21:46:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:46:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:46:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:46:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:46:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:46:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:46:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:46:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2b295e8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x274d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28197b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28a8790>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28a9690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28a9b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1475815581.533826-388927631', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:46:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 21:46:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 21:46:56 INFO - Using env: {'DISPLAY': ':0', 21:46:56 INFO - 'HOME': '/home/cltbld', 21:46:56 INFO - 'LANG': 'en_US.UTF-8', 21:46:56 INFO - 'LANGUAGE': 'en_US:en', 21:46:56 INFO - 'LOGNAME': 'cltbld', 21:46:56 INFO - 'MAIL': '/var/mail/cltbld', 21:46:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:46:56 INFO - 'MOZ_NO_REMOTE': '1', 21:46:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:46:56 INFO - 'NO_EM_RESTART': '1', 21:46:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:46:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:46:56 INFO - 'PWD': '/builds/slave/test', 21:46:56 INFO - 'SHELL': '/bin/bash', 21:46:56 INFO - 'SHLVL': '1', 21:46:56 INFO - 'TERM': 'linux', 21:46:56 INFO - 'TMOUT': '86400', 21:46:56 INFO - 'USER': 'cltbld', 21:46:56 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1475815581.533826-388927631', 21:46:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:46:56 INFO - '_': '/tools/buildbot/bin/python'} 21:46:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:46:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 21:46:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 21:46:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 21:46:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 21:46:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 21:46:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 21:46:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 21:46:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 21:46:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 21:46:56 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 21:46:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 21:46:56 INFO - Cleaning up... 21:46:56 INFO - Return code: 0 21:46:56 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:46:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:46:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:46:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:46:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:46:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:46:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:46:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2b295e8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x274d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28197b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28a8790>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28a9690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28a9b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1475815581.533826-388927631', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:46:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 21:46:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 21:46:56 INFO - Using env: {'DISPLAY': ':0', 21:46:56 INFO - 'HOME': '/home/cltbld', 21:46:56 INFO - 'LANG': 'en_US.UTF-8', 21:46:56 INFO - 'LANGUAGE': 'en_US:en', 21:46:56 INFO - 'LOGNAME': 'cltbld', 21:46:56 INFO - 'MAIL': '/var/mail/cltbld', 21:46:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:46:56 INFO - 'MOZ_NO_REMOTE': '1', 21:46:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:46:56 INFO - 'NO_EM_RESTART': '1', 21:46:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:46:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:46:56 INFO - 'PWD': '/builds/slave/test', 21:46:56 INFO - 'SHELL': '/bin/bash', 21:46:56 INFO - 'SHLVL': '1', 21:46:56 INFO - 'TERM': 'linux', 21:46:56 INFO - 'TMOUT': '86400', 21:46:56 INFO - 'USER': 'cltbld', 21:46:56 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1475815581.533826-388927631', 21:46:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:46:56 INFO - '_': '/tools/buildbot/bin/python'} 21:46:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:46:56 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 21:46:56 INFO - Cleaning up... 21:46:56 INFO - Return code: 0 21:46:56 INFO - Running post-action listener: _resource_record_post_action 21:46:56 INFO - Running post-action listener: _start_resource_monitoring 21:46:56 INFO - Starting resource monitoring. 21:46:56 INFO - [mozharness: 2016-10-07 04:46:56.618697Z] Finished create-virtualenv step (success) 21:46:56 INFO - [mozharness: 2016-10-07 04:46:56.619162Z] Running install step. 21:46:56 INFO - Running pre-action listener: _resource_record_pre_action 21:46:56 INFO - Running main action method: install 21:46:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:46:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:46:56 INFO - Reading from file tmpfile_stdout 21:46:56 INFO - Detecting whether we're running mozinstall >=1.0... 21:46:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:46:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:46:56 INFO - Reading from file tmpfile_stdout 21:46:56 INFO - Output received: 21:46:56 INFO - Usage: mozinstall [options] installer 21:46:56 INFO - Options: 21:46:56 INFO - -h, --help show this help message and exit 21:46:56 INFO - -d DEST, --destination=DEST 21:46:56 INFO - Directory to install application into. [default: 21:46:56 INFO - "/builds/slave/test"] 21:46:56 INFO - --app=APP Application being installed. [default: firefox] 21:46:56 INFO - mkdir: /builds/slave/test/build/application 21:46:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 21:46:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 21:47:14 INFO - Reading from file tmpfile_stdout 21:47:14 INFO - Output received: 21:47:14 INFO - /builds/slave/test/build/application/firefox/firefox 21:47:14 INFO - Running post-action listener: _resource_record_post_action 21:47:14 INFO - [mozharness: 2016-10-07 04:47:14.354932Z] Finished install step (success) 21:47:14 INFO - [mozharness: 2016-10-07 04:47:14.355202Z] Running run-tests step. 21:47:14 INFO - Running pre-action listener: _resource_record_pre_action 21:47:14 INFO - Running main action method: run_tests 21:47:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:47:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:47:14 INFO - Python 2.7.3 21:47:14 INFO - Return code: 0 21:47:14 INFO - grabbing minidump binary from tooltool 21:47:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:47:14 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28a8790>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28a9690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28a9b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:47:14 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 21:47:14 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 21:47:14 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 21:47:14 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:47:14 INFO - Return code: 0 21:47:14 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 21:47:14 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:47:14 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:47:14 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 21:47:14 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:47:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1475803800/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-004', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 21:47:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1475803800/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-004 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 21:47:14 INFO - Using env: {'DISPLAY': ':0', 21:47:14 INFO - 'HOME': '/home/cltbld', 21:47:14 INFO - 'LANG': 'en_US.UTF-8', 21:47:14 INFO - 'LANGUAGE': 'en_US:en', 21:47:14 INFO - 'LOGNAME': 'cltbld', 21:47:14 INFO - 'MAIL': '/var/mail/cltbld', 21:47:14 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:47:14 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 21:47:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:47:14 INFO - 'MOZ_NO_REMOTE': '1', 21:47:14 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:47:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:47:14 INFO - 'NO_EM_RESTART': '1', 21:47:14 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:47:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:47:14 INFO - 'PWD': '/builds/slave/test', 21:47:14 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:47:14 INFO - 'SHELL': '/bin/bash', 21:47:14 INFO - 'SHLVL': '1', 21:47:14 INFO - 'TERM': 'linux', 21:47:14 INFO - 'TMOUT': '86400', 21:47:14 INFO - 'USER': 'cltbld', 21:47:14 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1475815581.533826-388927631', 21:47:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:47:14 INFO - '_': '/tools/buildbot/bin/python'} 21:47:14 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1475803800/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-004', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 21:47:14 INFO - mozversion application_buildid: 20161006183000 21:47:14 INFO - mozversion application_changeset: b5c1f385ee5209796b4808cc9c40c0cb0cb4521a 21:47:14 INFO - mozversion application_display_name: Nightly 21:47:14 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:47:14 INFO - mozversion application_name: Firefox 21:47:14 INFO - mozversion application_remotingname: firefox 21:47:14 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 21:47:14 INFO - mozversion application_vendor: Mozilla 21:47:14 INFO - mozversion application_version: 52.0a1 21:47:14 INFO - mozversion platform_buildid: 20161006183000 21:47:14 INFO - mozversion platform_changeset: b5c1f385ee5209796b4808cc9c40c0cb0cb4521a 21:47:14 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 21:47:14 INFO - mozversion platform_version: 52.0a1 21:47:14 INFO - using testdate: 1475815634 21:47:14 INFO - actual date: 1475815634 21:47:14 INFO - starting webserver on 'localhost:48857' 21:47:14 INFO - SUITE-START | Running 2 tests 21:47:14 INFO - TEST-START | dromaeo_css 21:47:14 INFO - operating with platform_type : linux_ 21:47:14 INFO - Initialising browser for dromaeo_css test... 21:47:14 INFO - TEST-INFO | started process 14226 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTKJyRo/profile http://localhost:48857/getInfo.html) 21:47:18 INFO - PROCESS | 14226 | __metrics Screen width/height:1600/1200 21:47:18 INFO - PROCESS | 14226 | colorDepth:24 21:47:18 INFO - PROCESS | 14226 | Browser inner width/height: 1024/697 21:47:18 INFO - PROCESS | 14226 | __metrics 21:47:19 INFO - PROCESS | 14226 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 21:47:19 INFO - PROCESS | 14226 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:47:19 INFO - PROCESS | 14226 | console.error: PushService: 21:47:19 INFO - PROCESS | 14226 | stateChangeProcessEnqueue: Error transitioning state 21:47:19 INFO - PROCESS | 14226 | UnknownError 21:47:20 INFO - TEST-INFO | 14226: exit 0 21:47:20 INFO - Browser initialized. 21:47:20 INFO - Running cycle 1/1 for dromaeo_css test... 21:47:20 INFO - TEST-INFO | started process 14310 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTKJyRo/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:47:32 INFO - PROCESS | 14310 | RSS: Main: 173367296 21:47:32 INFO - PROCESS | 14310 | 21:48:24 INFO - PROCESS | 14310 | 1475815704001 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 21:50:34 INFO - PROCESS | 14310 | Cycle 1(1): loaded http://localhost:48857/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48857/tests/dromaeo/cssquery-ext.html) 21:50:35 INFO - PROCESS | 14310 | RSS: Main: 284053504 21:50:35 INFO - PROCESS | 14310 | 21:53:38 INFO - PROCESS | 14310 | Cycle 1(1): loaded http://localhost:48857/tests/dromaeo/cssquery-ext.html (next: http://localhost:48857/tests/dromaeo/cssquery-jquery.html) 21:53:38 INFO - PROCESS | 14310 | RSS: Main: 268840960 21:53:38 INFO - PROCESS | 14310 | 21:56:41 INFO - PROCESS | 14310 | Cycle 1(1): loaded http://localhost:48857/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48857/tests/dromaeo/cssquery-mootools.html) 21:56:41 INFO - PROCESS | 14310 | RSS: Main: 270241792 21:56:41 INFO - PROCESS | 14310 | 21:59:43 INFO - PROCESS | 14310 | Cycle 1(1): loaded http://localhost:48857/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48857/tests/dromaeo/cssquery-prototype.html) 21:59:44 INFO - PROCESS | 14310 | RSS: Main: 246169600 21:59:44 INFO - PROCESS | 14310 | 22:02:47 INFO - PROCESS | 14310 | Cycle 1(1): loaded http://localhost:48857/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48857/tests/dromaeo/cssquery-yui.html) 22:02:47 INFO - PROCESS | 14310 | RSS: Main: 215678976 22:02:47 INFO - PROCESS | 14310 | 22:05:50 INFO - PROCESS | 14310 | Cycle 1(1): loaded http://localhost:48857/tests/dromaeo/cssquery-yui.html (next: http://localhost:48857/tests/dromaeo/cssquery-dojo.html) 22:05:51 INFO - PROCESS | 14310 | RSS: Main: 304373760 22:05:51 INFO - PROCESS | 14310 | 22:05:51 INFO - PROCESS | 14310 | __start_tp_report 22:05:51 INFO - PROCESS | 14310 | _x_x_mozilla_page_load 22:05:51 INFO - PROCESS | 14310 | _x_x_mozilla_page_load_details 22:05:51 INFO - PROCESS | 14310 | |i|pagename|runs| 22:05:51 INFO - PROCESS | 14310 | |0;dojo.html;2991.65595956465;3025.561293612425;3028.1218446650464;3058.587090742749;3075.800072995255;5176.663516871406;5177.7928882844735;5231.607629427798;5247.86880327992;5267.078261304271;5277.736113194344;5285.762140703668;5306.840794776153;5326.254324394578;5371.462853714626;4834.516548345173;4845.757712114389;4864.683795553296;4892.315075889378;4903.190973489388;4840.177169881129;4860.829870954517;4864;4881.926771098437;4925.310456536088;4486.304622783474;4867.440244371907;4916.926246106311;4928.383952005999;4984.77568509418;4718.504557021532;4869.707817530924;4872.366592343008;4912.042151780404;4932.8273510427325;4673.766311684436;4709.6938698984795;4744.810207591692;4782.13921494131;4787.425508938914;5053.570446512051;5169.999999999963;5180.922286165711;5181.922271165936;5220.504052115043;5572.693501857396;5614.775408983635;5615.887682246333;5621.7751289948355;5633.070543360341;5498.147787093007;5498.505134537871;5553.944460555384;5554.416786237427;5568.777248910039;5187.066328060948;5206.479352064801;5210.114280572312;5217.373915130132;5218.66078704883;5700.173474846124;5704.942950570441;5715.257016587817;5722;5787.855303617359;5343.946560534345;5371.919421208685;5441.428649991693;5472.50747432733;5483.533899618497;5577.525910297589;5594.356648985337;5595.440455954372;5602.299712535933;5658.094704847204;5554.91667624986;5555.777768889199;5566.805161819398;5567.860803479945;5573.721313934287;5346.358436987586;5357.223202635596;5404.108322126805;5504.559635229252;5650.180723795027;4263.253930562139;4290.528041915387;4293.0984493256765;4321.7406955582765;4323.546027667113;3794.165283637595;3863.6715879150024;3888.300105980894;3909.9218015639526;3938.5273767148124;5240.711760853113;5243.764030618631;5246.97376513115;5252.185911183773;5309.867253318698;5411.756470958816;5536.695481748462;5577.944220557823;5579.497845193952;5594.216809646653;5158.871028224249;5199.818006369759;5231.973840130775;5277;5327.334083239595;4806.8798280043275;4810.254410566367;4815.036992601494;4818.566329030404;4871.2206047032305;5677.205191273142;5787.218725472091;5791.391903850035;5794.710264486759;5798.043322851682;5492.286002819608;5637.9718101409235;5658.5473162147755;5663.8867222656145;5727.914081288867;5859.9121013183985;5891.1752354671235;5894.882102357843;5899.646021238739;5900.085486749561;5568.526675232489;5576.191452239322;5581.748821303132;5586.497215250647;5591.384947655673;5427.1316589345515;5499.945000550103;5517.144842549411;5524.475174858382;5579.13523403873;5450.5912056595125;5451.127819548853;5459.12653975362;5465.098258787256;5497.725113744217;5444.782208711607;5449.754761035683;5452.26394436746;5462.235287059894;5470.261514695465;5237.973810131078;5288.365396152486;5371.328583927009;5434.864128396664;5485.917711234414;5498;5570.164475328733;5572.080606699849;5605.915911261416;5633.971830140987;5233.058049551118;5399.973000135132;5412.43169467216;5420.349558053059;5423.7830486780085 22:05:51 INFO - PROCESS | 14310 | |1;ext.html;572.3446653581649;599.2928344553425;604.2235727090689;613.5337143770732;630.1618846933579;31827.204319892015;43445.34831977519;43889.12221755563;43907.99999999996;44049.119017619625;44798.77600611992;45252.32121518171;45264;45309.32036019462;45328.3200751989;8087.353011759045;8326.209010144057;8954.37319387643;9113.270938324918;9125.49809760463;10614.203934704889;10860.891391086067;10861.619843305485;11190.776184476306;11195.552177912914;10997.395143267117;11077.279976801523;11077.778444431107;11102.222844400896;11119.555217791278;8280.50316980983;8506.532140732257;10687.412192329419;10869;10948.562057517689;10678.733031674192;10795;10803.297785643908;10803.459827008697;10806.945965270203;42576.148477030285;42626;42898.78550607227;42900;42939.35590966138;3490.8080055596934;3497.3704733148024;3560.8219589020446;3731.8320675569394;4050.392441133824;31174.376512469622;31248.21879453009;31498.527522087188;32349.35301293961;33594.83202583996;4286.978565107186;4362.432883725127;4526.54734526548;4562.384078149441;4565.360849481075;336709;338701;341525;341863;342532;58999.70500147557;59242;59565.702171489735;59670;59697.403025969186;36447.4532882007;37332.62667373346;37376.25247495035;60683.69658151681;61007.38992610017;16929.83070169307;17300;17323.913380433016;17329.133543322783;17330.39343622967;12174.391280435942;12421.565245216374;13134;13508.864911350956;13714.314284285745;19181.520461988282;19212.327568535035;19229.615407691766;19246.326378576683;19335.806641933683;6974.1889084225995;6991.23096459389;7136.215016348197;7163.89254161188;7215.690978886811;984.4487087231173;1022.3094628391501;1051.4374809476892;1117.782032503654;1141.9657410277705;30807.22981925425;32176.517352239734;32257.677423225938;32444.675553244637;32686.673133268363;1106.0322218059198;1108.2131686502673;1117.2179474367974;1119.9440027998567;1128.0862501373913;16380.918095409446;17099.91450042767;17203.91398043027;17233;17369;550078;554174;554602;555758;559551;58866.11700824491;59322;59417.70291148517;59439.70280148571;59514.404855951754;1191.249512806926;1249.4065318973596;1291.7416516696885;1341.0545565376385;1350.2708537389897;29046.7095329044;32974;33209.83395083009;33356;33515.927359332745;50651;50875.491245087076;51251.743741281054;51322;51365.7431712839;399081;401187;401475;402248;403997;28108.578371324857;28393.43213135767;28515.572266415606;28850;30595.847020764755;48109.5189048105;48256;48407.51592484171;48449.75775121102;48596.514034860615;40232.195356093296;41008.1798364037;41358.1728365425;41626.79186604169;42999.355009675506;40318.1936361277;40662.1867562653;40910.59089409068;41331;41914.79042604767;40392.596074038884;41047.589524104376;41378.586214137475;41442.37836432396;41632.16735665209;34830.30339393249;36683.81658091692;37267.68473590806;37493;37608;27069.458610828067;27616.171514854588;27781.16656500308;28032.86803286787;28137.71862281351 22:05:51 INFO - PROCESS | 14310 | |2;jquery.html;372.94219395993633;383.1322055544193;384.46559282597184;393.6752179451952;409.4963195269818;13843.893859222468;14368.137911725304;16893.746593801086;19724.901375493137;19899.502512437197;18320.26718931241;18361.173747181376;18751.437456876316;18802.24791008358;18945.62108757824;5625.099984002561;5855.355910849803;5858.472737453629;5858.73635686393;5860.120981852735;4210.59999300066;4407.713498622596;4504.391907092549;5765.336986246593;5839.4160583941475;4447.110577884436;4459.955400446002;4461.977690111545;6145;6544.083828264047;6356.872862542769;6541.738330466776;6548.1814773153355;6594.505412094112;6609.933900661004;5860.2967643883;5866.20806191163;5867;5871.295444546639;5871.324797648283;23765.287041388787;24405.26784196477;24585.13952011689;24952.625710614175;25136.874315628487;2284.48599065209;2390.1395497620842;2426.06596460364;2453.6196889482158;2465.7657522535333;15055;15859;15986.840131598652;15991.92004039984;16404.507864764077;1964;2095.8218551423147;2105.789421057882;2209;2232.2075663139676;93415.53292233564;97136.51431742866;97192.51403743007;98818.50590747072;100914.49542752313;17356.82643173552;17361.47915562535;17514.29942802299;17923.910380448015;18285.634287314446;31940;32095.197620059684;32203.296620888897;32229.194270143435;32235.194120147185;9634.9036509634;10047.447390393452;10126.493675316206;10171.288009839389;10220.488975551192;8398.874016889751;8411.242988130974;8694.435141633234;8732.65069397217;8789.165029322205;8016.358691304682;8734.86897696535;8868.33487488441;8922.509261990654;8966.551672416354;2849.9145025649264;3198.63215730194;3431;3446.379651662675;3489;890.5547226386807;946.129560804062;993.0317940008579;1022.2384323678907;1091.5360971587045;19297.4210773677;19332.516687082934;19395.418137455898;19519.707204391947;19643.94537298818;991.9133171334149;1015.2284263959444;1018.1549314069305;1030.7423144213947;1076.1068313299943;10300.690979270634;10973.561057557608;10978.890211097947;10979.505922233519;11009;343955;345396;454359;458336.9995600483;460876;98264;98732.50633746928;101610.49194754126;102759.03314228756;104489;1013.9138173255209;1044.2481413382504;1059.0362769879373;1064.6646306413454;1082.653550863716;16738.497845064667;17086.48740537786;17528.91235543814;17809.46571602854;18171.636567268844;28510;29876.850615746782;33882.98351049473;37148.44277335788;42607.57392426036;57683.4231657678;58104.70947645235;58134.7093264531;59553.70223148856;61217;8475.355597093308;8587.270082043096;8689.956550217461;8810.779730506532;8846.513441760764;12597.874021260037;12657.367131643197;13033.413496392875;13393.598192054254;13598.728025439634;11539.653810385365;11554.133439991867;11615.5934542294;11673.883261167619;11718.765624687629;11276.379799111128;11277.041451476716;11341.149413794163;11401.258918170292;11787.410629468664;11378.203525753117;11503.827442588201;11843;12417.75164496687;12429.12996090265;7369.373603243785;7868.84262314762;8688.174623410765;8854.424462409923;9007.414518056305;10924.235303528676;11457.255278406878;11504.309741415542;11657.825132623188;11687.88312116868 22:05:51 INFO - PROCESS | 14310 | |3;mootools.html;1490.6347944753534;1514.4775052606851;1631.4779270633394;1750.9562260943483;1773.5920738230207;7885.408594355417;8140.755777326674;8561.443506172101;9227.354085214038;9234.815303693922;8488.787780305496;8880.422772519782;8882.511461869612;9118.224950879166;9127.041660625622;2365.538719949615;2391.210900402863;2395.64065390192;2396.077510158584;2398.1606437746736;2022.8482863785202;2108.283183717536;2320.153144102399;2358.2666739946126;2386.606209975352;2264.184893438361;2355.105060077177;2361.89371478283;2374.525094981002;2376.1802178248563;2340.040583360831;2347.471818840764;2356.0929042318658;2358.445765245166;2361.4804742956608;2328.836981411302;2331.6152834782242;2336.97663023371;2341.8594884306995;2353.8587684738973;8897.822043559092;9008.77478063047;9047.230985366252;9061.728148155566;9081.59132839024;5304.708241046741;5458.918116228259;5461.262729531502;5468.535174510172;5472.206530053159;3378.3581119587448;3494.5806503219524;3536.487209354655;3551.94672079919;3557.8221088945706;1151.7869194199016;1178.988210117905;1206.873278305774;1218.7684339975376;1222.3277197541406;12794.360281985957;12823.935880320632;12832.80750788739;12856.550020749322;12864.549740759123;4618.3907824697535;4663.626909847204;4761.595264402565;4789.257665061921;4893.951060489349;10748.677539673823;10758.24692271549;10767.407792571326;10768.892311076946;10769.946150269356;5412.729363531807;5424.837254882281;5427.565794736412;5428.565714742811;5429.755660995264;4733.95266047342;4910.21436570147;4982.90034199314;4983.651144419929;4991;3729.6643302102398;3847.769133851978;3894.065424298148;3898.590647981978;3918.1771827916455;1010.9191264698807;1015.1574193419444;1138.686861113184;1166.1953252255917;1184.08233618946;828.5650033732338;926.5969303353063;940.3370623710268;944.9227880216558;971.0435221307007;5756.7121643917635;5842.8539286517325;5844.824655260349;5867.413258674099;6035.7283922223605;940.8259471997702;959.1559427703576;966.2270183852889;966.7051549277397;975.673149494913;3959.40608908666;4095.692823038284;4100.815463304159;4127.8968025798995;4201.831926722958;10810.189235807346;11292.54829806815;11299.322040677585;11304.943475282735;11335.82596872877;11222.494987725571;11223.551057957753;11229.10167186623;11232.719182020352;11235.943820280847;8266.718658607926;8285.917140828635;8328.916710832935;8394.37042221848;8394.874076888851;5662.716864156858;5679.971600141973;5685.431456854281;5848.2689663792025;5870.090136028923;10083.596656133966;10142.188624910137;10287.331323463952;10375.584976600852;10461.895381046092;10113.494325283853;10376.74058148522;10784;10786.622468213574;10818.134549235885;7642.5032372895585;7722;7788.260115289038;7789;7792.4545281832;8597.484150950962;8655.09121542229;8679.609417576097;8683.044865064712;8683.609237584451;7452.3665488431925;7635.961820190863;7716.228377162239;7879.921200788148;7887.211278872296;7464.589447580435;7578.355839753683;7583.582902940391;7637.427192960439;7653.57905315213;6688.799336019927;6732.8653426930205;6735.259121496533;6737.629430381376;6874.553154044971;4678.181318269221;4868.610511159028;4961.479044700254;5000.924986125284;5162.5869930406225;5139.781212015916;5167.715775632376;5212.530872221519;5368.141097424394;5385.353757549119 22:05:51 INFO - PROCESS | 14310 | |4;prototype.html;332.11491375484337;333.64633488502176;340.0919544815343;341.7556447140295;343.4864877008872;5048.217526283432;5220.68675879447;5246.580273578114;5297.629165958385;5302.814401495948;5075.9492405075935;5178.559822415099;5202.1936599826995;5219.408080535435;5226.216067589863;4155.168966206756;4160.958390416103;4177.310743727281;4180.770057646828;4201.76890271035;4009.258287216874;4126.9793651031705;4191.350340697181;4203.831846726127;4215.283401821697;4084.530279017906;4089.26393249215;4095.8361665533344;4107.116969851481;4107.788202480276;4050.392441133839;4060.918781624351;4065.532463766675;4093.488313960755;4105.220008198433;3614.34941710492;3624.420092785168;3624.746267761258;3625.2205775758075;3650.452432135201;5032.169692000815;5067.366579177603;5099.974500127512;5100.056489549445;5126.6667666601925;4653.185692503798;4664.486906440289;4682.157211701892;4682.461516925563;4721.693089949143;5373.5163835254625;5386.622936394454;5426.131818908995;5457.781688732446;5495.505404513573;3826.789526576037;3960.8019599019935;3962.920741585181;3964.920701585952;3972.6424621784176;5543.722813859331;5545.72271386429;5597.944020559783;5645;5650.841577476607;4018.3524754850373;4053.2704113259306;4059.594040595917;4100.0774825664585;4107.342825147962;4049.8785036448953;4093.570175131628;4095.447114639545;4146.295129827937;4159.251334759772;4618.1918164321105;4621.676482646182;4634.814607415733;4657.371254880548;4665.300204969281;5467.507924286754;5481.397046324901;5515.641483303572;5531.944680553223;5547.278853748987;1339.4709089909431;1369.9657508562366;1397.77635578307;1410.75311820431;1416.9574912752635;953.6042542344987;961.6441916490943;972.9318947673595;977.1694060048901;988.6292640259902;5171.3018742469285;5208.869778255498;5213.348331458567;5228.08508511009;5232.92150617741;5476.507114359727;5491.478309560585;5537.197106419547;5542.861428464321;5547.278853748987;5002.424721157041;5197.792088316501;5223.112070947948;5242.8465737538445;5269.209618557247;2973.3012742005612;2992.8653210605576;2997.8501074946603;3007;3010.7591392688532;5842.415758424124;5878.647281163144;5886.205362276038;5887.499562537147;5905.291365036223;5604.299462567179;5746.138079288056;5772.797952071657;5790.594658373873;5821.243238379068;5802.549362659335;5822.33043200029;5823.941760582509;5842.152887831326;5890.234269545017;5414.918776218438;5551.444855514416;5612.915806262991;5694.345150307602;5696.316442026983;5459.880724451557;5560.054790685513;5580.720963951868;5582.5533957282505;5586.916196256978;5709.628874123168;5809.419058094157;5811.476967072984;5822.70886455684;5825.155352473952;3961.9405708913814;4042.7372220805555;4057.39139129133;4079.7760671797746;4086.1623367210245;5318.7074710891275;5572.3034620672415;5612.165856242571;5617.578681598979;5640.153976903333;5314.176302673091;5407.323374929435;5497.361266591978;5530.423829208818;5539.833804985857;5486.862828429321;5501.312335958005;5502.80740174092;5510.559155267489;5511.4213007633625;5266.051560922483;5471.945280547144;5485.533729632866;5487.420912171273;5509.614326997072;5517.972410137923;5524.91712624319;5529.778808847601;5532.336119665666;5535.418781027934;5421.295231619864;5430.8099216527235;5438.483344082306;5443.074677304789;5470.206820010996 22:05:51 INFO - PROCESS | 14310 | |5;yui.html;654.8690261947612;720.618072421616;730.6091241185967;743.8028922335582;835.3400813357448;15272.541823745292;16428.507144785646;16493.092879891617;16502.339906403744;16592.917035414837;15331.770023449657;15467.613309667264;15482.380704771824;15487.457938972138;15513.069215847028;650.099612037327;673.85848971716;789.0964845252212;811.3549727966251;828.1759649149075;820.5938060659952;821.289584509401;822.983540329193;823.0904850140598;823.2631794543879;862.038826708219;862.5342315149811;863.6156910174975;863.874738162966;863.952482613456;694.8297667071549;710.8862581986909;832.5545832979387;850.6852464588142;856.546030603781;622.909678096678;623.3454872383978;623.7255607532717;623.7442648514087;623.8689875126229;14242.145471271757;14277.286135693173;14285.500007499688;14289.285535723277;14300.070495417765;13678.31608419575;13798.310084495735;14007.369668364949;14165.433382664682;14413.495527656587;12989.740205195843;13022.804657930139;13232.801507977389;13365.465381384733;13870.653233669138;4230.682698797603;4296.5059018213;4314.50383205929;4347.891302717426;4393.9121217575785;61928.639633649334;62386.37613623851;63144.68427657924;74619.25380746178;75671;11433.485493152662;11486.19596628228;11620.418979051014;11647;11830.585929492427;20919.8954005229;20923.37229883106;20953.476163096046;20953.68569471459;20966.26618068391;8227.588620568948;8249.876251856227;8445.95777021111;8545.914540854636;8599.527026013504;4142.875713728593;4360.498542667634;4418.867433976986;4429.092036132585;4623.237165867594;3651.908702282411;3758.0980564664283;3781.810909454516;3784.6404591563755;3797.9430308545393;630.2090875950653;630.7445484578753;637.8086574027773;662.2483481248818;662.3508961218033;571.5827445964386;585.7627660797384;622.5237693164732;636.2841802971657;652.55626174202;8648.567571621394;9021.639134434681;9402.576884040234;9408.482533460725;9455.432674039579;648.419664400359;657.8848701477223;671.1040760584576;680.8093733754557;691.7163962775238;4576.816927322936;4732.029933863619;4733.313669517969;4745.738984355894;4785.688930219594;71839;77821;113720;119876;128106.35946820393;62626.686866565375;62691;62782.372176278564;96814.51592741991;104896.47551762345;56844;57026;57635.42364576385;83297.58351208206;88301.1169888293;8903.866442003246;9283.257339412965;9592.472414017297;9599.760005999906;9667.854982175133;51014.74492627662;51280.23079653733;51329.48670513247;51507.227391589906;53603.46396535985;63664.68167659132;65062.67468662626;72668.27331726615;75830;77708.61145694235;13215.867841321464;13292.589763177875;13371.465141394625;13557.051006429456;13637.454501819817;14429.855701442852;14567;15246.313915874034;15455.690886181988;15675.686486270439;12619.30593817349;12756.48974041028;13227.074104812571;13388.330583470983;13679.221751060115;13531.526396576073;13668.65828354299;13866.791998120238;14049.297535123407;14122.293885305899;11512.136589755635;11818.113641476752;12143.878561214275;13136.60590182296;13423.932880335537;10881.673549793519;10992.395418252074;10999.890001099886;11103.5558577656;11108.666739997812;9828.4102953823;10068.597256109673;10785.191110666574;10830;10970.725731856768 22:05:51 INFO - PROCESS | 14310 | __end_tp_report 22:05:51 INFO - PROCESS | 14310 | __start_cc_report 22:05:51 INFO - PROCESS | 14310 | _x_x_mozilla_cycle_collect,1031 22:05:51 INFO - PROCESS | 14310 | __end_cc_report 22:05:51 INFO - PROCESS | 14310 | __startTimestamp1475816751166__endTimestamp 22:05:51 INFO - PROCESS | 14310 | 22:05:51 INFO - PROCESS | 14310 | ------- Summary: start ------- 22:05:51 INFO - PROCESS | 14310 | Number of tests: 6 22:05:51 INFO - PROCESS | 14310 | 22:05:51 INFO - PROCESS | 14310 | [#0] dojo.html Cycles:165 Average:5203.00 Median:5371.92 stddev:574.69 (10.7%) stddev-sans-first:549.64 22:05:51 INFO - PROCESS | 14310 | Values: 2991.7 3025.6 3028.1 3058.6 3075.8 5176.7 5177.8 5231.6 5247.9 5267.1 5277.7 5285.8 5306.8 5326.3 5371.5 4834.5 4845.8 4864.7 4892.3 4903.2 4840.2 4860.8 4864.0 4881.9 4925.3 4486.3 4867.4 4916.9 4928.4 4984.8 4718.5 4869.7 4872.4 4912.0 4932.8 4673.8 4709.7 4744.8 4782.1 4787.4 5053.6 5170.0 5180.9 5181.9 5220.5 5572.7 5614.8 5615.9 5621.8 5633.1 5498.1 5498.5 5553.9 5554.4 5568.8 5187.1 5206.5 5210.1 5217.4 5218.7 5700.2 5704.9 5715.3 5722.0 5787.9 5343.9 5371.9 5441.4 5472.5 5483.5 5577.5 5594.4 5595.4 5602.3 5658.1 5554.9 5555.8 5566.8 5567.9 5573.7 5346.4 5357.2 5404.1 5504.6 5650.2 4263.3 4290.5 4293.1 4321.7 4323.5 3794.2 3863.7 3888.3 3909.9 3938.5 5240.7 5243.8 5247.0 5252.2 5309.9 5411.8 5536.7 5577.9 5579.5 5594.2 5158.9 5199.8 5232.0 5277.0 5327.3 4806.9 4810.3 4815.0 4818.6 4871.2 5677.2 5787.2 5791.4 5794.7 5798.0 5492.3 5638.0 5658.5 5663.9 5727.9 5859.9 5891.2 5894.9 5899.6 5900.1 5568.5 5576.2 5581.7 5586.5 5591.4 5427.1 5499.9 5517.1 5524.5 5579.1 5450.6 5451.1 5459.1 5465.1 5497.7 5444.8 5449.8 5452.3 5462.2 5470.3 5238.0 5288.4 5371.3 5434.9 5485.9 5498.0 5570.2 5572.1 5605.9 5634.0 5233.1 5400.0 5412.4 5420.3 5423.8 22:05:51 INFO - PROCESS | 14310 | 22:05:51 INFO - PROCESS | 14310 | [#1] ext.html Cycles:180 Average:59488.55 Median:20532.23 stddev:117033.43 (570.0%) stddev-sans-first:117278.14 22:05:51 INFO - PROCESS | 14310 | Values: 572.3 599.3 604.2 613.5 630.2 31827.2 43445.3 43889.1 43908.0 44049.1 44798.8 45252.3 45264.0 45309.3 45328.3 8087.4 8326.2 8954.4 9113.3 9125.5 10614.2 10860.9 10861.6 11190.8 11195.6 10997.4 11077.3 11077.8 11102.2 11119.6 8280.5 8506.5 10687.4 10869.0 10948.6 10678.7 10795.0 10803.3 10803.5 10806.9 42576.1 42626.0 42898.8 42900.0 42939.4 3490.8 3497.4 3560.8 3731.8 4050.4 31174.4 31248.2 31498.5 32349.4 33594.8 4287.0 4362.4 4526.5 4562.4 4565.4 336709.0 338701.0 341525.0 341863.0 342532.0 58999.7 59242.0 59565.7 59670.0 59697.4 36447.5 37332.6 37376.3 60683.7 61007.4 16929.8 17300.0 17323.9 17329.1 17330.4 12174.4 12421.6 13134.0 13508.9 13714.3 19181.5 19212.3 19229.6 19246.3 19335.8 6974.2 6991.2 7136.2 7163.9 7215.7 984.4 1022.3 1051.4 1117.8 1142.0 30807.2 32176.5 32257.7 32444.7 32686.7 1106.0 1108.2 1117.2 1119.9 1128.1 16380.9 17099.9 17203.9 17233.0 17369.0 550078.0 554174.0 554602.0 555758.0 559551.0 58866.1 59322.0 59417.7 59439.7 59514.4 1191.2 1249.4 1291.7 1341.1 1350.3 29046.7 32974.0 33209.8 33356.0 33515.9 50651.0 50875.5 51251.7 51322.0 51365.7 399081.0 401187.0 401475.0 402248.0 403997.0 28108.6 28393.4 28515.6 28850.0 30595.8 48109.5 48256.0 48407.5 48449.8 48596.5 40232.2 41008.2 41358.2 41626.8 42999.4 40318.2 40662.2 40910.6 41331.0 41914.8 40392.6 41047.6 41378.6 41442.4 41632.2 34830.3 36683.8 37267.7 37493.0 37608.0 27069.5 27616.2 27781.2 28032.9 28137.7 22:05:51 INFO - PROCESS | 14310 | 22:05:51 INFO - PROCESS | 14310 | [#2] jquery.html Cycles:180 Average:28379.44 Median:13525.45 stddev:69653.25 (515.0%) stddev-sans-first:69816.90 22:05:51 INFO - PROCESS | 14310 | Values: 372.9 383.1 384.5 393.7 409.5 13843.9 14368.1 16893.7 19724.9 19899.5 18320.3 18361.2 18751.4 18802.2 18945.6 5625.1 5855.4 5858.5 5858.7 5860.1 4210.6 4407.7 4504.4 5765.3 5839.4 4447.1 4460.0 4462.0 6145.0 6544.1 6356.9 6541.7 6548.2 6594.5 6609.9 5860.3 5866.2 5867.0 5871.3 5871.3 23765.3 24405.3 24585.1 24952.6 25136.9 2284.5 2390.1 2426.1 2453.6 2465.8 15055.0 15859.0 15986.8 15991.9 16404.5 1964.0 2095.8 2105.8 2209.0 2232.2 93415.5 97136.5 97192.5 98818.5 100914.5 17356.8 17361.5 17514.3 17923.9 18285.6 31940.0 32095.2 32203.3 32229.2 32235.2 9634.9 10047.4 10126.5 10171.3 10220.5 8398.9 8411.2 8694.4 8732.7 8789.2 8016.4 8734.9 8868.3 8922.5 8966.6 2849.9 3198.6 3431.0 3446.4 3489.0 890.6 946.1 993.0 1022.2 1091.5 19297.4 19332.5 19395.4 19519.7 19643.9 991.9 1015.2 1018.2 1030.7 1076.1 10300.7 10973.6 10978.9 10979.5 11009.0 343955.0 345396.0 454359.0 458337.0 460876.0 98264.0 98732.5 101610.5 102759.0 104489.0 1013.9 1044.2 1059.0 1064.7 1082.7 16738.5 17086.5 17528.9 17809.5 18171.6 28510.0 29876.9 33883.0 37148.4 42607.6 57683.4 58104.7 58134.7 59553.7 61217.0 8475.4 8587.3 8690.0 8810.8 8846.5 12597.9 12657.4 13033.4 13393.6 13598.7 11539.7 11554.1 11615.6 11673.9 11718.8 11276.4 11277.0 11341.1 11401.3 11787.4 11378.2 11503.8 11843.0 12417.8 12429.1 7369.4 7868.8 8688.2 8854.4 9007.4 10924.2 11457.3 11504.3 11657.8 11687.9 22:05:51 INFO - PROCESS | 14310 | 22:05:51 INFO - PROCESS | 14310 | [#3] mootools.html Cycles:180 Average:5874.24 Median:4828.93 stddev:3397.41 (70.4%) stddev-sans-first:3390.97 22:05:51 INFO - PROCESS | 14310 | Values: 1490.6 1514.5 1631.5 1751.0 1773.6 7885.4 8140.8 8561.4 9227.4 9234.8 8488.8 8880.4 8882.5 9118.2 9127.0 2365.5 2391.2 2395.6 2396.1 2398.2 2022.8 2108.3 2320.2 2358.3 2386.6 2264.2 2355.1 2361.9 2374.5 2376.2 2340.0 2347.5 2356.1 2358.4 2361.5 2328.8 2331.6 2337.0 2341.9 2353.9 8897.8 9008.8 9047.2 9061.7 9081.6 5304.7 5458.9 5461.3 5468.5 5472.2 3378.4 3494.6 3536.5 3551.9 3557.8 1151.8 1179.0 1206.9 1218.8 1222.3 12794.4 12823.9 12832.8 12856.6 12864.5 4618.4 4663.6 4761.6 4789.3 4894.0 10748.7 10758.2 10767.4 10768.9 10769.9 5412.7 5424.8 5427.6 5428.6 5429.8 4734.0 4910.2 4982.9 4983.7 4991.0 3729.7 3847.8 3894.1 3898.6 3918.2 1010.9 1015.2 1138.7 1166.2 1184.1 828.6 926.6 940.3 944.9 971.0 5756.7 5842.9 5844.8 5867.4 6035.7 940.8 959.2 966.2 966.7 975.7 3959.4 4095.7 4100.8 4127.9 4201.8 10810.2 11292.5 11299.3 11304.9 11335.8 11222.5 11223.6 11229.1 11232.7 11235.9 8266.7 8285.9 8328.9 8394.4 8394.9 5662.7 5680.0 5685.4 5848.3 5870.1 10083.6 10142.2 10287.3 10375.6 10461.9 10113.5 10376.7 10784.0 10786.6 10818.1 7642.5 7722.0 7788.3 7789.0 7792.5 8597.5 8655.1 8679.6 8683.0 8683.6 7452.4 7636.0 7716.2 7879.9 7887.2 7464.6 7578.4 7583.6 7637.4 7653.6 6688.8 6732.9 6735.3 6737.6 6874.6 4678.2 4868.6 4961.5 5000.9 5162.6 5139.8 5167.7 5212.5 5368.1 5385.4 22:05:51 INFO - PROCESS | 14310 | 22:05:51 INFO - PROCESS | 14310 | [#4] prototype.html Cycles:180 Average:4626.91 Median:5244.71 stddev:1347.58 (25.7%) stddev-sans-first:1312.24 22:05:51 INFO - PROCESS | 14310 | Values: 332.1 333.6 340.1 341.8 343.5 5048.2 5220.7 5246.6 5297.6 5302.8 5075.9 5178.6 5202.2 5219.4 5226.2 4155.2 4161.0 4177.3 4180.8 4201.8 4009.3 4127.0 4191.4 4203.8 4215.3 4084.5 4089.3 4095.8 4107.1 4107.8 4050.4 4060.9 4065.5 4093.5 4105.2 3614.3 3624.4 3624.7 3625.2 3650.5 5032.2 5067.4 5100.0 5100.1 5126.7 4653.2 4664.5 4682.2 4682.5 4721.7 5373.5 5386.6 5426.1 5457.8 5495.5 3826.8 3960.8 3962.9 3964.9 3972.6 5543.7 5545.7 5597.9 5645.0 5650.8 4018.4 4053.3 4059.6 4100.1 4107.3 4049.9 4093.6 4095.4 4146.3 4159.3 4618.2 4621.7 4634.8 4657.4 4665.3 5467.5 5481.4 5515.6 5531.9 5547.3 1339.5 1370.0 1397.8 1410.8 1417.0 953.6 961.6 972.9 977.2 988.6 5171.3 5208.9 5213.3 5228.1 5232.9 5476.5 5491.5 5537.2 5542.9 5547.3 5002.4 5197.8 5223.1 5242.8 5269.2 2973.3 2992.9 2997.9 3007.0 3010.8 5842.4 5878.6 5886.2 5887.5 5905.3 5604.3 5746.1 5772.8 5790.6 5821.2 5802.5 5822.3 5823.9 5842.2 5890.2 5414.9 5551.4 5612.9 5694.3 5696.3 5459.9 5560.1 5580.7 5582.6 5586.9 5709.6 5809.4 5811.5 5822.7 5825.2 3961.9 4042.7 4057.4 4079.8 4086.2 5318.7 5572.3 5612.2 5617.6 5640.2 5314.2 5407.3 5497.4 5530.4 5539.8 5486.9 5501.3 5502.8 5510.6 5511.4 5266.1 5471.9 5485.5 5487.4 5509.6 5518.0 5524.9 5529.8 5532.3 5535.4 5421.3 5430.8 5438.5 5443.1 5470.2 22:05:51 INFO - PROCESS | 14310 | 22:05:51 INFO - PROCESS | 14310 | [#5] yui.html Cycles:180 Average:19030.18 Median:4739.53 stddev:26308.08 (555.1%) stddev-sans-first:26345.70 22:05:51 INFO - PROCESS | 14310 | Values: 654.9 720.6 730.6 743.8 835.3 15272.5 16428.5 16493.1 16502.3 16592.9 15331.8 15467.6 15482.4 15487.5 15513.1 650.1 673.9 789.1 811.4 828.2 820.6 821.3 823.0 823.1 823.3 862.0 862.5 863.6 863.9 864.0 694.8 710.9 832.6 850.7 856.5 622.9 623.3 623.7 623.7 623.9 14242.1 14277.3 14285.5 14289.3 14300.1 13678.3 13798.3 14007.4 14165.4 14413.5 12989.7 13022.8 13232.8 13365.5 13870.7 4230.7 4296.5 4314.5 4347.9 4393.9 61928.6 62386.4 63144.7 74619.3 75671.0 11433.5 11486.2 11620.4 11647.0 11830.6 20919.9 20923.4 20953.5 20953.7 20966.3 8227.6 8249.9 8446.0 8545.9 8599.5 4142.9 4360.5 4418.9 4429.1 4623.2 3651.9 3758.1 3781.8 3784.6 3797.9 630.2 630.7 637.8 662.2 662.4 571.6 585.8 622.5 636.3 652.6 8648.6 9021.6 9402.6 9408.5 9455.4 648.4 657.9 671.1 680.8 691.7 4576.8 4732.0 4733.3 4745.7 4785.7 71839.0 77821.0 113720.0 119876.0 128106.4 62626.7 62691.0 62782.4 96814.5 104896.5 56844.0 57026.0 57635.4 83297.6 88301.1 8903.9 9283.3 9592.5 9599.8 9667.9 51014.7 51280.2 51329.5 51507.2 53603.5 63664.7 65062.7 72668.3 75830.0 77708.6 13215.9 13292.6 13371.5 13557.1 13637.5 14429.9 14567.0 15246.3 15455.7 15675.7 12619.3 12756.5 13227.1 13388.3 13679.2 13531.5 13668.7 13866.8 14049.3 14122.3 11512.1 11818.1 12143.9 13136.6 13423.9 10881.7 10992.4 10999.9 11103.6 11108.7 9828.4 10068.6 10785.2 10830.0 10970.7 22:05:51 INFO - PROCESS | 14310 | -------- Summary: end -------- 22:05:51 INFO - PROCESS | 14310 | 22:05:52 INFO - TEST-INFO | 14310: exit 0 22:05:52 INFO - TEST-OK | dromaeo_css | took 1117468ms 22:05:52 INFO - TEST-START | kraken 22:05:52 INFO - operating with platform_type : linux_ 22:05:52 INFO - Initialising browser for kraken test... 22:05:52 INFO - TEST-INFO | started process 14617 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMLeTKk/profile http://localhost:48857/getInfo.html) 22:05:56 INFO - PROCESS | 14617 | __metrics Screen width/height:1600/1200 22:05:56 INFO - PROCESS | 14617 | colorDepth:24 22:05:56 INFO - PROCESS | 14617 | Browser inner width/height: 1024/697 22:05:56 INFO - PROCESS | 14617 | __metrics 22:05:57 INFO - PROCESS | 14617 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 22:05:57 INFO - PROCESS | 14617 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:05:57 INFO - PROCESS | 14617 | console.error: PushService: 22:05:57 INFO - PROCESS | 14617 | stateChangeProcessEnqueue: Error transitioning state 22:05:57 INFO - PROCESS | 14617 | UnknownError 22:05:58 INFO - TEST-INFO | 14617: exit 0 22:05:58 INFO - Browser initialized. 22:05:58 INFO - Running cycle 1/1 for kraken test... 22:05:58 INFO - TEST-INFO | started process 14699 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMLeTKk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:06:10 INFO - PROCESS | 14699 | RSS: Main: 173613056 22:06:10 INFO - PROCESS | 14699 | 22:06:12 INFO - PROCESS | 14699 | Cycle 1(1): loaded http://localhost:48857/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48857/tests/kraken/driver.html?testName=audio-beat-detection) 22:06:13 INFO - PROCESS | 14699 | RSS: Main: 232497152 22:06:13 INFO - PROCESS | 14699 | 22:06:16 INFO - PROCESS | 14699 | Cycle 1(1): loaded http://localhost:48857/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48857/tests/kraken/driver.html?testName=audio-dft) 22:06:16 INFO - PROCESS | 14699 | RSS: Main: 217563136 22:06:16 INFO - PROCESS | 14699 | 22:06:20 INFO - PROCESS | 14699 | Cycle 1(1): loaded http://localhost:48857/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48857/tests/kraken/driver.html?testName=audio-fft) 22:06:20 INFO - PROCESS | 14699 | RSS: Main: 298749952 22:06:20 INFO - PROCESS | 14699 | 22:06:22 INFO - PROCESS | 14699 | Cycle 1(1): loaded http://localhost:48857/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48857/tests/kraken/driver.html?testName=audio-oscillator) 22:06:23 INFO - PROCESS | 14699 | RSS: Main: 210456576 22:06:23 INFO - PROCESS | 14699 | 22:06:25 INFO - PROCESS | 14699 | Cycle 1(1): loaded http://localhost:48857/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48857/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:06:26 INFO - PROCESS | 14699 | RSS: Main: 212946944 22:06:26 INFO - PROCESS | 14699 | 22:06:29 INFO - PROCESS | 14699 | Cycle 1(1): loaded http://localhost:48857/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48857/tests/kraken/driver.html?testName=imaging-darkroom) 22:06:29 INFO - PROCESS | 14699 | RSS: Main: 249393152 22:06:29 INFO - PROCESS | 14699 | 22:06:33 INFO - PROCESS | 14699 | Cycle 1(1): loaded http://localhost:48857/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48857/tests/kraken/driver.html?testName=imaging-desaturate) 22:06:33 INFO - PROCESS | 14699 | RSS: Main: 248872960 22:06:33 INFO - PROCESS | 14699 | 22:06:36 INFO - PROCESS | 14699 | Cycle 1(1): loaded http://localhost:48857/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48857/tests/kraken/driver.html?testName=json-parse-financial) 22:06:37 INFO - PROCESS | 14699 | RSS: Main: 248176640 22:06:37 INFO - PROCESS | 14699 | 22:06:38 INFO - PROCESS | 14699 | Cycle 1(1): loaded http://localhost:48857/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48857/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:06:39 INFO - PROCESS | 14699 | RSS: Main: 210358272 22:06:39 INFO - PROCESS | 14699 | 22:06:40 INFO - PROCESS | 14699 | Cycle 1(1): loaded http://localhost:48857/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48857/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:06:41 INFO - PROCESS | 14699 | RSS: Main: 217505792 22:06:41 INFO - PROCESS | 14699 | 22:06:43 INFO - PROCESS | 14699 | Cycle 1(1): loaded http://localhost:48857/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48857/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:06:44 INFO - PROCESS | 14699 | RSS: Main: 227495936 22:06:44 INFO - PROCESS | 14699 | 22:06:46 INFO - PROCESS | 14699 | Cycle 1(1): loaded http://localhost:48857/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48857/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:06:47 INFO - PROCESS | 14699 | RSS: Main: 236023808 22:06:47 INFO - PROCESS | 14699 | 22:06:50 INFO - PROCESS | 14699 | Cycle 1(1): loaded http://localhost:48857/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48857/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:06:50 INFO - PROCESS | 14699 | RSS: Main: 232747008 22:06:50 INFO - PROCESS | 14699 | 22:06:52 INFO - PROCESS | 14699 | Cycle 1(1): loaded http://localhost:48857/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48857/tests/kraken/driver.html?testName=ai-astar) 22:06:52 INFO - PROCESS | 14699 | RSS: Main: 283930624 22:06:52 INFO - PROCESS | 14699 | 22:06:52 INFO - PROCESS | 14699 | __start_tp_report 22:06:52 INFO - PROCESS | 14699 | _x_x_mozilla_page_load 22:06:52 INFO - PROCESS | 14699 | _x_x_mozilla_page_load_details 22:06:52 INFO - PROCESS | 14699 | |i|pagename|runs| 22:06:52 INFO - PROCESS | 14699 | |0;ai-astar;110;113;111;110;111;110;111;110;111;112 22:06:52 INFO - PROCESS | 14699 | |1;audio-beat-detection;151;122;123;166;125;128;123;122;165;122 22:06:52 INFO - PROCESS | 14699 | |2;audio-dft;160;163;160;160;161;161;161;161;161;162 22:06:52 INFO - PROCESS | 14699 | |3;audio-fft;77;74;76;108;76;76;76;75;101;75 22:06:52 INFO - PROCESS | 14699 | |4;audio-oscillator;82;82;126;83;83;84;110;82;82;110 22:06:52 INFO - PROCESS | 14699 | |5;imaging-gaussian-blur;117;117;116;117;116;117;117;117;116;117 22:06:52 INFO - PROCESS | 14699 | |6;imaging-darkroom;146;148;145;146;146;146;145;145;146;145 22:06:52 INFO - PROCESS | 14699 | |7;imaging-desaturate;95;94;95;95;95;95;95;95;95;95 22:06:52 INFO - PROCESS | 14699 | |8;json-parse-financial;51;50;50;52;52;52;53;51;52;52 22:06:52 INFO - PROCESS | 14699 | |9;json-stringify-tinderbox;62;62;62;61;63;61;62;62;62;62 22:06:52 INFO - PROCESS | 14699 | |10;stanford-crypto-aes;88;78;80;78;88;80;79;78;79;79 22:06:52 INFO - PROCESS | 14699 | |11;stanford-crypto-ccm;133;129;129;134;139;145;141;128;171;137 22:06:52 INFO - PROCESS | 14699 | |12;stanford-crypto-pbkdf2;171;173;178;170;171;169;169;172;173;170 22:06:52 INFO - PROCESS | 14699 | |13;stanford-crypto-sha256-iterative;69;69;67;67;67;65;67;66;65;65 22:06:52 INFO - PROCESS | 14699 | __end_tp_report 22:06:52 INFO - PROCESS | 14699 | __start_cc_report 22:06:52 INFO - PROCESS | 14699 | _x_x_mozilla_cycle_collect,1656 22:06:52 INFO - PROCESS | 14699 | __end_cc_report 22:06:52 INFO - PROCESS | 14699 | __startTimestamp1475816812914__endTimestamp 22:06:52 INFO - PROCESS | 14699 | 22:06:52 INFO - PROCESS | 14699 | ------- Summary: start ------- 22:06:52 INFO - PROCESS | 14699 | Number of tests: 14 22:06:52 INFO - PROCESS | 14699 | 22:06:52 INFO - PROCESS | 14699 | [#0] ai-astar Cycles:10 Average:110.90 Median:111.00 stddev:0.99 (0.9%) stddev-sans-first:1.00 22:06:52 INFO - PROCESS | 14699 | Values: 110.0 113.0 111.0 110.0 111.0 110.0 111.0 110.0 111.0 112.0 22:06:52 INFO - PROCESS | 14699 | 22:06:52 INFO - PROCESS | 14699 | [#1] audio-beat-detection Cycles:10 Average:134.70 Median:126.50 stddev:18.44 (14.6%) stddev-sans-first:18.59 22:06:52 INFO - PROCESS | 14699 | Values: 151.0 122.0 123.0 166.0 125.0 128.0 123.0 122.0 165.0 122.0 22:06:52 INFO - PROCESS | 14699 | 22:06:52 INFO - PROCESS | 14699 | [#2] audio-dft Cycles:10 Average:161.00 Median:161.00 stddev:0.94 (0.6%) stddev-sans-first:0.93 22:06:52 INFO - PROCESS | 14699 | Values: 160.0 163.0 160.0 160.0 161.0 161.0 161.0 161.0 161.0 162.0 22:06:52 INFO - PROCESS | 14699 | 22:06:52 INFO - PROCESS | 14699 | [#3] audio-fft Cycles:10 Average:81.40 Median:76.00 stddev:12.31 (16.2%) stddev-sans-first:12.96 22:06:52 INFO - PROCESS | 14699 | Values: 77.0 74.0 76.0 108.0 76.0 76.0 76.0 75.0 101.0 75.0 22:06:52 INFO - PROCESS | 14699 | 22:06:52 INFO - PROCESS | 14699 | [#4] audio-oscillator Cycles:10 Average:92.40 Median:82.00 stddev:16.43 (20.0%) stddev-sans-first:16.99 22:06:52 INFO - PROCESS | 14699 | Values: 82.0 82.0 126.0 83.0 83.0 84.0 110.0 82.0 82.0 110.0 22:06:52 INFO - PROCESS | 14699 | 22:06:52 INFO - PROCESS | 14699 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 22:06:52 INFO - PROCESS | 14699 | Values: 117.0 117.0 116.0 117.0 116.0 117.0 117.0 117.0 116.0 117.0 22:06:52 INFO - PROCESS | 14699 | 22:06:52 INFO - PROCESS | 14699 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.92 (0.6%) stddev-sans-first:0.97 22:06:52 INFO - PROCESS | 14699 | Values: 146.0 148.0 145.0 146.0 146.0 146.0 145.0 145.0 146.0 145.0 22:06:52 INFO - PROCESS | 14699 | 22:06:52 INFO - PROCESS | 14699 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 22:06:52 INFO - PROCESS | 14699 | Values: 95.0 94.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 22:06:52 INFO - PROCESS | 14699 | 22:06:52 INFO - PROCESS | 14699 | [#8] json-parse-financial Cycles:10 Average:51.50 Median:52.00 stddev:0.97 (1.9%) stddev-sans-first:1.01 22:06:52 INFO - PROCESS | 14699 | Values: 51.0 50.0 50.0 52.0 52.0 52.0 53.0 51.0 52.0 52.0 22:06:52 INFO - PROCESS | 14699 | 22:06:52 INFO - PROCESS | 14699 | [#9] json-stringify-tinderbox Cycles:10 Average:61.90 Median:62.00 stddev:0.57 (0.9%) stddev-sans-first:0.60 22:06:52 INFO - PROCESS | 14699 | Values: 62.0 62.0 62.0 61.0 63.0 61.0 62.0 62.0 62.0 62.0 22:06:52 INFO - PROCESS | 14699 | 22:06:52 INFO - PROCESS | 14699 | [#10] stanford-crypto-aes Cycles:10 Average:80.70 Median:79.50 stddev:3.92 (4.9%) stddev-sans-first:3.14 22:06:52 INFO - PROCESS | 14699 | Values: 88.0 78.0 80.0 78.0 88.0 80.0 79.0 78.0 79.0 79.0 22:06:52 INFO - PROCESS | 14699 | 22:06:52 INFO - PROCESS | 14699 | [#11] stanford-crypto-ccm Cycles:10 Average:138.60 Median:138.00 stddev:12.69 (9.2%) stddev-sans-first:13.29 22:06:52 INFO - PROCESS | 14699 | Values: 133.0 129.0 129.0 134.0 139.0 145.0 141.0 128.0 171.0 137.0 22:06:52 INFO - PROCESS | 14699 | 22:06:52 INFO - PROCESS | 14699 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.60 Median:171.50 stddev:2.67 (1.6%) stddev-sans-first:2.83 22:06:52 INFO - PROCESS | 14699 | Values: 171.0 173.0 178.0 170.0 171.0 169.0 169.0 172.0 173.0 170.0 22:06:52 INFO - PROCESS | 14699 | 22:06:52 INFO - PROCESS | 14699 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.70 Median:67.00 stddev:1.49 (2.2%) stddev-sans-first:1.33 22:06:52 INFO - PROCESS | 14699 | Values: 69.0 69.0 67.0 67.0 67.0 65.0 67.0 66.0 65.0 65.0 22:06:52 INFO - PROCESS | 14699 | -------- Summary: end -------- 22:06:52 INFO - PROCESS | 14699 | 22:06:54 INFO - TEST-INFO | 14699: exit 0 22:06:54 INFO - TEST-OK | kraken | took 61979ms 22:06:54 INFO - SUITE-END | took 1179s 22:06:54 INFO - Completed test suite (00:19:39) 22:06:54 INFO - javascript benchmark 22:06:54 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2991.65595956465, 3025.561293612425, 3028.1218446650464, 3058.587090742749, 3075.800072995255, 5176.663516871406, 5177.7928882844735, 5231.607629427798, 5247.86880327992, 5267.078261304271, 5277.736113194344, 5285.762140703668, 5306.840794776153, 5326.254324394578, 5371.462853714626, 4834.516548345173, 4845.757712114389, 4864.683795553296, 4892.315075889378, 4903.190973489388, 4840.177169881129, 4860.829870954517, 4864.0, 4881.926771098437, 4925.310456536088, 4486.304622783474, 4867.440244371907, 4916.926246106311, 4928.383952005999, 4984.77568509418, 4718.504557021532, 4869.707817530924, 4872.366592343008, 4912.042151780404, 4932.8273510427325, 4673.766311684436, 4709.6938698984795, 4744.810207591692, 4782.13921494131, 4787.425508938914, 5053.570446512051, 5169.999999999963, 5180.922286165711, 5181.922271165936, 5220.504052115043, 5572.693501857396, 5614.775408983635, 5615.887682246333, 5621.7751289948355, 5633.070543360341, 5498.147787093007, 5498.505134537871, 5553.944460555384, 5554.416786237427, 5568.777248910039, 5187.066328060948, 5206.479352064801, 5210.114280572312, 5217.373915130132, 5218.66078704883, 5700.173474846124, 5704.942950570441, 5715.257016587817, 5722.0, 5787.855303617359, 5343.946560534345, 5371.919421208685, 5441.428649991693, 5472.50747432733, 5483.533899618497, 5577.525910297589, 5594.356648985337, 5595.440455954372, 5602.299712535933, 5658.094704847204, 5554.91667624986, 5555.777768889199, 5566.805161819398, 5567.860803479945, 5573.721313934287, 5346.358436987586, 5357.223202635596, 5404.108322126805, 5504.559635229252, 5650.180723795027, 4263.253930562139, 4290.528041915387, 4293.0984493256765, 4321.7406955582765, 4323.546027667113, 3794.165283637595, 3863.6715879150024, 3888.300105980894, 3909.9218015639526, 3938.5273767148124, 5240.711760853113, 5243.764030618631, 5246.97376513115, 5252.185911183773, 5309.867253318698, 5411.756470958816, 5536.695481748462, 5577.944220557823, 5579.497845193952, 5594.216809646653, 5158.871028224249, 5199.818006369759, 5231.973840130775, 5277.0, 5327.334083239595, 4806.8798280043275, 4810.254410566367, 4815.036992601494, 4818.566329030404, 4871.2206047032305, 5677.205191273142, 5787.218725472091, 5791.391903850035, 5794.710264486759, 5798.043322851682, 5492.286002819608, 5637.9718101409235, 5658.5473162147755, 5663.8867222656145, 5727.914081288867, 5859.9121013183985, 5891.1752354671235, 5894.882102357843, 5899.646021238739, 5900.085486749561, 5568.526675232489, 5576.191452239322, 5581.748821303132, 5586.497215250647, 5591.384947655673, 5427.1316589345515, 5499.945000550103, 5517.144842549411, 5524.475174858382, 5579.13523403873, 5450.5912056595125, 5451.127819548853, 5459.12653975362, 5465.098258787256, 5497.725113744217, 5444.782208711607, 5449.754761035683, 5452.26394436746, 5462.235287059894, 5470.261514695465, 5237.973810131078, 5288.365396152486, 5371.328583927009, 5434.864128396664, 5485.917711234414, 5498.0, 5570.164475328733, 5572.080606699849, 5605.915911261416, 5633.971830140987, 5233.058049551118, 5399.973000135132, 5412.43169467216, 5420.349558053059, 5423.7830486780085], "value": 5165.217293845116, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [572.3446653581649, 599.2928344553425, 604.2235727090689, 613.5337143770732, 630.1618846933579, 31827.204319892015, 43445.34831977519, 43889.12221755563, 43907.99999999996, 44049.119017619625, 44798.77600611992, 45252.32121518171, 45264.0, 45309.32036019462, 45328.3200751989, 8087.353011759045, 8326.209010144057, 8954.37319387643, 9113.270938324918, 9125.49809760463, 10614.203934704889, 10860.891391086067, 10861.619843305485, 11190.776184476306, 11195.552177912914, 10997.395143267117, 11077.279976801523, 11077.778444431107, 11102.222844400896, 11119.555217791278, 8280.50316980983, 8506.532140732257, 10687.412192329419, 10869.0, 10948.562057517689, 10678.733031674192, 10795.0, 10803.297785643908, 10803.459827008697, 10806.945965270203, 42576.148477030285, 42626.0, 42898.78550607227, 42900.0, 42939.35590966138, 3490.8080055596934, 3497.3704733148024, 3560.8219589020446, 3731.8320675569394, 4050.392441133824, 31174.376512469622, 31248.21879453009, 31498.527522087188, 32349.35301293961, 33594.83202583996, 4286.978565107186, 4362.432883725127, 4526.54734526548, 4562.384078149441, 4565.360849481075, 336709.0, 338701.0, 341525.0, 341863.0, 342532.0, 58999.70500147557, 59242.0, 59565.702171489735, 59670.0, 59697.403025969186, 36447.4532882007, 37332.62667373346, 37376.25247495035, 60683.69658151681, 61007.38992610017, 16929.83070169307, 17300.0, 17323.913380433016, 17329.133543322783, 17330.39343622967, 12174.391280435942, 12421.565245216374, 13134.0, 13508.864911350956, 13714.314284285745, 19181.520461988282, 19212.327568535035, 19229.615407691766, 19246.326378576683, 19335.806641933683, 6974.1889084225995, 6991.23096459389, 7136.215016348197, 7163.89254161188, 7215.690978886811, 984.4487087231173, 1022.3094628391501, 1051.4374809476892, 1117.782032503654, 1141.9657410277705, 30807.22981925425, 32176.517352239734, 32257.677423225938, 32444.675553244637, 32686.673133268363, 1106.0322218059198, 1108.2131686502673, 1117.2179474367974, 1119.9440027998567, 1128.0862501373913, 16380.918095409446, 17099.91450042767, 17203.91398043027, 17233.0, 17369.0, 550078.0, 554174.0, 554602.0, 555758.0, 559551.0, 58866.11700824491, 59322.0, 59417.70291148517, 59439.70280148571, 59514.404855951754, 1191.249512806926, 1249.4065318973596, 1291.7416516696885, 1341.0545565376385, 1350.2708537389897, 29046.7095329044, 32974.0, 33209.83395083009, 33356.0, 33515.927359332745, 50651.0, 50875.491245087076, 51251.743741281054, 51322.0, 51365.7431712839, 399081.0, 401187.0, 401475.0, 402248.0, 403997.0, 28108.578371324857, 28393.43213135767, 28515.572266415606, 28850.0, 30595.847020764755, 48109.5189048105, 48256.0, 48407.51592484171, 48449.75775121102, 48596.514034860615, 40232.195356093296, 41008.1798364037, 41358.1728365425, 41626.79186604169, 42999.355009675506, 40318.1936361277, 40662.1867562653, 40910.59089409068, 41331.0, 41914.79042604767, 40392.596074038884, 41047.589524104376, 41378.586214137475, 41442.37836432396, 41632.16735665209, 34830.30339393249, 36683.81658091692, 37267.68473590806, 37493.0, 37608.0, 27069.458610828067, 27616.171514854588, 27781.16656500308, 28032.86803286787, 28137.71862281351], "value": 20437.440104443005, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [372.94219395993633, 383.1322055544193, 384.46559282597184, 393.6752179451952, 409.4963195269818, 13843.893859222468, 14368.137911725304, 16893.746593801086, 19724.901375493137, 19899.502512437197, 18320.26718931241, 18361.173747181376, 18751.437456876316, 18802.24791008358, 18945.62108757824, 5625.099984002561, 5855.355910849803, 5858.472737453629, 5858.73635686393, 5860.120981852735, 4210.59999300066, 4407.713498622596, 4504.391907092549, 5765.336986246593, 5839.4160583941475, 4447.110577884436, 4459.955400446002, 4461.977690111545, 6145.0, 6544.083828264047, 6356.872862542769, 6541.738330466776, 6548.1814773153355, 6594.505412094112, 6609.933900661004, 5860.2967643883, 5866.20806191163, 5867.0, 5871.295444546639, 5871.324797648283, 23765.287041388787, 24405.26784196477, 24585.13952011689, 24952.625710614175, 25136.874315628487, 2284.48599065209, 2390.1395497620842, 2426.06596460364, 2453.6196889482158, 2465.7657522535333, 15055.0, 15859.0, 15986.840131598652, 15991.92004039984, 16404.507864764077, 1964.0, 2095.8218551423147, 2105.789421057882, 2209.0, 2232.2075663139676, 93415.53292233564, 97136.51431742866, 97192.51403743007, 98818.50590747072, 100914.49542752313, 17356.82643173552, 17361.47915562535, 17514.29942802299, 17923.910380448015, 18285.634287314446, 31940.0, 32095.197620059684, 32203.296620888897, 32229.194270143435, 32235.194120147185, 9634.9036509634, 10047.447390393452, 10126.493675316206, 10171.288009839389, 10220.488975551192, 8398.874016889751, 8411.242988130974, 8694.435141633234, 8732.65069397217, 8789.165029322205, 8016.358691304682, 8734.86897696535, 8868.33487488441, 8922.509261990654, 8966.551672416354, 2849.9145025649264, 3198.63215730194, 3431.0, 3446.379651662675, 3489.0, 890.5547226386807, 946.129560804062, 993.0317940008579, 1022.2384323678907, 1091.5360971587045, 19297.4210773677, 19332.516687082934, 19395.418137455898, 19519.707204391947, 19643.94537298818, 991.9133171334149, 1015.2284263959444, 1018.1549314069305, 1030.7423144213947, 1076.1068313299943, 10300.690979270634, 10973.561057557608, 10978.890211097947, 10979.505922233519, 11009.0, 343955.0, 345396.0, 454359.0, 458336.9995600483, 460876.0, 98264.0, 98732.50633746928, 101610.49194754126, 102759.03314228756, 104489.0, 1013.9138173255209, 1044.2481413382504, 1059.0362769879373, 1064.6646306413454, 1082.653550863716, 16738.497845064667, 17086.48740537786, 17528.91235543814, 17809.46571602854, 18171.636567268844, 28510.0, 29876.850615746782, 33882.98351049473, 37148.44277335788, 42607.57392426036, 57683.4231657678, 58104.70947645235, 58134.7093264531, 59553.70223148856, 61217.0, 8475.355597093308, 8587.270082043096, 8689.956550217461, 8810.779730506532, 8846.513441760764, 12597.874021260037, 12657.367131643197, 13033.413496392875, 13393.598192054254, 13598.728025439634, 11539.653810385365, 11554.133439991867, 11615.5934542294, 11673.883261167619, 11718.765624687629, 11276.379799111128, 11277.041451476716, 11341.149413794163, 11401.258918170292, 11787.410629468664, 11378.203525753117, 11503.827442588201, 11843.0, 12417.75164496687, 12429.12996090265, 7369.373603243785, 7868.84262314762, 8688.174623410765, 8854.424462409923, 9007.414518056305, 10924.235303528676, 11457.255278406878, 11504.309741415542, 11657.825132623188, 11687.88312116868], "value": 10026.443730115168, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1490.6347944753534, 1514.4775052606851, 1631.4779270633394, 1750.9562260943483, 1773.5920738230207, 7885.408594355417, 8140.755777326674, 8561.443506172101, 9227.354085214038, 9234.815303693922, 8488.787780305496, 8880.422772519782, 8882.511461869612, 9118.224950879166, 9127.041660625622, 2365.538719949615, 2391.210900402863, 2395.64065390192, 2396.077510158584, 2398.1606437746736, 2022.8482863785202, 2108.283183717536, 2320.153144102399, 2358.2666739946126, 2386.606209975352, 2264.184893438361, 2355.105060077177, 2361.89371478283, 2374.525094981002, 2376.1802178248563, 2340.040583360831, 2347.471818840764, 2356.0929042318658, 2358.445765245166, 2361.4804742956608, 2328.836981411302, 2331.6152834782242, 2336.97663023371, 2341.8594884306995, 2353.8587684738973, 8897.822043559092, 9008.77478063047, 9047.230985366252, 9061.728148155566, 9081.59132839024, 5304.708241046741, 5458.918116228259, 5461.262729531502, 5468.535174510172, 5472.206530053159, 3378.3581119587448, 3494.5806503219524, 3536.487209354655, 3551.94672079919, 3557.8221088945706, 1151.7869194199016, 1178.988210117905, 1206.873278305774, 1218.7684339975376, 1222.3277197541406, 12794.360281985957, 12823.935880320632, 12832.80750788739, 12856.550020749322, 12864.549740759123, 4618.3907824697535, 4663.626909847204, 4761.595264402565, 4789.257665061921, 4893.951060489349, 10748.677539673823, 10758.24692271549, 10767.407792571326, 10768.892311076946, 10769.946150269356, 5412.729363531807, 5424.837254882281, 5427.565794736412, 5428.565714742811, 5429.755660995264, 4733.95266047342, 4910.21436570147, 4982.90034199314, 4983.651144419929, 4991.0, 3729.6643302102398, 3847.769133851978, 3894.065424298148, 3898.590647981978, 3918.1771827916455, 1010.9191264698807, 1015.1574193419444, 1138.686861113184, 1166.1953252255917, 1184.08233618946, 828.5650033732338, 926.5969303353063, 940.3370623710268, 944.9227880216558, 971.0435221307007, 5756.7121643917635, 5842.8539286517325, 5844.824655260349, 5867.413258674099, 6035.7283922223605, 940.8259471997702, 959.1559427703576, 966.2270183852889, 966.7051549277397, 975.673149494913, 3959.40608908666, 4095.692823038284, 4100.815463304159, 4127.8968025798995, 4201.831926722958, 10810.189235807346, 11292.54829806815, 11299.322040677585, 11304.943475282735, 11335.82596872877, 11222.494987725571, 11223.551057957753, 11229.10167186623, 11232.719182020352, 11235.943820280847, 8266.718658607926, 8285.917140828635, 8328.916710832935, 8394.37042221848, 8394.874076888851, 5662.716864156858, 5679.971600141973, 5685.431456854281, 5848.2689663792025, 5870.090136028923, 10083.596656133966, 10142.188624910137, 10287.331323463952, 10375.584976600852, 10461.895381046092, 10113.494325283853, 10376.74058148522, 10784.0, 10786.622468213574, 10818.134549235885, 7642.5032372895585, 7722.0, 7788.260115289038, 7789.0, 7792.4545281832, 8597.484150950962, 8655.09121542229, 8679.609417576097, 8683.044865064712, 8683.609237584451, 7452.3665488431925, 7635.961820190863, 7716.228377162239, 7879.921200788148, 7887.211278872296, 7464.589447580435, 7578.355839753683, 7583.582902940391, 7637.427192960439, 7653.57905315213, 6688.799336019927, 6732.8653426930205, 6735.259121496533, 6737.629430381376, 6874.553154044971, 4678.181318269221, 4868.610511159028, 4961.479044700254, 5000.924986125284, 5162.5869930406225, 5139.781212015916, 5167.715775632376, 5212.530872221519, 5368.141097424394, 5385.353757549119], "value": 4672.6621489240215, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [332.11491375484337, 333.64633488502176, 340.0919544815343, 341.7556447140295, 343.4864877008872, 5048.217526283432, 5220.68675879447, 5246.580273578114, 5297.629165958385, 5302.814401495948, 5075.9492405075935, 5178.559822415099, 5202.1936599826995, 5219.408080535435, 5226.216067589863, 4155.168966206756, 4160.958390416103, 4177.310743727281, 4180.770057646828, 4201.76890271035, 4009.258287216874, 4126.9793651031705, 4191.350340697181, 4203.831846726127, 4215.283401821697, 4084.530279017906, 4089.26393249215, 4095.8361665533344, 4107.116969851481, 4107.788202480276, 4050.392441133839, 4060.918781624351, 4065.532463766675, 4093.488313960755, 4105.220008198433, 3614.34941710492, 3624.420092785168, 3624.746267761258, 3625.2205775758075, 3650.452432135201, 5032.169692000815, 5067.366579177603, 5099.974500127512, 5100.056489549445, 5126.6667666601925, 4653.185692503798, 4664.486906440289, 4682.157211701892, 4682.461516925563, 4721.693089949143, 5373.5163835254625, 5386.622936394454, 5426.131818908995, 5457.781688732446, 5495.505404513573, 3826.789526576037, 3960.8019599019935, 3962.920741585181, 3964.920701585952, 3972.6424621784176, 5543.722813859331, 5545.72271386429, 5597.944020559783, 5645.0, 5650.841577476607, 4018.3524754850373, 4053.2704113259306, 4059.594040595917, 4100.0774825664585, 4107.342825147962, 4049.8785036448953, 4093.570175131628, 4095.447114639545, 4146.295129827937, 4159.251334759772, 4618.1918164321105, 4621.676482646182, 4634.814607415733, 4657.371254880548, 4665.300204969281, 5467.507924286754, 5481.397046324901, 5515.641483303572, 5531.944680553223, 5547.278853748987, 1339.4709089909431, 1369.9657508562366, 1397.77635578307, 1410.75311820431, 1416.9574912752635, 953.6042542344987, 961.6441916490943, 972.9318947673595, 977.1694060048901, 988.6292640259902, 5171.3018742469285, 5208.869778255498, 5213.348331458567, 5228.08508511009, 5232.92150617741, 5476.507114359727, 5491.478309560585, 5537.197106419547, 5542.861428464321, 5547.278853748987, 5002.424721157041, 5197.792088316501, 5223.112070947948, 5242.8465737538445, 5269.209618557247, 2973.3012742005612, 2992.8653210605576, 2997.8501074946603, 3007.0, 3010.7591392688532, 5842.415758424124, 5878.647281163144, 5886.205362276038, 5887.499562537147, 5905.291365036223, 5604.299462567179, 5746.138079288056, 5772.797952071657, 5790.594658373873, 5821.243238379068, 5802.549362659335, 5822.33043200029, 5823.941760582509, 5842.152887831326, 5890.234269545017, 5414.918776218438, 5551.444855514416, 5612.915806262991, 5694.345150307602, 5696.316442026983, 5459.880724451557, 5560.054790685513, 5580.720963951868, 5582.5533957282505, 5586.916196256978, 5709.628874123168, 5809.419058094157, 5811.476967072984, 5822.70886455684, 5825.155352473952, 3961.9405708913814, 4042.7372220805555, 4057.39139129133, 4079.7760671797746, 4086.1623367210245, 5318.7074710891275, 5572.3034620672415, 5612.165856242571, 5617.578681598979, 5640.153976903333, 5314.176302673091, 5407.323374929435, 5497.361266591978, 5530.423829208818, 5539.833804985857, 5486.862828429321, 5501.312335958005, 5502.80740174092, 5510.559155267489, 5511.4213007633625, 5266.051560922483, 5471.945280547144, 5485.533729632866, 5487.420912171273, 5509.614326997072, 5517.972410137923, 5524.91712624319, 5529.778808847601, 5532.336119665666, 5535.418781027934, 5421.295231619864, 5430.8099216527235, 5438.483344082306, 5443.074677304789, 5470.206820010996], "value": 4201.293995773439, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [654.8690261947612, 720.618072421616, 730.6091241185967, 743.8028922335582, 835.3400813357448, 15272.541823745292, 16428.507144785646, 16493.092879891617, 16502.339906403744, 16592.917035414837, 15331.770023449657, 15467.613309667264, 15482.380704771824, 15487.457938972138, 15513.069215847028, 650.099612037327, 673.85848971716, 789.0964845252212, 811.3549727966251, 828.1759649149075, 820.5938060659952, 821.289584509401, 822.983540329193, 823.0904850140598, 823.2631794543879, 862.038826708219, 862.5342315149811, 863.6156910174975, 863.874738162966, 863.952482613456, 694.8297667071549, 710.8862581986909, 832.5545832979387, 850.6852464588142, 856.546030603781, 622.909678096678, 623.3454872383978, 623.7255607532717, 623.7442648514087, 623.8689875126229, 14242.145471271757, 14277.286135693173, 14285.500007499688, 14289.285535723277, 14300.070495417765, 13678.31608419575, 13798.310084495735, 14007.369668364949, 14165.433382664682, 14413.495527656587, 12989.740205195843, 13022.804657930139, 13232.801507977389, 13365.465381384733, 13870.653233669138, 4230.682698797603, 4296.5059018213, 4314.50383205929, 4347.891302717426, 4393.9121217575785, 61928.639633649334, 62386.37613623851, 63144.68427657924, 74619.25380746178, 75671.0, 11433.485493152662, 11486.19596628228, 11620.418979051014, 11647.0, 11830.585929492427, 20919.8954005229, 20923.37229883106, 20953.476163096046, 20953.68569471459, 20966.26618068391, 8227.588620568948, 8249.876251856227, 8445.95777021111, 8545.914540854636, 8599.527026013504, 4142.875713728593, 4360.498542667634, 4418.867433976986, 4429.092036132585, 4623.237165867594, 3651.908702282411, 3758.0980564664283, 3781.810909454516, 3784.6404591563755, 3797.9430308545393, 630.2090875950653, 630.7445484578753, 637.8086574027773, 662.2483481248818, 662.3508961218033, 571.5827445964386, 585.7627660797384, 622.5237693164732, 636.2841802971657, 652.55626174202, 8648.567571621394, 9021.639134434681, 9402.576884040234, 9408.482533460725, 9455.432674039579, 648.419664400359, 657.8848701477223, 671.1040760584576, 680.8093733754557, 691.7163962775238, 4576.816927322936, 4732.029933863619, 4733.313669517969, 4745.738984355894, 4785.688930219594, 71839.0, 77821.0, 113720.0, 119876.0, 128106.35946820393, 62626.686866565375, 62691.0, 62782.372176278564, 96814.51592741991, 104896.47551762345, 56844.0, 57026.0, 57635.42364576385, 83297.58351208206, 88301.1169888293, 8903.866442003246, 9283.257339412965, 9592.472414017297, 9599.760005999906, 9667.854982175133, 51014.74492627662, 51280.23079653733, 51329.48670513247, 51507.227391589906, 53603.46396535985, 63664.68167659132, 65062.67468662626, 72668.27331726615, 75830.0, 77708.61145694235, 13215.867841321464, 13292.589763177875, 13371.465141394625, 13557.051006429456, 13637.454501819817, 14429.855701442852, 14567.0, 15246.313915874034, 15455.690886181988, 15675.686486270439, 12619.30593817349, 12756.48974041028, 13227.074104812571, 13388.330583470983, 13679.221751060115, 13531.526396576073, 13668.65828354299, 13866.791998120238, 14049.297535123407, 14122.293885305899, 11512.136589755635, 11818.113641476752, 12143.878561214275, 13136.60590182296, 13423.932880335537, 10881.673549793519, 10992.395418252074, 10999.890001099886, 11103.5558577656, 11108.666739997812, 9828.4102953823, 10068.597256109673, 10785.191110666574, 10830.0, 10970.725731856768], "value": 7341.177419764892, "unit": "score"}], "name": "dromaeo_css", "value": 7309.77152972529, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 113.0, 111.0, 110.0, 111.0, 110.0, 111.0, 110.0, 111.0, 112.0], "value": 110.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 122.0, 123.0, 166.0, 125.0, 128.0, 123.0, 122.0, 165.0, 122.0], "value": 134.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 163.0, 160.0, 160.0, 161.0, 161.0, 161.0, 161.0, 161.0, 162.0], "value": 161.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 74.0, 76.0, 108.0, 76.0, 76.0, 76.0, 75.0, 101.0, 75.0], "value": 81.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 126.0, 83.0, 83.0, 84.0, 110.0, 82.0, 82.0, 110.0], "value": 92.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 116.0, 117.0, 117.0, 117.0, 116.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 148.0, 145.0, 146.0, 146.0, 146.0, 145.0, 145.0, 146.0, 145.0], "value": 145.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 50.0, 50.0, 52.0, 52.0, 52.0, 53.0, 51.0, 52.0, 52.0], "value": 51.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 62.0, 61.0, 63.0, 61.0, 62.0, 62.0, 62.0, 62.0], "value": 61.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 78.0, 80.0, 78.0, 88.0, 80.0, 79.0, 78.0, 79.0, 79.0], "value": 80.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 129.0, 129.0, 134.0, 139.0, 145.0, 141.0, 128.0, 171.0, 137.0], "value": 138.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 173.0, 178.0, 170.0, 171.0, 169.0, 169.0, 172.0, 173.0, 170.0], "value": 171.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 69.0, 67.0, 67.0, 67.0, 65.0, 67.0, 66.0, 65.0, 65.0], "value": 66.7, "unit": "score"}], "name": "kraken", "value": 1508.8, "alertThreshold": 2.0}]} 22:06:54 INFO - Return code: 0 22:06:54 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 22:06:54 INFO - # TBPL SUCCESS # 22:06:54 INFO - Running post-action listener: _resource_record_post_action 22:06:54 INFO - [mozharness: 2016-10-07 05:06:54.699634Z] Finished run-tests step (success) 22:06:54 INFO - Running post-run listener: _resource_record_post_run 22:06:54 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 4096; Write bytes: 400711680; Read time: 8; Write time: 348668 22:06:54 INFO - TinderboxPrint: CPU usage
13.1% 22:06:54 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 22:06:54 INFO - TinderboxPrint: I/O write bytes / time
400,711,680 / 348,668 22:06:54 INFO - TinderboxPrint: CPU idle
8,309.7 (86.9%) 22:06:54 INFO - TinderboxPrint: CPU user
1,197.1 (12.5%) 22:06:54 INFO - TinderboxPrint: Swap in / out
0 / 0 22:06:54 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 111677440; Read time: 0; Write time: 103360 22:06:54 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 4096; Write bytes: 289034240; Read time: 8; Write time: 245308 22:06:55 INFO - Running post-run listener: _upload_blobber_files 22:06:55 INFO - Blob upload gear active. 22:06:55 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 22:06:55 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 22:06:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 22:06:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 22:06:55 INFO - (blobuploader) - INFO - Open directory for files ... 22:06:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 22:06:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:06:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:06:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 22:06:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:06:56 INFO - (blobuploader) - INFO - Done attempting. 22:06:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 22:06:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:06:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:06:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 22:06:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:06:57 INFO - (blobuploader) - INFO - Done attempting. 22:06:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 22:06:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:06:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:07:00 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 22:07:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:07:00 INFO - (blobuploader) - INFO - Done attempting. 22:07:00 INFO - (blobuploader) - INFO - Iteration through files over. 22:07:00 INFO - Return code: 0 22:07:00 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 22:07:00 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 22:07:00 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6274092eff0d3e3b301ba8b62e15facae3e41af1d0669b26329f99beb0aa8514f894ec38cfacea61256528700b7d4807f0dde9612ac9444d413157ef574eac18", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/65e74f422e19c3001689bccc9116f600a2f3aa65ba2c6115096283c46fab110a06688692338f1bd69d5a700a9a8273574cfde8595acf077eabd087c06824c583", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7179b259f8eb88166adfefcc1589655f2c3836dbf9cd4f18f1220c2de00c420ce624c0275233113773653635564d486db3929b3fd9347b4ac86e0b853f66e76c"} 22:07:00 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 22:07:00 INFO - Writing to file /builds/slave/test/properties/blobber_files 22:07:00 INFO - Contents: 22:07:00 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6274092eff0d3e3b301ba8b62e15facae3e41af1d0669b26329f99beb0aa8514f894ec38cfacea61256528700b7d4807f0dde9612ac9444d413157ef574eac18", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/65e74f422e19c3001689bccc9116f600a2f3aa65ba2c6115096283c46fab110a06688692338f1bd69d5a700a9a8273574cfde8595acf077eabd087c06824c583", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7179b259f8eb88166adfefcc1589655f2c3836dbf9cd4f18f1220c2de00c420ce624c0275233113773653635564d486db3929b3fd9347b4ac86e0b853f66e76c"} 22:07:00 INFO - Running post-run listener: copy_logs_to_upload_dir 22:07:00 INFO - Copying logs to upload dir... 22:07:00 INFO - mkdir: /builds/slave/test/build/upload/logs 22:07:00 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.550176 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-10-06 22:07:00.622449) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-06 22:07:00.625689) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=c6927cf182745ad25b1d38b9000001fe-1475815581.533826-388927631 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6274092eff0d3e3b301ba8b62e15facae3e41af1d0669b26329f99beb0aa8514f894ec38cfacea61256528700b7d4807f0dde9612ac9444d413157ef574eac18", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/65e74f422e19c3001689bccc9116f600a2f3aa65ba2c6115096283c46fab110a06688692338f1bd69d5a700a9a8273574cfde8595acf077eabd087c06824c583", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7179b259f8eb88166adfefcc1589655f2c3836dbf9cd4f18f1220c2de00c420ce624c0275233113773653635564d486db3929b3fd9347b4ac86e0b853f66e76c"} build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1475803800/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011366 build_url: 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1475803800/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6274092eff0d3e3b301ba8b62e15facae3e41af1d0669b26329f99beb0aa8514f894ec38cfacea61256528700b7d4807f0dde9612ac9444d413157ef574eac18", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/65e74f422e19c3001689bccc9116f600a2f3aa65ba2c6115096283c46fab110a06688692338f1bd69d5a700a9a8273574cfde8595acf077eabd087c06824c583", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7179b259f8eb88166adfefcc1589655f2c3836dbf9cd4f18f1220c2de00c420ce624c0275233113773653635564d486db3929b3fd9347b4ac86e0b853f66e76c"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-06 22:07:00.651718) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 22:07:00.652076) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=c6927cf182745ad25b1d38b9000001fe-1475815581.533826-388927631 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004451 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 22:07:00.735281) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-06 22:07:00.735625) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-06 22:07:00.735927) ========= ========= Total master_lag: 0.17 =========