builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-040 starttime: 1477478158.67 results: success (0) buildid: 20161026003021 builduid: 33658884f83c48d9967f732a41285ca9 revision: f9f3cc95d7282f1fd83f66dd74acbcdbfe821915 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-26 03:35:58.674079) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-26 03:35:58.674489) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-26 03:35:58.674760) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-26 03:35:58.702032) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 03:35:58.702298) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1477476345.565501-940132543 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-26 03:35:59-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 225M=0s 2016-10-26 03:35:59 (225 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.107305 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 03:35:58.827293) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 03:35:58.827776) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1477476345.565501-940132543 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021705 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 03:35:58.880027) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 03:35:58.880374) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev f9f3cc95d7282f1fd83f66dd74acbcdbfe821915 --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 f9f3cc95d7282f1fd83f66dd74acbcdbfe821915 --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=9e0dfe3369c33a1556e63f89000001d8-1477476345.565501-940132543 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-26 03:35:59,451 truncating revision to first 12 chars 2016-10-26 03:35:59,451 Setting DEBUG logging. 2016-10-26 03:35:59,451 attempt 1/10 2016-10-26 03:35:59,451 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/f9f3cc95d728?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-26 03:35:59,894 unpacking tar archive at: fx-team-f9f3cc95d728/testing/mozharness/ program finished with exit code 0 elapsedTime=0.749318 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 03:35:59.643021) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-26 03:35:59.643362) ========= script_repo_revision: f9f3cc95d7282f1fd83f66dd74acbcdbfe821915 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-26 03:35:59.643751) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-26 03:35:59.644016) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-26 03:35:59.656163) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-10-26 03:35:59.656451) ========= /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=9e0dfe3369c33a1556e63f89000001d8-1477476345.565501-940132543 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:36:00 INFO - MultiFileLogger online at 20161026 03:36:00 in /builds/slave/test 03:36:00 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 03:36:00 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:36:00 INFO - {'append_to_log': False, 03:36:00 INFO - 'base_work_dir': '/builds/slave/test', 03:36:00 INFO - 'blob_upload_branch': 'Fx-Team', 03:36:00 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:36:00 INFO - 'branch': 'Fx-Team', 03:36:00 INFO - 'buildbot_json_path': 'buildprops.json', 03:36:00 INFO - 'config_files': ('talos/linux_config.py',), 03:36:00 INFO - 'default_actions': ('clobber', 03:36:00 INFO - 'read-buildbot-config', 03:36:00 INFO - 'download-and-extract', 03:36:00 INFO - 'populate-webroot', 03:36:00 INFO - 'create-virtualenv', 03:36:00 INFO - 'install', 03:36:00 INFO - 'run-tests'), 03:36:00 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:36:00 INFO - 'download_minidump_stackwalk': True, 03:36:00 INFO - 'download_symbols': 'ondemand', 03:36:00 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:36:00 INFO - 'tooltool.py': '/tools/tooltool.py', 03:36:00 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:36:00 INFO - '/tools/misc-python/virtualenv.py')}, 03:36:00 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:36:00 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:36:00 INFO - 'installer_path': 'installer.exe', 03:36:00 INFO - 'log_level': 'info', 03:36:00 INFO - 'log_name': 'talos', 03:36:00 INFO - 'log_to_console': True, 03:36:00 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:36:00 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:36:00 INFO - 'opt_config_files': (), 03:36:00 INFO - 'pip_index': False, 03:36:00 INFO - 'sps_profile': False, 03:36:00 INFO - 'sps_profile_interval': 0, 03:36:00 INFO - 'suite': 'dromaeojs', 03:36:00 INFO - 'system_bits': '32', 03:36:00 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:36:00 INFO - 'title': 'talos-linux64-ix-040', 03:36:00 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:36:00 INFO - 'use_talos_json': True, 03:36:00 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:36:00 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:36:00 INFO - 'work_dir': 'build'} 03:36:00 INFO - [mozharness: 2016-10-26 10:36:00.321782Z] Running clobber step. 03:36:00 INFO - Running pre-action listener: _resource_record_pre_action 03:36:00 INFO - Running main action method: clobber 03:36:00 INFO - rmtree: /builds/slave/test/build 03:36:00 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:36:00 INFO - Running post-action listener: _resource_record_post_action 03:36:00 INFO - [mozharness: 2016-10-26 10:36:00.786067Z] Finished clobber step (success) 03:36:00 INFO - [mozharness: 2016-10-26 10:36:00.786169Z] Running read-buildbot-config step. 03:36:00 INFO - Running pre-action listener: _resource_record_pre_action 03:36:00 INFO - Running main action method: read_buildbot_config 03:36:00 INFO - Using buildbot properties: 03:36:00 INFO - { 03:36:00 INFO - "project": "", 03:36:00 INFO - "product": "firefox", 03:36:00 INFO - "script_repo_revision": "production", 03:36:00 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 03:36:00 INFO - "repository": "", 03:36:00 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 03:36:00 INFO - "buildid": "20161026003021", 03:36:00 INFO - "pgo_build": "True", 03:36:00 INFO - "basedir": "/builds/slave/test", 03:36:00 INFO - "buildnumber": 560, 03:36:00 INFO - "slavename": "talos-linux64-ix-040", 03:36:00 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 03:36:00 INFO - "platform": "ubuntu64_hw", 03:36:00 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 03:36:00 INFO - "branch": "fx-team", 03:36:00 INFO - "repo_path": "integration/fx-team", 03:36:00 INFO - "revision": "f9f3cc95d7282f1fd83f66dd74acbcdbfe821915", 03:36:00 INFO - "stage_platform": "linux64-pgo", 03:36:00 INFO - "builduid": "33658884f83c48d9967f732a41285ca9", 03:36:00 INFO - "slavebuilddir": "test" 03:36:00 INFO - } 03:36:00 INFO - Found installer url https://queue.taskcluster.net/v1/task/Cpqc0s_UQDGAAt8wCYrSRg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 03:36:00 INFO - Running post-action listener: _resource_record_post_action 03:36:00 INFO - [mozharness: 2016-10-26 10:36:00.788611Z] Finished read-buildbot-config step (success) 03:36:00 INFO - [mozharness: 2016-10-26 10:36:00.788700Z] Running download-and-extract step. 03:36:00 INFO - Running pre-action listener: _resource_record_pre_action 03:36:00 INFO - Running main action method: download_and_extract 03:36:00 INFO - mkdir: /builds/slave/test/build/tests 03:36:00 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')]} 03:36:00 INFO - trying https://queue.taskcluster.net/v1/task/Cpqc0s_UQDGAAt8wCYrSRg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 03:36:00 INFO - Downloading https://queue.taskcluster.net/v1/task/Cpqc0s_UQDGAAt8wCYrSRg/artifacts/public/build/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 03:36:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Cpqc0s_UQDGAAt8wCYrSRg/artifacts/public/build/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 03:36:01 INFO - Downloaded 1361 bytes. 03:36:01 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 03:36:01 INFO - Using the following test package requirements: 03:36:01 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 03:36:01 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 03:36:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 03:36:01 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 03:36:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 03:36:01 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 03:36:01 INFO - u'jsshell-linux-x86_64.zip'], 03:36:01 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 03:36:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 03:36:01 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 03:36:01 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 03:36:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 03:36:01 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 03:36:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 03:36:01 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 03:36:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 03:36:01 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 03:36:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 03:36:01 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:36:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Cpqc0s_UQDGAAt8wCYrSRg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 03:36:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Cpqc0s_UQDGAAt8wCYrSRg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:36:01 INFO - Fetch https://queue.taskcluster.net/v1/task/Cpqc0s_UQDGAAt8wCYrSRg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 03:36:01 INFO - Http code: 200 03:36:01 INFO - via: 1.1 7f9e159e8ac7593f5d3d995abc6d2db3.cloudfront.net (CloudFront) 03:36:01 INFO - x-amz-cf-id: t3PyT7UAWJpXAsG2RmaW3NOHpsfOgLLwKCRhziHfqyMP9xxacLLznQ== 03:36:01 INFO - x-amz-version-id: YWpsQGm.kaEUKvz3g15Ob2CGJKYoJm7W 03:36:02 INFO - Expected file size: 22050788 03:36:02 INFO - Obtained file size: 22050788 03:36:06 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 03:36:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Cpqc0s_UQDGAAt8wCYrSRg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 03:36:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Cpqc0s_UQDGAAt8wCYrSRg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:36:06 INFO - Fetch https://queue.taskcluster.net/v1/task/Cpqc0s_UQDGAAt8wCYrSRg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 03:36:06 INFO - Http code: 200 03:36:06 INFO - via: 1.1 c54d7f08e2f3dab1918454910cc8aad0.cloudfront.net (CloudFront) 03:36:06 INFO - x-amz-cf-id: X-h_wWJfXFJkrRIOBibVoUe7fOO5yz57Xg_-xNTTa_M-46vlGebn7Q== 03:36:06 INFO - x-amz-version-id: YWpsQGm.kaEUKvz3g15Ob2CGJKYoJm7W 03:36:07 INFO - Expected file size: 22050788 03:36:07 INFO - Obtained file size: 22050788 03:36:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Cpqc0s_UQDGAAt8wCYrSRg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 03:36:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Cpqc0s_UQDGAAt8wCYrSRg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 03:36:11 INFO - Fetch https://queue.taskcluster.net/v1/task/Cpqc0s_UQDGAAt8wCYrSRg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 03:36:12 INFO - Http code: 200 03:36:12 INFO - via: 1.1 24b0e5a3429d07ef12381da50e07f70f.cloudfront.net (CloudFront) 03:36:12 INFO - x-amz-cf-id: ANhvkcim_WfVajz10g8PmXtmiZoj_q-SnfvsRkkHtsDZ795dFBbfVw== 03:36:12 INFO - x-amz-version-id: 098heAa1Zpvwb6Zi1XHM7hGHgIbVPYJo 03:36:12 INFO - Expected file size: 14409028 03:36:12 INFO - Obtained file size: 14409028 03:36:12 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')]} 03:36:12 INFO - trying https://queue.taskcluster.net/v1/task/Cpqc0s_UQDGAAt8wCYrSRg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 03:36:12 INFO - Downloading https://queue.taskcluster.net/v1/task/Cpqc0s_UQDGAAt8wCYrSRg/artifacts/public/build/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 03:36:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Cpqc0s_UQDGAAt8wCYrSRg/artifacts/public/build/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 03:36:13 INFO - Downloaded 59470048 bytes. 03:36:13 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Cpqc0s_UQDGAAt8wCYrSRg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 03:36:13 INFO - mkdir: /builds/slave/test/properties 03:36:13 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:36:13 INFO - Writing to file /builds/slave/test/properties/build_url 03:36:13 INFO - Contents: 03:36:13 INFO - build_url:https://queue.taskcluster.net/v1/task/Cpqc0s_UQDGAAt8wCYrSRg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 03:36:14 INFO - Running post-action listener: _resource_record_post_action 03:36:14 INFO - Running post-action listener: set_extra_try_arguments 03:36:14 INFO - [mozharness: 2016-10-26 10:36:14.334467Z] Finished download-and-extract step (success) 03:36:14 INFO - [mozharness: 2016-10-26 10:36:14.334765Z] Running populate-webroot step. 03:36:14 INFO - Running pre-action listener: _resource_record_pre_action 03:36:14 INFO - Running main action method: populate_webroot 03:36:14 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:36:14 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:36:14 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:36:14 INFO - '--tppagecycles', 03:36:14 INFO - '7'], 03:36:14 INFO - 'tests': ['tsvgm']}}, 03:36:14 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:36:14 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:36:14 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:36:14 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:36:14 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:36:14 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:36:14 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:36:14 INFO - 'talos_options': ['--disable-e10s'], 03:36:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:36:14 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:36:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:36:14 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:36:14 INFO - 'talos_options': ['--disable-e10s'], 03:36:14 INFO - 'tests': ['damp', 'tps']}, 03:36:14 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:36:14 INFO - 'tests': ['damp', 'tps']}, 03:36:14 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:36:14 INFO - 'tests': ['dromaeo_dom']}, 03:36:14 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:36:14 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:36:14 INFO - 'tests': ['basic_compositor_video']}, 03:36:14 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:36:14 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:36:14 INFO - 'tests': ['a11yr', 03:36:14 INFO - 'ts_paint', 03:36:14 INFO - 'tpaint', 03:36:14 INFO - 'sessionrestore', 03:36:14 INFO - 'sessionrestore_no_auto_restore', 03:36:14 INFO - 'tabpaint']}, 03:36:14 INFO - 'other-e10s': {'tests': ['a11yr', 03:36:14 INFO - 'ts_paint', 03:36:14 INFO - 'tpaint', 03:36:14 INFO - 'sessionrestore', 03:36:14 INFO - 'sessionrestore_no_auto_restore', 03:36:14 INFO - 'tabpaint']}, 03:36:14 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:36:14 INFO - 'ts_paint', 03:36:14 INFO - 'tpaint', 03:36:14 INFO - 'sessionrestore', 03:36:14 INFO - 'sessionrestore_no_auto_restore', 03:36:14 INFO - 'tabpaint']}, 03:36:14 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:36:14 INFO - 'ts_paint', 03:36:14 INFO - 'tpaint', 03:36:14 INFO - 'sessionrestore', 03:36:14 INFO - 'sessionrestore_no_auto_restore', 03:36:14 INFO - 'tabpaint']}, 03:36:14 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:36:14 INFO - 'tests': ['a11yr', 03:36:14 INFO - 'ts_paint', 03:36:14 INFO - 'tpaint', 03:36:14 INFO - 'sessionrestore', 03:36:14 INFO - 'sessionrestore_no_auto_restore', 03:36:14 INFO - 'tabpaint']}, 03:36:14 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:36:14 INFO - 'tests': ['a11yr', 03:36:14 INFO - 'ts_paint', 03:36:14 INFO - 'tpaint', 03:36:14 INFO - 'sessionrestore', 03:36:14 INFO - 'sessionrestore_no_auto_restore', 03:36:14 INFO - 'tabpaint']}, 03:36:14 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:36:14 INFO - 'tests': ['tsvgx', 03:36:14 INFO - 'tsvgr_opacity', 03:36:14 INFO - 'tart', 03:36:14 INFO - 'tscrollx', 03:36:14 INFO - 'cart']}, 03:36:14 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:36:14 INFO - 'tsvgr_opacity', 03:36:14 INFO - 'tart', 03:36:14 INFO - 'tscrollx', 03:36:14 INFO - 'cart']}, 03:36:14 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:36:14 INFO - 'talos_options': ['--disable-e10s'], 03:36:14 INFO - 'tests': ['tp5o']}, 03:36:14 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:36:14 INFO - 'tests': ['tp5o']}, 03:36:14 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:36:14 INFO - 'talos_options': ['--disable-e10s', 03:36:14 INFO - '--xperf_path', 03:36:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:36:14 INFO - 'tests': ['tp5n']}, 03:36:14 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:36:14 INFO - 'talos_options': ['--xperf_path', 03:36:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:36:14 INFO - 'tests': ['tp5n']}}, 03:36:14 INFO - 'talos.zip': {'path': '', 03:36:14 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:36:14 INFO - Running post-action listener: _resource_record_post_action 03:36:14 INFO - [mozharness: 2016-10-26 10:36:14.356502Z] Finished populate-webroot step (success) 03:36:14 INFO - [mozharness: 2016-10-26 10:36:14.356595Z] Running create-virtualenv step. 03:36:14 INFO - Running pre-action listener: _resource_record_pre_action 03:36:14 INFO - Running main action method: create_virtualenv 03:36:14 INFO - Creating virtualenv /builds/slave/test/build/venv 03:36:14 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 03:36:14 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:36:14 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:36:14 INFO - Using real prefix '/usr' 03:36:14 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:36:14 INFO - Installing distribute.............................................................................................................................................................................................done. 03:36:16 INFO - Installing pip.................done. 03:36:16 INFO - Return code: 0 03:36:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:36:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:36:17 INFO - Reading from file tmpfile_stdout 03:36:17 INFO - Output received: 03:36:17 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) 03:36:17 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:36:17 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')]} 03:36:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:36:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:36:17 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')]} 03:36:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:36:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:36:17 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 0x7f591985ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x218b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2258790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2255930>, '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 0x2256830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2256cc0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1477476345.565501-940132543', '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 03:36:17 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 03:36:17 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 03:36:17 INFO - Using env: {'DISPLAY': ':0', 03:36:17 INFO - 'HOME': '/home/cltbld', 03:36:17 INFO - 'LANG': 'en_US.UTF-8', 03:36:17 INFO - 'LANGUAGE': 'en_US:en', 03:36:17 INFO - 'LOGNAME': 'cltbld', 03:36:17 INFO - 'MAIL': '/var/mail/cltbld', 03:36:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:36:17 INFO - 'MOZ_NO_REMOTE': '1', 03:36:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:36:17 INFO - 'NO_EM_RESTART': '1', 03:36:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:36:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:36:17 INFO - 'PWD': '/builds/slave/test', 03:36:17 INFO - 'SHELL': '/bin/bash', 03:36:17 INFO - 'SHLVL': '1', 03:36:17 INFO - 'TERM': 'linux', 03:36:17 INFO - 'TMOUT': '86400', 03:36:17 INFO - 'USER': 'cltbld', 03:36:17 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1477476345.565501-940132543', 03:36:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:36:17 INFO - '_': '/tools/buildbot/bin/python'} 03:36:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:36:17 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 03:36:17 INFO - Cleaning up... 03:36:17 INFO - Return code: 0 03:36:17 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:36:17 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')]} 03:36:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:36:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:36:17 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')]} 03:36:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:36:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:36:17 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 0x7f591985ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x218b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2258790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2255930>, '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 0x2256830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2256cc0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1477476345.565501-940132543', '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 03:36:17 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 03:36:17 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 03:36:17 INFO - Using env: {'DISPLAY': ':0', 03:36:17 INFO - 'HOME': '/home/cltbld', 03:36:17 INFO - 'LANG': 'en_US.UTF-8', 03:36:17 INFO - 'LANGUAGE': 'en_US:en', 03:36:17 INFO - 'LOGNAME': 'cltbld', 03:36:17 INFO - 'MAIL': '/var/mail/cltbld', 03:36:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:36:17 INFO - 'MOZ_NO_REMOTE': '1', 03:36:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:36:17 INFO - 'NO_EM_RESTART': '1', 03:36:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:36:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:36:17 INFO - 'PWD': '/builds/slave/test', 03:36:17 INFO - 'SHELL': '/bin/bash', 03:36:17 INFO - 'SHLVL': '1', 03:36:17 INFO - 'TERM': 'linux', 03:36:17 INFO - 'TMOUT': '86400', 03:36:17 INFO - 'USER': 'cltbld', 03:36:17 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1477476345.565501-940132543', 03:36:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:36:17 INFO - '_': '/tools/buildbot/bin/python'} 03:36:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:36:17 INFO - Downloading/unpacking psutil>=3.1.1 03:36:17 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 03:36:17 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 03:36:17 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 03:36:17 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 03:36:17 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 03:36:17 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 03:36:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:36:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:36:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:36:19 INFO - Installing collected packages: psutil 03:36:19 INFO - Running setup.py install for psutil 03:36:19 INFO - building 'psutil._psutil_linux' extension 03:36:19 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 03:36:19 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 03:36:19 INFO - building 'psutil._psutil_posix' extension 03:36:19 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 03:36:20 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 03:36:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:36:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:36:20 INFO - Successfully installed psutil 03:36:20 INFO - Cleaning up... 03:36:20 INFO - Return code: 0 03:36:20 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:36:20 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')]} 03:36:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:36:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:36:20 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')]} 03:36:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:36:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:36:20 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 0x7f591985ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x218b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2258790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2255930>, '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 0x2256830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2256cc0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1477476345.565501-940132543', '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 03:36:20 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 03:36:20 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 03:36:20 INFO - Using env: {'DISPLAY': ':0', 03:36:20 INFO - 'HOME': '/home/cltbld', 03:36:20 INFO - 'LANG': 'en_US.UTF-8', 03:36:20 INFO - 'LANGUAGE': 'en_US:en', 03:36:20 INFO - 'LOGNAME': 'cltbld', 03:36:20 INFO - 'MAIL': '/var/mail/cltbld', 03:36:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:36:20 INFO - 'MOZ_NO_REMOTE': '1', 03:36:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:36:20 INFO - 'NO_EM_RESTART': '1', 03:36:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:36:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:36:20 INFO - 'PWD': '/builds/slave/test', 03:36:20 INFO - 'SHELL': '/bin/bash', 03:36:20 INFO - 'SHLVL': '1', 03:36:20 INFO - 'TERM': 'linux', 03:36:20 INFO - 'TMOUT': '86400', 03:36:20 INFO - 'USER': 'cltbld', 03:36:20 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1477476345.565501-940132543', 03:36:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:36:20 INFO - '_': '/tools/buildbot/bin/python'} 03:36:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:36:20 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:36:20 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 03:36:20 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 03:36:20 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 03:36:20 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 03:36:20 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 03:36:20 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 03:36:22 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:36:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:36:22 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:36:22 INFO - Installing collected packages: mozsystemmonitor 03:36:22 INFO - Running setup.py install for mozsystemmonitor 03:36:22 INFO - Successfully installed mozsystemmonitor 03:36:22 INFO - Cleaning up... 03:36:22 INFO - Return code: 0 03:36:22 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:36:22 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')]} 03:36:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:36:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:36:22 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')]} 03:36:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:36:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:36:22 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 0x7f591985ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x218b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2258790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2255930>, '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 0x2256830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2256cc0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1477476345.565501-940132543', '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 03:36:22 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 03:36:22 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 03:36:22 INFO - Using env: {'DISPLAY': ':0', 03:36:22 INFO - 'HOME': '/home/cltbld', 03:36:22 INFO - 'LANG': 'en_US.UTF-8', 03:36:22 INFO - 'LANGUAGE': 'en_US:en', 03:36:22 INFO - 'LOGNAME': 'cltbld', 03:36:22 INFO - 'MAIL': '/var/mail/cltbld', 03:36:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:36:22 INFO - 'MOZ_NO_REMOTE': '1', 03:36:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:36:22 INFO - 'NO_EM_RESTART': '1', 03:36:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:36:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:36:22 INFO - 'PWD': '/builds/slave/test', 03:36:22 INFO - 'SHELL': '/bin/bash', 03:36:22 INFO - 'SHLVL': '1', 03:36:22 INFO - 'TERM': 'linux', 03:36:22 INFO - 'TMOUT': '86400', 03:36:22 INFO - 'USER': 'cltbld', 03:36:22 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1477476345.565501-940132543', 03:36:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:36:22 INFO - '_': '/tools/buildbot/bin/python'} 03:36:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:36:22 INFO - Downloading/unpacking jsonschema==2.5.1 03:36:22 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 03:36:22 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 03:36:22 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 03:36:22 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 03:36:22 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 03:36:22 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 03:36:24 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:36:24 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:36:24 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 03:36:24 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 03:36:24 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 03:36:24 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 03:36:24 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 03:36:24 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 03:36:24 INFO - Downloading functools32-3.2.3-2.tar.gz 03:36:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:36:24 INFO - warning: no files found matching '*.txt' 03:36:24 INFO - no previously-included directories found matching 'build' 03:36:24 INFO - no previously-included directories found matching 'dist' 03:36:24 INFO - no previously-included directories found matching '.git*' 03:36:24 INFO - Installing collected packages: jsonschema, functools32 03:36:25 INFO - Running setup.py install for functools32 03:36:25 INFO - warning: no files found matching '*.txt' 03:36:25 INFO - no previously-included directories found matching 'build' 03:36:25 INFO - no previously-included directories found matching 'dist' 03:36:25 INFO - no previously-included directories found matching '.git*' 03:36:25 INFO - Successfully installed jsonschema functools32 03:36:25 INFO - Cleaning up... 03:36:25 INFO - Return code: 0 03:36:25 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:36:25 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')]} 03:36:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:36:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:36:25 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')]} 03:36:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:36:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:36:25 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 0x7f591985ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x218b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2258790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2255930>, '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 0x2256830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2256cc0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1477476345.565501-940132543', '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 03:36:25 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 03:36:25 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 03:36:25 INFO - Using env: {'DISPLAY': ':0', 03:36:25 INFO - 'HOME': '/home/cltbld', 03:36:25 INFO - 'LANG': 'en_US.UTF-8', 03:36:25 INFO - 'LANGUAGE': 'en_US:en', 03:36:25 INFO - 'LOGNAME': 'cltbld', 03:36:25 INFO - 'MAIL': '/var/mail/cltbld', 03:36:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:36:25 INFO - 'MOZ_NO_REMOTE': '1', 03:36:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:36:25 INFO - 'NO_EM_RESTART': '1', 03:36:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:36:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:36:25 INFO - 'PWD': '/builds/slave/test', 03:36:25 INFO - 'SHELL': '/bin/bash', 03:36:25 INFO - 'SHLVL': '1', 03:36:25 INFO - 'TERM': 'linux', 03:36:25 INFO - 'TMOUT': '86400', 03:36:25 INFO - 'USER': 'cltbld', 03:36:25 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1477476345.565501-940132543', 03:36:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:36:25 INFO - '_': '/tools/buildbot/bin/python'} 03:36:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:36:25 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:36:25 INFO - Cleaning up... 03:36:25 INFO - Return code: 0 03:36:25 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:36:25 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')]} 03:36:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:36:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:36:25 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')]} 03:36:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:36:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:36:25 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 0x7f591985ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x218b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2258790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2255930>, '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 0x2256830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2256cc0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1477476345.565501-940132543', '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 03:36:25 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 03:36:25 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 03:36:25 INFO - Using env: {'DISPLAY': ':0', 03:36:25 INFO - 'HOME': '/home/cltbld', 03:36:25 INFO - 'LANG': 'en_US.UTF-8', 03:36:25 INFO - 'LANGUAGE': 'en_US:en', 03:36:25 INFO - 'LOGNAME': 'cltbld', 03:36:25 INFO - 'MAIL': '/var/mail/cltbld', 03:36:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:36:25 INFO - 'MOZ_NO_REMOTE': '1', 03:36:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:36:25 INFO - 'NO_EM_RESTART': '1', 03:36:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:36:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:36:25 INFO - 'PWD': '/builds/slave/test', 03:36:25 INFO - 'SHELL': '/bin/bash', 03:36:25 INFO - 'SHLVL': '1', 03:36:25 INFO - 'TERM': 'linux', 03:36:25 INFO - 'TMOUT': '86400', 03:36:25 INFO - 'USER': 'cltbld', 03:36:25 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1477476345.565501-940132543', 03:36:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:36:25 INFO - '_': '/tools/buildbot/bin/python'} 03:36:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:36:25 INFO - Downloading/unpacking blobuploader==1.2.4 03:36:25 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 03:36:25 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 03:36:25 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 03:36:25 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 03:36:25 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 03:36:25 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 03:36:27 INFO - Downloading blobuploader-1.2.4.tar.gz 03:36:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:36:27 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:36:27 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 03:36:27 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 03:36:27 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 03:36:27 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 03:36:27 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 03:36:27 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 03:36:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:36:28 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:36:28 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 03:36:28 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 03:36:28 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 03:36:28 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 03:36:28 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 03:36:28 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 03:36:28 INFO - Downloading docopt-0.6.1.tar.gz 03:36:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:36:28 INFO - Installing collected packages: blobuploader, requests, docopt 03:36:28 INFO - Running setup.py install for blobuploader 03:36:28 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:36:28 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:36:28 INFO - Running setup.py install for requests 03:36:28 INFO - Running setup.py install for docopt 03:36:28 INFO - Successfully installed blobuploader requests docopt 03:36:28 INFO - Cleaning up... 03:36:28 INFO - Return code: 0 03:36:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:36:28 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')]} 03:36:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:36:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:36:28 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')]} 03:36:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:36:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:36:29 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 0x7f591985ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x218b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2258790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2255930>, '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 0x2256830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2256cc0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1477476345.565501-940132543', '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 03:36:29 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 03:36:29 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 03:36:29 INFO - Using env: {'DISPLAY': ':0', 03:36:29 INFO - 'HOME': '/home/cltbld', 03:36:29 INFO - 'LANG': 'en_US.UTF-8', 03:36:29 INFO - 'LANGUAGE': 'en_US:en', 03:36:29 INFO - 'LOGNAME': 'cltbld', 03:36:29 INFO - 'MAIL': '/var/mail/cltbld', 03:36:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:36:29 INFO - 'MOZ_NO_REMOTE': '1', 03:36:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:36:29 INFO - 'NO_EM_RESTART': '1', 03:36:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:36:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:36:29 INFO - 'PWD': '/builds/slave/test', 03:36:29 INFO - 'SHELL': '/bin/bash', 03:36:29 INFO - 'SHLVL': '1', 03:36:29 INFO - 'TERM': 'linux', 03:36:29 INFO - 'TMOUT': '86400', 03:36:29 INFO - 'USER': 'cltbld', 03:36:29 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1477476345.565501-940132543', 03:36:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:36:29 INFO - '_': '/tools/buildbot/bin/python'} 03:36:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:36:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:36:29 INFO - Running setup.py (path:/tmp/pip-uwjTR9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:36:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:36:29 INFO - Running setup.py (path:/tmp/pip-dQGN77-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:36:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:36:29 INFO - Running setup.py (path:/tmp/pip-osicB4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:36:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:36:29 INFO - Running setup.py (path:/tmp/pip-X5TJHW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:36:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:36:29 INFO - Running setup.py (path:/tmp/pip-0l9lOd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:36:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:36:29 INFO - Running setup.py (path:/tmp/pip-0bh3AV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:36:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:36:29 INFO - Running setup.py (path:/tmp/pip-8hRtgK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:36:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:36:29 INFO - Running setup.py (path:/tmp/pip-sU2K3H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:36:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:36:29 INFO - Running setup.py (path:/tmp/pip-8WSa7P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:36:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:36:29 INFO - Running setup.py (path:/tmp/pip-DocVqK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:36:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:36:29 INFO - Running setup.py (path:/tmp/pip-CujYSC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:36:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:36:30 INFO - Running setup.py (path:/tmp/pip-Iy7J6e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:36:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:36:30 INFO - Running setup.py (path:/tmp/pip-NCVhCV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:36:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:36:30 INFO - Running setup.py (path:/tmp/pip-Vk1uxM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:36:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:36:30 INFO - Running setup.py (path:/tmp/pip-72LCdX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:36:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:36:30 INFO - Running setup.py (path:/tmp/pip-9ivqb_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:36:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:36:30 INFO - Running setup.py (path:/tmp/pip-3jMPwj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:36:30 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:36:30 INFO - Running setup.py install for manifestparser 03:36:30 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:36:30 INFO - Running setup.py install for mozcrash 03:36:30 INFO - Running setup.py install for mozdebug 03:36:30 INFO - Running setup.py install for mozdevice 03:36:30 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:36:30 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:36:30 INFO - Running setup.py install for mozfile 03:36:30 INFO - Running setup.py install for mozhttpd 03:36:31 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:36:31 INFO - Running setup.py install for mozinfo 03:36:31 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:36:31 INFO - Running setup.py install for mozInstall 03:36:31 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:36:31 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:36:31 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:36:31 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:36:31 INFO - Running setup.py install for mozleak 03:36:31 INFO - Running setup.py install for mozlog 03:36:31 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:36:31 INFO - Running setup.py install for moznetwork 03:36:31 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:36:31 INFO - Running setup.py install for mozprocess 03:36:31 INFO - Running setup.py install for mozprofile 03:36:31 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:36:31 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:36:31 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:36:31 INFO - Running setup.py install for mozrunner 03:36:31 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:36:31 INFO - Running setup.py install for mozscreenshot 03:36:32 INFO - Running setup.py install for moztest 03:36:32 INFO - Running setup.py install for mozversion 03:36:32 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:36:32 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:36:32 INFO - Cleaning up... 03:36:32 INFO - Return code: 0 03:36:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:36:32 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')]} 03:36:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:36:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:36:32 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')]} 03:36:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:36:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:36:32 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 0x7f591985ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x218b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2258790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2255930>, '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 0x2256830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2256cc0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1477476345.565501-940132543', '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 03:36:32 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 03:36:32 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 03:36:32 INFO - Using env: {'DISPLAY': ':0', 03:36:32 INFO - 'HOME': '/home/cltbld', 03:36:32 INFO - 'LANG': 'en_US.UTF-8', 03:36:32 INFO - 'LANGUAGE': 'en_US:en', 03:36:32 INFO - 'LOGNAME': 'cltbld', 03:36:32 INFO - 'MAIL': '/var/mail/cltbld', 03:36:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:36:32 INFO - 'MOZ_NO_REMOTE': '1', 03:36:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:36:32 INFO - 'NO_EM_RESTART': '1', 03:36:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:36:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:36:32 INFO - 'PWD': '/builds/slave/test', 03:36:32 INFO - 'SHELL': '/bin/bash', 03:36:32 INFO - 'SHLVL': '1', 03:36:32 INFO - 'TERM': 'linux', 03:36:32 INFO - 'TMOUT': '86400', 03:36:32 INFO - 'USER': 'cltbld', 03:36:32 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1477476345.565501-940132543', 03:36:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:36:32 INFO - '_': '/tools/buildbot/bin/python'} 03:36:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:36:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:36:32 INFO - Running setup.py (path:/tmp/pip-sJEXc4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:36:32 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)) 03:36:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:36:32 INFO - Running setup.py (path:/tmp/pip-NG9CS_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:36:32 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)) 03:36:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:36:32 INFO - Running setup.py (path:/tmp/pip-UADptu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:36:32 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)) 03:36:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:36:32 INFO - Running setup.py (path:/tmp/pip-8Wdx0B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:36:32 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)) 03:36:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:36:32 INFO - Running setup.py (path:/tmp/pip-ydymUs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:36:32 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)) 03:36:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:36:32 INFO - Running setup.py (path:/tmp/pip-e5DcbW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:36:32 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)) 03:36:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:36:32 INFO - Running setup.py (path:/tmp/pip-8UPf3Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:36:32 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)) 03:36:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:36:33 INFO - Running setup.py (path:/tmp/pip-_tNBwO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:36:33 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)) 03:36:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:36:33 INFO - Running setup.py (path:/tmp/pip-HdwE9y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:36:33 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)) 03:36:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:36:33 INFO - Running setup.py (path:/tmp/pip-oPNfWF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:36:33 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)) 03:36:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:36:33 INFO - Running setup.py (path:/tmp/pip-UKyvWp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:36:33 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)) 03:36:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:36:33 INFO - Running setup.py (path:/tmp/pip-6Wa77B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:36:33 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)) 03:36:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:36:33 INFO - Running setup.py (path:/tmp/pip-4LRMxO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:36:33 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)) 03:36:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:36:33 INFO - Running setup.py (path:/tmp/pip-8nBmJT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:36:33 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)) 03:36:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:36:33 INFO - Running setup.py (path:/tmp/pip-qNu8Uf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:36:33 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)) 03:36:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:36:33 INFO - Running setup.py (path:/tmp/pip-LEHA9W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:36:33 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)) 03:36:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:36:33 INFO - Running setup.py (path:/tmp/pip-cqwTPy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:36:33 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)) 03:36:33 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)) 03:36:33 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)) 03:36:33 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)) 03:36:33 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)) 03:36:33 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)) 03:36:33 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:36:33 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 03:36:33 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 03:36:33 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 03:36:33 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 03:36:33 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 03:36:33 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 03:36:35 INFO - Downloading blessings-1.6.tar.gz 03:36:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:36:35 INFO - Installing collected packages: blessings 03:36:35 INFO - Running setup.py install for blessings 03:36:35 INFO - Successfully installed blessings 03:36:35 INFO - Cleaning up... 03:36:35 INFO - Return code: 0 03:36:35 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:36:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:36:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:36:36 INFO - Reading from file tmpfile_stdout 03:36:36 INFO - Current package versions: 03:36:36 INFO - argparse == 1.2.1 03:36:36 INFO - blessings == 1.6 03:36:36 INFO - blobuploader == 1.2.4 03:36:36 INFO - docopt == 0.6.1 03:36:36 INFO - functools32 == 3.2.3-2 03:36:36 INFO - jsonschema == 2.5.1 03:36:36 INFO - manifestparser == 1.1 03:36:36 INFO - mozInstall == 1.12 03:36:36 INFO - mozcrash == 0.17 03:36:36 INFO - mozdebug == 0.1 03:36:36 INFO - mozdevice == 0.48 03:36:36 INFO - mozfile == 1.2 03:36:36 INFO - mozhttpd == 0.7 03:36:36 INFO - mozinfo == 0.9 03:36:36 INFO - mozleak == 0.1 03:36:36 INFO - mozlog == 3.4 03:36:36 INFO - moznetwork == 0.27 03:36:36 INFO - mozprocess == 0.23 03:36:36 INFO - mozprofile == 0.28 03:36:36 INFO - mozrunner == 6.12 03:36:36 INFO - mozscreenshot == 0.1 03:36:36 INFO - mozsystemmonitor == 0.3 03:36:36 INFO - moztest == 0.7 03:36:36 INFO - mozversion == 1.4 03:36:36 INFO - psutil == 3.1.1 03:36:36 INFO - requests == 1.2.3 03:36:36 INFO - wsgiref == 0.1.2 03:36:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:36:36 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')]} 03:36:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:36:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:36:36 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')]} 03:36:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:36:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:36:36 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 0x7f591985ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x218b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2258790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2255930>, '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 0x2256830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2256cc0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1477476345.565501-940132543', '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 03:36:36 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 03:36:36 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 03:36:36 INFO - Using env: {'DISPLAY': ':0', 03:36:36 INFO - 'HOME': '/home/cltbld', 03:36:36 INFO - 'LANG': 'en_US.UTF-8', 03:36:36 INFO - 'LANGUAGE': 'en_US:en', 03:36:36 INFO - 'LOGNAME': 'cltbld', 03:36:36 INFO - 'MAIL': '/var/mail/cltbld', 03:36:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:36:36 INFO - 'MOZ_NO_REMOTE': '1', 03:36:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:36:36 INFO - 'NO_EM_RESTART': '1', 03:36:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:36:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:36:36 INFO - 'PWD': '/builds/slave/test', 03:36:36 INFO - 'SHELL': '/bin/bash', 03:36:36 INFO - 'SHLVL': '1', 03:36:36 INFO - 'TERM': 'linux', 03:36:36 INFO - 'TMOUT': '86400', 03:36:36 INFO - 'USER': 'cltbld', 03:36:36 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1477476345.565501-940132543', 03:36:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:36:36 INFO - '_': '/tools/buildbot/bin/python'} 03:36:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:36:36 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)) 03:36:36 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)) 03:36:36 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)) 03:36:36 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)) 03:36:36 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)) 03:36:36 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)) 03:36:36 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)) 03:36:36 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)) 03:36:36 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)) 03:36:36 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)) 03:36:36 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)) 03:36:36 INFO - Cleaning up... 03:36:36 INFO - Return code: 0 03:36:36 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:36:36 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')]} 03:36:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:36:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:36:36 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')]} 03:36:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:36:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:36:36 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 0x7f591985ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x218b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2258790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2255930>, '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 0x2256830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2256cc0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1477476345.565501-940132543', '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 03:36:36 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 03:36:36 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 03:36:36 INFO - Using env: {'DISPLAY': ':0', 03:36:36 INFO - 'HOME': '/home/cltbld', 03:36:36 INFO - 'LANG': 'en_US.UTF-8', 03:36:36 INFO - 'LANGUAGE': 'en_US:en', 03:36:36 INFO - 'LOGNAME': 'cltbld', 03:36:36 INFO - 'MAIL': '/var/mail/cltbld', 03:36:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:36:36 INFO - 'MOZ_NO_REMOTE': '1', 03:36:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:36:36 INFO - 'NO_EM_RESTART': '1', 03:36:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:36:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:36:36 INFO - 'PWD': '/builds/slave/test', 03:36:36 INFO - 'SHELL': '/bin/bash', 03:36:36 INFO - 'SHLVL': '1', 03:36:36 INFO - 'TERM': 'linux', 03:36:36 INFO - 'TMOUT': '86400', 03:36:36 INFO - 'USER': 'cltbld', 03:36:36 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1477476345.565501-940132543', 03:36:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:36:36 INFO - '_': '/tools/buildbot/bin/python'} 03:36:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:36:36 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:36:36 INFO - Cleaning up... 03:36:36 INFO - Return code: 0 03:36:36 INFO - Running post-action listener: _resource_record_post_action 03:36:36 INFO - Running post-action listener: _start_resource_monitoring 03:36:36 INFO - Starting resource monitoring. 03:36:36 INFO - [mozharness: 2016-10-26 10:36:36.645121Z] Finished create-virtualenv step (success) 03:36:36 INFO - [mozharness: 2016-10-26 10:36:36.645707Z] Running install step. 03:36:36 INFO - Running pre-action listener: _resource_record_pre_action 03:36:36 INFO - Running main action method: install 03:36:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:36:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:36:36 INFO - Reading from file tmpfile_stdout 03:36:36 INFO - Detecting whether we're running mozinstall >=1.0... 03:36:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:36:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:36:36 INFO - Reading from file tmpfile_stdout 03:36:36 INFO - Output received: 03:36:36 INFO - Usage: mozinstall [options] installer 03:36:36 INFO - Options: 03:36:36 INFO - -h, --help show this help message and exit 03:36:36 INFO - -d DEST, --destination=DEST 03:36:36 INFO - Directory to install application into. [default: 03:36:36 INFO - "/builds/slave/test"] 03:36:36 INFO - --app=APP Application being installed. [default: firefox] 03:36:36 INFO - mkdir: /builds/slave/test/build/application 03:36:36 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'] 03:36:36 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 03:36:53 INFO - Reading from file tmpfile_stdout 03:36:53 INFO - Output received: 03:36:53 INFO - /builds/slave/test/build/application/firefox/firefox 03:36:53 INFO - Running post-action listener: _resource_record_post_action 03:36:53 INFO - [mozharness: 2016-10-26 10:36:53.869478Z] Finished install step (success) 03:36:53 INFO - [mozharness: 2016-10-26 10:36:53.869732Z] Running run-tests step. 03:36:53 INFO - Running pre-action listener: _resource_record_pre_action 03:36:53 INFO - Running main action method: run_tests 03:36:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:36:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:36:53 INFO - Python 2.7.3 03:36:53 INFO - Return code: 0 03:36:53 INFO - grabbing minidump binary from tooltool 03:36:53 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')]} 03:36:53 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 0x2255930>, '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 0x2256830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2256cc0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:36:53 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 03:36:53 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 03:36:53 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 03:36:53 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:36:53 INFO - Return code: 0 03:36:53 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:36:53 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:36:53 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:36:53 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:36:53 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:36:53 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://queue.taskcluster.net/v1/task/Cpqc0s_UQDGAAt8wCYrSRg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-040', '--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 03:36:53 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://queue.taskcluster.net/v1/task/Cpqc0s_UQDGAAt8wCYrSRg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-040 --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 03:36:53 INFO - Using env: {'DISPLAY': ':0', 03:36:53 INFO - 'HOME': '/home/cltbld', 03:36:53 INFO - 'LANG': 'en_US.UTF-8', 03:36:53 INFO - 'LANGUAGE': 'en_US:en', 03:36:53 INFO - 'LOGNAME': 'cltbld', 03:36:53 INFO - 'MAIL': '/var/mail/cltbld', 03:36:53 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:36:53 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:36:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:36:53 INFO - 'MOZ_NO_REMOTE': '1', 03:36:53 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:36:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:36:53 INFO - 'NO_EM_RESTART': '1', 03:36:53 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:36:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:36:53 INFO - 'PWD': '/builds/slave/test', 03:36:53 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:36:53 INFO - 'SHELL': '/bin/bash', 03:36:53 INFO - 'SHLVL': '1', 03:36:53 INFO - 'TERM': 'linux', 03:36:53 INFO - 'TMOUT': '86400', 03:36:53 INFO - 'USER': 'cltbld', 03:36:53 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1477476345.565501-940132543', 03:36:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:36:53 INFO - '_': '/tools/buildbot/bin/python'} 03:36:53 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://queue.taskcluster.net/v1/task/Cpqc0s_UQDGAAt8wCYrSRg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-040', '--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 03:36:54 INFO - mozversion application_buildid: 20161026003021 03:36:54 INFO - mozversion application_changeset: f9f3cc95d7282f1fd83f66dd74acbcdbfe821915 03:36:54 INFO - mozversion application_display_name: Nightly 03:36:54 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:36:54 INFO - mozversion application_name: Firefox 03:36:54 INFO - mozversion application_remotingname: firefox 03:36:54 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 03:36:54 INFO - mozversion application_vendor: Mozilla 03:36:54 INFO - mozversion application_version: 52.0a1 03:36:54 INFO - mozversion platform_buildid: 20161026003021 03:36:54 INFO - mozversion platform_changeset: f9f3cc95d7282f1fd83f66dd74acbcdbfe821915 03:36:54 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 03:36:54 INFO - mozversion platform_version: 52.0a1 03:36:54 INFO - using testdate: 1477478214 03:36:54 INFO - actual date: 1477478214 03:36:54 INFO - starting webserver on 'localhost:53273' 03:36:54 INFO - SUITE-START | Running 2 tests 03:36:54 INFO - TEST-START | dromaeo_css 03:36:54 INFO - operating with platform_type : linux_ 03:36:54 INFO - Initialising browser for dromaeo_css test... 03:36:54 INFO - TEST-INFO | started process 3654 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfNIk5y/profile http://localhost:53273/getInfo.html) 03:36:58 INFO - PROCESS | 3654 | __metrics Screen width/height:1600/1200 03:36:58 INFO - PROCESS | 3654 | colorDepth:24 03:36:58 INFO - PROCESS | 3654 | Browser inner width/height: 1024/697 03:36:58 INFO - PROCESS | 3654 | __metrics 03:36:59 INFO - PROCESS | 3654 | 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" 03:36:59 INFO - PROCESS | 3654 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:36:59 INFO - PROCESS | 3654 | console.error: PushService: 03:36:59 INFO - PROCESS | 3654 | stateChangeProcessEnqueue: Error transitioning state 03:36:59 INFO - PROCESS | 3654 | UnknownError 03:37:00 INFO - TEST-INFO | 3654: exit 0 03:37:00 INFO - Browser initialized. 03:37:00 INFO - Running cycle 1/1 for dromaeo_css test... 03:37:00 INFO - TEST-INFO | started process 3739 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfNIk5y/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:37:12 INFO - PROCESS | 3739 | RSS: Main: 172044288 03:37:12 INFO - PROCESS | 3739 | 03:38:03 INFO - PROCESS | 3739 | 1477478283558 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] 03:40:14 INFO - PROCESS | 3739 | Cycle 1(1): loaded http://localhost:53273/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53273/tests/dromaeo/cssquery-ext.html) 03:40:16 INFO - PROCESS | 3739 | RSS: Main: 409808896 03:40:16 INFO - PROCESS | 3739 | 03:43:19 INFO - PROCESS | 3739 | Cycle 1(1): loaded http://localhost:53273/tests/dromaeo/cssquery-ext.html (next: http://localhost:53273/tests/dromaeo/cssquery-jquery.html) 03:43:20 INFO - PROCESS | 3739 | RSS: Main: 289353728 03:43:20 INFO - PROCESS | 3739 | 03:46:22 INFO - PROCESS | 3739 | Cycle 1(1): loaded http://localhost:53273/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53273/tests/dromaeo/cssquery-mootools.html) 03:46:22 INFO - PROCESS | 3739 | RSS: Main: 220082176 03:46:22 INFO - PROCESS | 3739 | 03:49:24 INFO - PROCESS | 3739 | Cycle 1(1): loaded http://localhost:53273/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53273/tests/dromaeo/cssquery-prototype.html) 03:49:25 INFO - PROCESS | 3739 | RSS: Main: 263483392 03:49:25 INFO - PROCESS | 3739 | 03:52:28 INFO - PROCESS | 3739 | Cycle 1(1): loaded http://localhost:53273/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53273/tests/dromaeo/cssquery-yui.html) 03:52:28 INFO - PROCESS | 3739 | RSS: Main: 220807168 03:52:28 INFO - PROCESS | 3739 | 03:55:31 INFO - PROCESS | 3739 | Cycle 1(1): loaded http://localhost:53273/tests/dromaeo/cssquery-yui.html (next: http://localhost:53273/tests/dromaeo/cssquery-dojo.html) 03:55:31 INFO - PROCESS | 3739 | RSS: Main: 318414848 03:55:31 INFO - PROCESS | 3739 | 03:55:31 INFO - PROCESS | 3739 | __start_tp_report 03:55:31 INFO - PROCESS | 3739 | _x_x_mozilla_page_load 03:55:31 INFO - PROCESS | 3739 | _x_x_mozilla_page_load_details 03:55:31 INFO - PROCESS | 3739 | |i|pagename|runs| 03:55:31 INFO - PROCESS | 3739 | |0;dojo.html;3042.5588289697994;3057.847107644617;3086.8765249390026;3099.4575949208884;3106.3166103457233;5273.683578985264;5326.62713610047;5331.3069300990865;5380.192971054344;5425.321834770659;5382.2464854920245;5389.649672771267;5399.298091248133;5413.296271484712;5417.783288668458;4876.317315575822;4894.265860120975;4920.876978075541;4934.235193544989;4961.950380496203;4979.900401991958;4985.6759310644875;5025.949740502585;5050.217216331474;5055.368078990126;5041.470645582216;5049.4193167785625;5049.873753156164;5071.746412679369;5080;5036.7229802361035;5045.041442125985;5049.924251136236;5051.772670229849;5118.38579370478;4626.907461850744;4745.596624286905;4822.324874517571;4867.51324867514;4885.340479035356;5360.865978350534;5429.321334833146;5429.429909859447;5447.101228297366;5466.699331536764;5697.6296540724725;5701.629394089371;5722.9141562876175;5799.159121927297;5913.142594323842;5828.650280983112;5844.094165404369;5847.26909136358;5848.619839710405;5853.50245229156;5222.634415590872;5262.236975638511;5354.036273470812;5441.401445840955;5449.23710680509;5900.675462849498;5919.911201331984;5958.19564358806;5958.940410595838;6021.217241758543;5654.321481422256;5688.203651488795;5699;5703.486686198179;5705.686187259657;5654.688992105392;5684.459976302244;5740.512056475246;5742.224799652077;5745.253117094751;5750.079987202028;5758.913616295759;5773.653580785166;5830.650160990354;5846.239988801429;5750.367459579443;5759.798407055733;5763.106718458645;5790.044642634002;5816.1566572846705;4312.245357062501;4323.48118225815;4453.977730111329;4471.664625153061;4517.367568540407;3922.646961773454;3939.4681717967705;3947.92104157921;3988.6210809973004;3998.3202855514633;5451.318585176853;5509;5511.641743286674;5514.476124768141;5574.637648552831;5834.620749651259;5836.299644042657;5845.386234445407;5848;5856.297244330623;5356.517913387814;5408.729563521808;5462.590305727007;5518.834434966958;5541.750621222055;5049.343585333883;5050.116229659795;5076.111680455905;5095.847124586268;5112.565431938327;5986.940130598812;6036.758529658852;6040.305364883095;6042.969785151134;6046.486048685911;5716.742746576331;5726.455986681259;5780.208135478016;5872.765089396376;5884.735186916685;5991.400859913973;5993.041113421831;6042.516598672008;6102.908456373069;6111.8777624446375;5722.456366645162;5723.055695810144;5723.198752174616;5729.140628905531;5733.31200255972;5642.774289028557;5692.402297758841;5754.424557544212;5773.047447171338;5780.710964451677;5573.637713548606;5640.097584386643;5643.576731745217;5644.717764111696;5647.491725744702;5592.524635406036;5605.467480589337;5607.271054762855;5609.971950140386;5615.438456154516;5616.073347897551;5631.155326701028;5631.267935168402;5633.63381380209;5660.490555849993;5678.4605462480995;5730.169125476866;5755.366909639853;5759.625624334405;5761.193432919311;5514.696691681996;5529.861753456195;5531.115021596686;5531.253280807039;5538.556915446674 03:55:31 INFO - PROCESS | 3739 | |1;ext.html;582.1297160744688;608.817354793562;611.8562137897593;614.1555361378105;635.8219698484423;30032.549511757315;33789.1552711182;33941.15147121317;34000.31999360015;42801.35797963033;42001.36997945033;46061;46064.309035364495;46106.769466152626;46204;8821.117888211176;8940.597673104694;8947.865782013276;8960.103989601053;8980.057094005133;8030.678772849079;8230.382721295897;8889.066648001964;8985.640574377017;8987.101289870994;8216.794580135514;8265.95867020664;10488.632897848576;10844.295120817122;10846.29499082561;10643.254972151952;10808.297460665031;10819;10819.459027048695;10822;10608.469576521144;10659.147268218523;10680.412577308245;10680.78638427227;10682.359058456517;41644.583554164376;41711.1657766846;41785.79107104445;42003.789981050206;42034.369484457755;3371.814550199738;3516.191276006533;3609.9458508122398;3830.9616903830884;3839.1361943562756;30460.695393046008;30630.234244143852;31448;31604.841975790205;31718.841405793053;4236.279832428495;4306.80619372129;4471.955280447187;4488.438945131858;4519.751413672247;330260;333781;334835;335682;335874.99999999756;57013;57363.42636573581;57396.42603573911;57422.71288643614;57436.425635743944;59504;59707.40292597105;59925.700371497864;60068.399316007155;60183.398166018655;15359.539213823604;15552;15578.9221053894;15614.29735661898;15702.842971570139;11731.76536469266;11762.176647634755;11769.293842369485;11770.176087673952;11774.234674746114;14623.122612643063;14970.40118395252;15092.471763488225;16044.636205922627;16656.08391538477;5760.683162426023;5955.34491205967;6037.396260373927;6090.786822461193;6130.908036379458;884.2748945864458;951.3198063384575;989.2877128467492;1044.5821671331375;1125.774845030997;31783.56753116856;31885.20286992844;32012.679873201436;32145.678543214268;32435.837820810746;1012.2205901455985;1043.5773511727762;1099.5272033025876;1101.5869049106584;1138.2942575603179;16042;16971.915140424466;16973.575660608585;16988.660226795393;16995.660086798194;517428;521974;522545;522694;522847;50512;51288.74355628272;56713.716431417575;58050.419495804505;58139.418605814244;1246.9314187719763;1251.0679543739973;1272.7200015996466;1284.5825106840127;1286.4339690536322;30677;33588.496172556945;33687.66312336845;33894.491582625786;34080.829595851865;50537.24194137017;51107.2333914999;51112;51113;51122.74438627783;449961;507276;517485;519746;522148;27036.324091897073;27312.59031114495;27433.725662743116;27772.583411249252;27807;47103.76448117737;47243;47835.521644783104;48081.519184809105;49190.50809492003;39288;39666.40500392439;39954.80022599868;40650.390244146955;41527.1694566113;39723.40414893837;39741.40387894126;40187.59812401838;40810.79594602008;41433.79283103565;40860.387094193014;40976.59023409847;42304;42350.788246058575;42495.78752106219;33531;36371.81814090913;36725.81637091797;37203.25593488061;37461.81269093637;27868.721312786613;28052.438951220454;28309.15072547827;28578.285542861595;28631 03:55:31 INFO - PROCESS | 3739 | |2;jquery.html;365.78235949609973;366.6590071233753;391.80801407310406;397.3265315290583;408.5954904644403;14144;15476.613084672888;18571.535711607215;19134.52163695908;19142.23431062759;15210.315535800888;15335.233238338094;15356.385744570203;15462.458813941514;15480.380784768624;4157.979210103946;5523.088690366085;5755.65466072037;5764.048931926227;5764.481196692297;4279.229738647043;6091.329953705089;6346;6440.581362211465;6542.50931180161;6264.686765661721;6417.26201486828;6463.159789227418;6492.772752953648;6501.7724379646725;6415.4546863516425;6442.645654489002;6449.419552240297;6456.7740129095255;6457.483401327906;5482.396936337;5639.436056394369;5688.4311568843195;5694.316681998187;5695.629784064064;22670.319890403316;22962.77037229623;23269.06923723049;23325;23515.882420587957;2149.6560550312033;2285.8171346292256;2320.93037208884;2534.4677617700304;2768.806183567151;9740.269479789044;10297.279190456671;10320.690379288633;10333.431661258628;13954.93022534891;1836.366453573515;1908.8186622270862;1919.2227148005081;1938.176275083098;1950.2296592845746;84853.57573212156;86788.24599818046;87301.56349218213;88554;90352.5482372584;10632.468376581295;10840.620578279722;10850.171673605328;10857.185711071543;10940.671779846618;14947.252637368305;14974.700505989818;15081.924590376977;15111.395544178109;15151.848481515044;7599.058628498629;7878.684852605947;7989.241022102891;8096.7166149184495;8109;6718.428933540606;6864.553804002724;7036.401905838061;7047.823804404931;7052;4514.977425112854;4554.385158003627;4558.635309175258;4724.102420540086;4781.665283430196;1831.8259765322273;1943.407260785474;1973.9506512337018;1978.0999645161417;1978.871373360727;812.8536863364533;841.8568843296654;956;1004.1163775877181;1056.5087234436023;18100.818991809912;18917;18980.905095474434;19212.903935480233;19513.414597562096;973.9172170365598;977.9462129582942;982.0964712464549;986.4623780039896;989.2086330935223;10121.69634910954;10804.783904322027;10830.729231769268;10840.349579025284;10893.346399215914;452052;467641;471410;473689;482300;90313;92262.53868730614;92764.53617731867;92926;93288;944.6740874398322;960.7550074730899;962.5764663548016;964.6864768950119;970.2819913264134;16204.136524299385;16776.916115419346;17268;17380.21789019472;17634.82365176332;40568.79715601403;40971;41006.1798764029;41897.58102418937;42729;58918.70540647269;58984.70507647434;60087.39912600818;60115.39884601098;60442;8451.154884511745;8491.108433614629;8528.403011789364;8659.393842430969;8913.153250441197;11479.827802583135;12475.75048499043;12569;13031.218126912416;13046.282454464716;11031.779364412507;11160.274582152135;11520.596779112691;11826.113041522092;11919.463624137108;10754.784904301714;11292.7741445169;11369.43152842338;11392.145589080686;11893.345865977455;11169.441527923735;11259.437028148724;11359.54561817518;11404;11601.883981160081;8349.206825351583;8418.95790521068;8618.827623447622;8681.956590217262;8772.605232764668;11332.886671133183;11695.473703683525;11698.94150529242;11743.471543780379;12207 03:55:31 INFO - PROCESS | 3739 | |3;mootools.html;1460.6567456647686;1497.6779992301654;1598.4964736108125;1733.6706025855078;1781.27858217422;8233.053198882131;8753.693620723276;8783.297336213103;8786.12138786121;8787.824243515133;7544.962275188616;7739.419543534229;8347.707830225943;8572.271356934669;8590.055093939662;2278.977210227897;2299.5630830142304;2302.5164715409783;2304.942376440594;2314.271004633535;2316.085146367184;2341.4146463384154;2380.1074597026113;2384.3204686664303;2384.9046038158453;2277.350954977832;2282.6918366020623;2299.908003679851;2308.145985985188;2310.3069079276233;2222;2222.111155537798;2233.7207849018873;2236.4185311818965;2240.9439764005865;2211.9557608847895;2240.451089483087;2242.6972358731527;2262.049939025597;2271.8636881787147;8791.252743516809;8793.692220772306;8831.3376496763;8843.734687959372;8858.911410885938;5103.719295438749;5221.765020574083;5231.058409486291;5233.241180028875;5233.764480598345;2994.6107006089287;3082.568440418343;3272.198311413695;3273.9508907366408;3288.030031140819;1046.4819914142547;1057.6774083904406;1068.4016950507742;1073.5276478349579;1098.758273179899;11979.221350612183;11989.880101198964;12096.153269271155;12131;12167.878321216764;4406.20688276107;4585.151746926829;4650.813967441332;4659.277811939155;4686.554777296152;10399.688009359732;10400.635977740743;10408.583656653649;10413.843792343121;10413.947930260452;5317.335333083364;5323.387810401776;5328.946710532845;5331.067063263913;5334.51989320963;4263.5096963849555;4282.164977829356;4767.523247675204;4850.83022094225;4875.341828853059;3744.7004239661305;3854.6530812226474;3869.129445874712;3948.980255098706;3961.782101984361;1208.250884451628;1218.2081646929566;1226.3439060102803;1253.5173958026044;1254.3978890132787;787.4330482053027;837.7151768398652;846.9703560375481;871.9825603487894;948.2650945517279;5296.179092240709;5467.726613669301;5622.465865742748;5653.830385088454;5692;850.3834719828199;867.9392442528963;884.8186121845006;885.1590988560764;936.134075979716;3503.964960350364;3640.5631324241263;3693.242885208526;3712.7029837612927;3725.5529336479253;10683;11143.052840508486;11151.05216056628;11153.10775137987;11155.944220279009;10973.177011723992;10992.395418252074;11008.779824403628;11018.889811101786;11076.058535024453;7943.4042446815565;8174.3460523158;8210.630521626661;8322.375821813388;8327.791805204797;5307.52232299095;5447.836564903059;5519.751611177587;5531.612787104864;5597.608167428241;9699.951500242454;9913.801723965624;9916.752081198028;10018.048285412875;10034.397936123563;10054.095131438205;10147.695569132939;10148.137408320375;10246.590136394461;10302.278840481094;7010.719571217094;7116.3951064158055;7580.658870350958;7616.771496855104;7761.18507556721;8414.116517765546;8689.391742577958;8713.956430217808;8748.475091494276;8760.080191579793;7622.3521000713345;7679.961600192187;7701.691932322644;7837.216278372117;7951.284384405431;7636.350910172475;7684.6157692116285;7748.573828439265;7813.648385822766;7931.246531579491;7035.33164349386;7065.540739851893;7137.464690148156;7138.928610714034;7148.142222933281;4655.4180727409075;4689.249720044776;4749.335093087039;4879.512048795092;5070.2394640802695;4813.807447702053;4866.562009419169;4884.584810291023;4983.152864013199;4986.675866068694 03:55:31 INFO - PROCESS | 3739 | |4;prototype.html;328.5302018114096;334.7305419137594;340.83810190159676;341.83093819138554;345.41107411862777;5124.8975020499565;5223.850752834375;5240.737963101848;5313.89372212556;5341.919871201935;5099.133147364948;5170.715610641413;5176.912848301852;5213.661112027725;5231.189165679316;4131.73143745657;4132.5040995080635;4133.875983720493;4147.979260103695;4152.73007254529;3907.941380879289;4083.9183216335655;4137.13120244749;4147.917041659165;4159.481789146955;4049.9392509112386;4064.9390259146135;4067.4712287402594;4068.125353049094;4084.8978775530554;4016.6786657067655;4037.1118353962374;4040.2525532776235;4046.1300820323627;4067.2882245607047;3543.4330507118993;3543.94684079739;3551.94672079919;3573.87491437801;3597.8740744074094;5073;5115.360579927509;5125.308083408767;5125.871853203663;5129.897402051975;4657.417822772153;4664.277037059262;4669.696469729491;4683.836065737717;4692.366530518405;5439.728013599304;5460.6177567570285;5461.18082287656;5461.399246082928;5483.287172667528;3845.384738441836;3846.2499812536566;3880.844766209348;3881.913064341989;3896.376579747227;5607.439256074401;5655.519280861132;5665.716714164275;5671.886562268732;5682.431756824284;4036.495438070241;4038.273110840077;4040.8585699500377;4053.7365071270274;4081.428599996003;4029.3351596986167;4070.9796451017555;4082.2856000199845;4104.753714777123;4138.337865941435;4649.418822647169;4661.790219440133;4666.393368862026;4667.906641867144;4672.761718144694;5489.368722596872;5492.780288788404;5496.560275178056;5500.339959204921;5567.582431317667;1340.2561578324123;1340.8200783310624;1365.3582816076428;1369.5617402431326;1386.895982801294;843.9367047471342;880.7137680253815;895.820835832823;900.7883147460342;905.2667339455063;4651.511591282934;4678.081986385566;4683.250679891201;4689.577937985529;4691.483936766953;4902.7988142905215;4923.310736496894;4924.227278179852;4936.827211047596;4942.728149951788;4622.214223581999;4648.44277167146;4653.7207767534055;4669.649776266793;4680.4149481314835;2788.2852045991567;2996.1760515858314;3013.141254742388;3017.879284828582;3033.5449682547796;5790.334111577223;5795.1886735857015;5804.506616937608;5809.854753631109;5818.44724751148;5548.306461692288;5716.971415142898;5732.165706973812;5802.750459742558;5808.419158084243;5729.455701708331;5758.1362795581;5758.452946970031;5758.712064396764;5797.391273916262;5634.295713035871;5657.349404818334;5667.801626943037;5674;5679.602427830012;5390.649607775482;5586.720663966867;5594.545418191218;5602.943970560243;5612;5803.158542011469;5813.447722466359;5817.127430885401;5824.883502329845;5865.208196893535;3980.582038885875;4059.6955228358584;4079.9184016318914;4085.080012394289;4110.815013324348;5345.995251780582;5612.5509959202345;5628.859278517906;5635.577331700057;5661.348944871393;5299.443558426464;5383.711922433029;5467.39858615544;5481.3970463248215;5514.255575497417;5424.83725488236;5476.616636835383;5504.431322002648;5507.807226747044;5511.917321240265;5320.627556071193;5458.153986132156;5465.016297066566;5497.8075767347955;5512.5589952802875;5526.944730552643;5552.722363881709;5559.749811258423;5586.011483856118;5594.272744543347;5458.3897750163005;5464.808731694372;5483.972580137074;5487.945120548743;5496.6701997880255 03:55:31 INFO - PROCESS | 3739 | |5;yui.html;727.5198369076411;766.3600893254132;771.1324759645399;777.5218240781918;815.5473712089791;12308.19996700215;12666.683332916682;12686.746265074693;12726.68183295418;12772.105952583312;12596.118271720983;12747.490100395997;12806.871931280684;12809.117948461591;12830.871691283084;780.9062912450514;790.6007466229546;794.7655441644729;795.5187111797366;795.7016118955391;783.478986473997;785.1245860865151;785.681798871458;785.9410544209179;786.2844811221789;822.3667775812621;822.9094799572042;824.0646865807322;824.3981893217955;824.4517395931698;816.3550794872015;817.7955511122219;818.2840014986887;818.5907046476761;818.6561644109458;604.5375287904757;605.1830029460193;605.279717136606;605.2948315212772;605.3220393159689;11883.405829708567;11989.400529973467;12016.218945768585;12022.218555793845;12758.489660413572;11322.32066076038;11889.643310700692;12250.44872980709;12323.260604363766;12359.567415140516;11649.883501164964;11924.10569207313;12021.459034343388;12023.278603283743;12614.180078294974;4289.892752681208;4331.631811296043;4379.846705365297;4385.2106620808245;4523.864284071483;65698.67150664264;67255.66372168157;67485.66257168683;67832.32167678358;68875;10290.639827606148;10336.379817210842;10452.268341216193;10488.108510776518;10649.094826939641;18245.7263141053;18449.53876153107;18656.253749849853;18703.532411689543;18988.715169272473;7525.36034437079;7561.09266887977;7596.08846938371;7636.3890888728765;7653.885191722128;4198.454200953856;4366.781660916941;4420.646348292129;4476.552344765562;4585.426821647294;3231.6929891660725;3328.417526932777;3350.447176215946;3559.750817442806;3761.153740408386;645.6255371884296;650.222983534681;650.278191207759;662.3707477895922;664.9335066493409;578.2887048929756;599.3856297295307;677.9795613482074;680.4138026800027;687.4328678839977;8823.867641985375;9262.259019278576;9479.336446448682;9554.187894028946;9556.95221523888;564.2692712936757;566.303446760487;574.5776854012298;694.4236283884364;697.0589703899797;4255.319148936155;4436.423264975597;4482;4589.154982007693;4628.39830821991;52352;53161.7341913288;53296.46703532915;53466;71732.2826771736;46065;46215.76892115518;64590.35409645843;70305.64847175732;71538;62324.15840990288;64655;64731;64841.67579162074;65407.34592654108;8771.780705482413;9231.446113232958;9269.86095208559;9336.758268784552;9376.156145946898;42114.57885421229;43659.345109822745;44166;44331.77834110809;44757.55242447664;55511;60501.69749151226;60719.69640151771;61674.69162654158;63735;11673.416329183678;11831.467583958914;12097.879021209676;12110.878891210976;12628.494860205488;13209.273489958145;13355;13752.724945501233;13909.930450347683;14085.295735213404;12045.33750643688;12229.449674764835;12512.124151309321;12967.157134786208;13187.208767473981;12616.36918154107;12676.683082923;12687.555935542581;12724.427400766803;13507.932460337635;12186.939065304618;12223.449944752685;12492.437840297027;12649.87350126487;12861.614151575468;9842.311038227255;10180.338278011906;10218.795624087625;10248.436336001592;10285.897141028794;8802.471851688919;9056.909430905607;9122.390323739763;9957.950210248902;10017 03:55:31 INFO - PROCESS | 3739 | __end_tp_report 03:55:31 INFO - PROCESS | 3739 | __start_cc_report 03:55:31 INFO - PROCESS | 3739 | _x_x_mozilla_cycle_collect,2594 03:55:31 INFO - PROCESS | 3739 | __end_cc_report 03:55:31 INFO - PROCESS | 3739 | __startTimestamp1477479331862__endTimestamp 03:55:31 INFO - PROCESS | 3739 | 03:55:31 INFO - PROCESS | 3739 | ------- Summary: start ------- 03:55:31 INFO - PROCESS | 3739 | Number of tests: 6 03:55:31 INFO - PROCESS | 3739 | 03:55:31 INFO - PROCESS | 3739 | [#0] dojo.html Cycles:165 Average:5385.20 Median:5605.47 stddev:614.39 (11.0%) stddev-sans-first:588.14 03:55:31 INFO - PROCESS | 3739 | Values: 3042.6 3057.8 3086.9 3099.5 3106.3 5273.7 5326.6 5331.3 5380.2 5425.3 5382.2 5389.6 5399.3 5413.3 5417.8 4876.3 4894.3 4920.9 4934.2 4962.0 4979.9 4985.7 5025.9 5050.2 5055.4 5041.5 5049.4 5049.9 5071.7 5080.0 5036.7 5045.0 5049.9 5051.8 5118.4 4626.9 4745.6 4822.3 4867.5 4885.3 5360.9 5429.3 5429.4 5447.1 5466.7 5697.6 5701.6 5722.9 5799.2 5913.1 5828.7 5844.1 5847.3 5848.6 5853.5 5222.6 5262.2 5354.0 5441.4 5449.2 5900.7 5919.9 5958.2 5958.9 6021.2 5654.3 5688.2 5699.0 5703.5 5705.7 5654.7 5684.5 5740.5 5742.2 5745.3 5750.1 5758.9 5773.7 5830.7 5846.2 5750.4 5759.8 5763.1 5790.0 5816.2 4312.2 4323.5 4454.0 4471.7 4517.4 3922.6 3939.5 3947.9 3988.6 3998.3 5451.3 5509.0 5511.6 5514.5 5574.6 5834.6 5836.3 5845.4 5848.0 5856.3 5356.5 5408.7 5462.6 5518.8 5541.8 5049.3 5050.1 5076.1 5095.8 5112.6 5986.9 6036.8 6040.3 6043.0 6046.5 5716.7 5726.5 5780.2 5872.8 5884.7 5991.4 5993.0 6042.5 6102.9 6111.9 5722.5 5723.1 5723.2 5729.1 5733.3 5642.8 5692.4 5754.4 5773.0 5780.7 5573.6 5640.1 5643.6 5644.7 5647.5 5592.5 5605.5 5607.3 5610.0 5615.4 5616.1 5631.2 5631.3 5633.6 5660.5 5678.5 5730.2 5755.4 5759.6 5761.2 5514.7 5529.9 5531.1 5531.3 5538.6 03:55:31 INFO - PROCESS | 3739 | 03:55:31 INFO - PROCESS | 3739 | [#1] ext.html Cycles:180 Average:60808.86 Median:39694.90 stddev:122451.66 (308.5%) stddev-sans-first:122711.67 03:55:31 INFO - PROCESS | 3739 | Values: 582.1 608.8 611.9 614.2 635.8 30032.5 33789.2 33941.2 34000.3 42801.4 42001.4 46061.0 46064.3 46106.8 46204.0 8821.1 8940.6 8947.9 8960.1 8980.1 8030.7 8230.4 8889.1 8985.6 8987.1 8216.8 8266.0 10488.6 10844.3 10846.3 10643.3 10808.3 10819.0 10819.5 10822.0 10608.5 10659.1 10680.4 10680.8 10682.4 41644.6 41711.2 41785.8 42003.8 42034.4 3371.8 3516.2 3609.9 3831.0 3839.1 30460.7 30630.2 31448.0 31604.8 31718.8 4236.3 4306.8 4472.0 4488.4 4519.8 330260.0 333781.0 334835.0 335682.0 335875.0 57013.0 57363.4 57396.4 57422.7 57436.4 59504.0 59707.4 59925.7 60068.4 60183.4 15359.5 15552.0 15578.9 15614.3 15702.8 11731.8 11762.2 11769.3 11770.2 11774.2 14623.1 14970.4 15092.5 16044.6 16656.1 5760.7 5955.3 6037.4 6090.8 6130.9 884.3 951.3 989.3 1044.6 1125.8 31783.6 31885.2 32012.7 32145.7 32435.8 1012.2 1043.6 1099.5 1101.6 1138.3 16042.0 16971.9 16973.6 16988.7 16995.7 517428.0 521974.0 522545.0 522694.0 522847.0 50512.0 51288.7 56713.7 58050.4 58139.4 1246.9 1251.1 1272.7 1284.6 1286.4 30677.0 33588.5 33687.7 33894.5 34080.8 50537.2 51107.2 51112.0 51113.0 51122.7 449961.0 507276.0 517485.0 519746.0 522148.0 27036.3 27312.6 27433.7 27772.6 27807.0 47103.8 47243.0 47835.5 48081.5 49190.5 39288.0 39666.4 39954.8 40650.4 41527.2 39723.4 39741.4 40187.6 40810.8 41433.8 40860.4 40976.6 42304.0 42350.8 42495.8 33531.0 36371.8 36725.8 37203.3 37461.8 27868.7 28052.4 28309.2 28578.3 28631.0 03:55:31 INFO - PROCESS | 3739 | 03:55:31 INFO - PROCESS | 3739 | [#2] jquery.html Cycles:180 Average:28451.63 Median:20488.70 stddev:77721.57 (379.3%) stddev-sans-first:77910.99 03:55:31 INFO - PROCESS | 3739 | Values: 365.8 366.7 391.8 397.3 408.6 14144.0 15476.6 18571.5 19134.5 19142.2 15210.3 15335.2 15356.4 15462.5 15480.4 4158.0 5523.1 5755.7 5764.0 5764.5 4279.2 6091.3 6346.0 6440.6 6542.5 6264.7 6417.3 6463.2 6492.8 6501.8 6415.5 6442.6 6449.4 6456.8 6457.5 5482.4 5639.4 5688.4 5694.3 5695.6 22670.3 22962.8 23269.1 23325.0 23515.9 2149.7 2285.8 2320.9 2534.5 2768.8 9740.3 10297.3 10320.7 10333.4 13954.9 1836.4 1908.8 1919.2 1938.2 1950.2 84853.6 86788.2 87301.6 88554.0 90352.5 10632.5 10840.6 10850.2 10857.2 10940.7 14947.3 14974.7 15081.9 15111.4 15151.8 7599.1 7878.7 7989.2 8096.7 8109.0 6718.4 6864.6 7036.4 7047.8 7052.0 4515.0 4554.4 4558.6 4724.1 4781.7 1831.8 1943.4 1974.0 1978.1 1978.9 812.9 841.9 956.0 1004.1 1056.5 18100.8 18917.0 18980.9 19212.9 19513.4 973.9 977.9 982.1 986.5 989.2 10121.7 10804.8 10830.7 10840.3 10893.3 452052.0 467641.0 471410.0 473689.0 482300.0 90313.0 92262.5 92764.5 92926.0 93288.0 944.7 960.8 962.6 964.7 970.3 16204.1 16776.9 17268.0 17380.2 17634.8 40568.8 40971.0 41006.2 41897.6 42729.0 58918.7 58984.7 60087.4 60115.4 60442.0 8451.2 8491.1 8528.4 8659.4 8913.2 11479.8 12475.8 12569.0 13031.2 13046.3 11031.8 11160.3 11520.6 11826.1 11919.5 10754.8 11292.8 11369.4 11392.1 11893.3 11169.4 11259.4 11359.5 11404.0 11601.9 8349.2 8419.0 8618.8 8682.0 8772.6 11332.9 11695.5 11698.9 11743.5 12207.0 03:55:31 INFO - PROCESS | 3739 | 03:55:31 INFO - PROCESS | 3739 | [#3] mootools.html Cycles:180 Average:5708.05 Median:4719.29 stddev:3310.64 (70.2%) stddev-sans-first:3304.54 03:55:31 INFO - PROCESS | 3739 | Values: 1460.7 1497.7 1598.5 1733.7 1781.3 8233.1 8753.7 8783.3 8786.1 8787.8 7545.0 7739.4 8347.7 8572.3 8590.1 2279.0 2299.6 2302.5 2304.9 2314.3 2316.1 2341.4 2380.1 2384.3 2384.9 2277.4 2282.7 2299.9 2308.1 2310.3 2222.0 2222.1 2233.7 2236.4 2240.9 2212.0 2240.5 2242.7 2262.0 2271.9 8791.3 8793.7 8831.3 8843.7 8858.9 5103.7 5221.8 5231.1 5233.2 5233.8 2994.6 3082.6 3272.2 3274.0 3288.0 1046.5 1057.7 1068.4 1073.5 1098.8 11979.2 11989.9 12096.2 12131.0 12167.9 4406.2 4585.2 4650.8 4659.3 4686.6 10399.7 10400.6 10408.6 10413.8 10413.9 5317.3 5323.4 5328.9 5331.1 5334.5 4263.5 4282.2 4767.5 4850.8 4875.3 3744.7 3854.7 3869.1 3949.0 3961.8 1208.3 1218.2 1226.3 1253.5 1254.4 787.4 837.7 847.0 872.0 948.3 5296.2 5467.7 5622.5 5653.8 5692.0 850.4 867.9 884.8 885.2 936.1 3504.0 3640.6 3693.2 3712.7 3725.6 10683.0 11143.1 11151.1 11153.1 11155.9 10973.2 10992.4 11008.8 11018.9 11076.1 7943.4 8174.3 8210.6 8322.4 8327.8 5307.5 5447.8 5519.8 5531.6 5597.6 9700.0 9913.8 9916.8 10018.0 10034.4 10054.1 10147.7 10148.1 10246.6 10302.3 7010.7 7116.4 7580.7 7616.8 7761.2 8414.1 8689.4 8714.0 8748.5 8760.1 7622.4 7680.0 7701.7 7837.2 7951.3 7636.4 7684.6 7748.6 7813.6 7931.2 7035.3 7065.5 7137.5 7138.9 7148.1 4655.4 4689.2 4749.3 4879.5 5070.2 4813.8 4866.6 4884.6 4983.2 4986.7 03:55:31 INFO - PROCESS | 3739 | 03:55:31 INFO - PROCESS | 3739 | [#4] prototype.html Cycles:180 Average:4572.24 Median:5127.88 stddev:1347.22 (26.3%) stddev-sans-first:1312.81 03:55:31 INFO - PROCESS | 3739 | Values: 328.5 334.7 340.8 341.8 345.4 5124.9 5223.9 5240.7 5313.9 5341.9 5099.1 5170.7 5176.9 5213.7 5231.2 4131.7 4132.5 4133.9 4148.0 4152.7 3907.9 4083.9 4137.1 4147.9 4159.5 4049.9 4064.9 4067.5 4068.1 4084.9 4016.7 4037.1 4040.3 4046.1 4067.3 3543.4 3543.9 3551.9 3573.9 3597.9 5073.0 5115.4 5125.3 5125.9 5129.9 4657.4 4664.3 4669.7 4683.8 4692.4 5439.7 5460.6 5461.2 5461.4 5483.3 3845.4 3846.2 3880.8 3881.9 3896.4 5607.4 5655.5 5665.7 5671.9 5682.4 4036.5 4038.3 4040.9 4053.7 4081.4 4029.3 4071.0 4082.3 4104.8 4138.3 4649.4 4661.8 4666.4 4667.9 4672.8 5489.4 5492.8 5496.6 5500.3 5567.6 1340.3 1340.8 1365.4 1369.6 1386.9 843.9 880.7 895.8 900.8 905.3 4651.5 4678.1 4683.3 4689.6 4691.5 4902.8 4923.3 4924.2 4936.8 4942.7 4622.2 4648.4 4653.7 4669.6 4680.4 2788.3 2996.2 3013.1 3017.9 3033.5 5790.3 5795.2 5804.5 5809.9 5818.4 5548.3 5717.0 5732.2 5802.8 5808.4 5729.5 5758.1 5758.5 5758.7 5797.4 5634.3 5657.3 5667.8 5674.0 5679.6 5390.6 5586.7 5594.5 5602.9 5612.0 5803.2 5813.4 5817.1 5824.9 5865.2 3980.6 4059.7 4079.9 4085.1 4110.8 5346.0 5612.6 5628.9 5635.6 5661.3 5299.4 5383.7 5467.4 5481.4 5514.3 5424.8 5476.6 5504.4 5507.8 5511.9 5320.6 5458.2 5465.0 5497.8 5512.6 5526.9 5552.7 5559.7 5586.0 5594.3 5458.4 5464.8 5484.0 5487.9 5496.7 03:55:31 INFO - PROCESS | 3739 | 03:55:31 INFO - PROCESS | 3739 | [#5] yui.html Cycles:180 Average:15994.45 Median:25422.08 stddev:20172.88 (79.4%) stddev-sans-first:20196.90 03:55:31 INFO - PROCESS | 3739 | Values: 727.5 766.4 771.1 777.5 815.5 12308.2 12666.7 12686.7 12726.7 12772.1 12596.1 12747.5 12806.9 12809.1 12830.9 780.9 790.6 794.8 795.5 795.7 783.5 785.1 785.7 785.9 786.3 822.4 822.9 824.1 824.4 824.5 816.4 817.8 818.3 818.6 818.7 604.5 605.2 605.3 605.3 605.3 11883.4 11989.4 12016.2 12022.2 12758.5 11322.3 11889.6 12250.4 12323.3 12359.6 11649.9 11924.1 12021.5 12023.3 12614.2 4289.9 4331.6 4379.8 4385.2 4523.9 65698.7 67255.7 67485.7 67832.3 68875.0 10290.6 10336.4 10452.3 10488.1 10649.1 18245.7 18449.5 18656.3 18703.5 18988.7 7525.4 7561.1 7596.1 7636.4 7653.9 4198.5 4366.8 4420.6 4476.6 4585.4 3231.7 3328.4 3350.4 3559.8 3761.2 645.6 650.2 650.3 662.4 664.9 578.3 599.4 678.0 680.4 687.4 8823.9 9262.3 9479.3 9554.2 9557.0 564.3 566.3 574.6 694.4 697.1 4255.3 4436.4 4482.0 4589.2 4628.4 52352.0 53161.7 53296.5 53466.0 71732.3 46065.0 46215.8 64590.4 70305.6 71538.0 62324.2 64655.0 64731.0 64841.7 65407.3 8771.8 9231.4 9269.9 9336.8 9376.2 42114.6 43659.3 44166.0 44331.8 44757.6 55511.0 60501.7 60719.7 61674.7 63735.0 11673.4 11831.5 12097.9 12110.9 12628.5 13209.3 13355.0 13752.7 13909.9 14085.3 12045.3 12229.4 12512.1 12967.2 13187.2 12616.4 12676.7 12687.6 12724.4 13507.9 12186.9 12223.4 12492.4 12649.9 12861.6 9842.3 10180.3 10218.8 10248.4 10285.9 8802.5 9056.9 9122.4 9958.0 10017.0 03:55:31 INFO - PROCESS | 3739 | -------- Summary: end -------- 03:55:31 INFO - PROCESS | 3739 | 03:55:32 INFO - TEST-INFO | 3739: exit 0 03:55:32 INFO - TEST-OK | dromaeo_css | took 1118726ms 03:55:32 INFO - TEST-START | kraken 03:55:32 INFO - operating with platform_type : linux_ 03:55:32 INFO - Initialising browser for kraken test... 03:55:32 INFO - TEST-INFO | started process 4047 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFRv4B9/profile http://localhost:53273/getInfo.html) 03:55:36 INFO - PROCESS | 4047 | __metrics Screen width/height:1600/1200 03:55:36 INFO - PROCESS | 4047 | colorDepth:24 03:55:36 INFO - PROCESS | 4047 | Browser inner width/height: 1024/697 03:55:36 INFO - PROCESS | 4047 | __metrics 03:55:37 INFO - PROCESS | 4047 | 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" 03:55:37 INFO - PROCESS | 4047 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:55:38 INFO - PROCESS | 4047 | console.error: PushService: 03:55:38 INFO - PROCESS | 4047 | stateChangeProcessEnqueue: Error transitioning state 03:55:38 INFO - PROCESS | 4047 | UnknownError 03:55:38 INFO - TEST-INFO | 4047: exit 0 03:55:38 INFO - Browser initialized. 03:55:38 INFO - Running cycle 1/1 for kraken test... 03:55:38 INFO - TEST-INFO | started process 4132 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFRv4B9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:55:50 INFO - PROCESS | 4132 | RSS: Main: 172335104 03:55:50 INFO - PROCESS | 4132 | 03:55:53 INFO - PROCESS | 4132 | Cycle 1(1): loaded http://localhost:53273/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53273/tests/kraken/driver.html?testName=audio-beat-detection) 03:55:54 INFO - PROCESS | 4132 | RSS: Main: 228868096 03:55:54 INFO - PROCESS | 4132 | 03:55:56 INFO - PROCESS | 4132 | Cycle 1(1): loaded http://localhost:53273/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53273/tests/kraken/driver.html?testName=audio-dft) 03:55:57 INFO - PROCESS | 4132 | RSS: Main: 215560192 03:55:57 INFO - PROCESS | 4132 | 03:56:00 INFO - PROCESS | 4132 | Cycle 1(1): loaded http://localhost:53273/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53273/tests/kraken/driver.html?testName=audio-fft) 03:56:01 INFO - PROCESS | 4132 | RSS: Main: 297304064 03:56:01 INFO - PROCESS | 4132 | 03:56:03 INFO - PROCESS | 4132 | Cycle 1(1): loaded http://localhost:53273/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53273/tests/kraken/driver.html?testName=audio-oscillator) 03:56:03 INFO - PROCESS | 4132 | RSS: Main: 208506880 03:56:03 INFO - PROCESS | 4132 | 03:56:06 INFO - PROCESS | 4132 | Cycle 1(1): loaded http://localhost:53273/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53273/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:56:06 INFO - PROCESS | 4132 | RSS: Main: 211640320 03:56:06 INFO - PROCESS | 4132 | 03:56:09 INFO - PROCESS | 4132 | Cycle 1(1): loaded http://localhost:53273/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53273/tests/kraken/driver.html?testName=imaging-darkroom) 03:56:10 INFO - PROCESS | 4132 | RSS: Main: 248020992 03:56:10 INFO - PROCESS | 4132 | 03:56:13 INFO - PROCESS | 4132 | Cycle 1(1): loaded http://localhost:53273/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53273/tests/kraken/driver.html?testName=imaging-desaturate) 03:56:14 INFO - PROCESS | 4132 | RSS: Main: 247201792 03:56:14 INFO - PROCESS | 4132 | 03:56:16 INFO - PROCESS | 4132 | Cycle 1(1): loaded http://localhost:53273/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53273/tests/kraken/driver.html?testName=json-parse-financial) 03:56:17 INFO - PROCESS | 4132 | RSS: Main: 246054912 03:56:17 INFO - PROCESS | 4132 | 03:56:18 INFO - PROCESS | 4132 | Cycle 1(1): loaded http://localhost:53273/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53273/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:56:19 INFO - PROCESS | 4132 | RSS: Main: 208535552 03:56:19 INFO - PROCESS | 4132 | 03:56:21 INFO - PROCESS | 4132 | Cycle 1(1): loaded http://localhost:53273/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53273/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:56:21 INFO - PROCESS | 4132 | RSS: Main: 215654400 03:56:21 INFO - PROCESS | 4132 | 03:56:23 INFO - PROCESS | 4132 | Cycle 1(1): loaded http://localhost:53273/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53273/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:56:24 INFO - PROCESS | 4132 | RSS: Main: 225685504 03:56:24 INFO - PROCESS | 4132 | 03:56:27 INFO - PROCESS | 4132 | Cycle 1(1): loaded http://localhost:53273/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53273/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:56:27 INFO - PROCESS | 4132 | RSS: Main: 231067648 03:56:27 INFO - PROCESS | 4132 | 03:56:30 INFO - PROCESS | 4132 | Cycle 1(1): loaded http://localhost:53273/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53273/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:56:31 INFO - PROCESS | 4132 | RSS: Main: 231567360 03:56:31 INFO - PROCESS | 4132 | 03:56:33 INFO - PROCESS | 4132 | Cycle 1(1): loaded http://localhost:53273/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53273/tests/kraken/driver.html?testName=ai-astar) 03:56:33 INFO - PROCESS | 4132 | RSS: Main: 280924160 03:56:33 INFO - PROCESS | 4132 | 03:56:33 INFO - PROCESS | 4132 | __start_tp_report 03:56:33 INFO - PROCESS | 4132 | _x_x_mozilla_page_load 03:56:33 INFO - PROCESS | 4132 | _x_x_mozilla_page_load_details 03:56:33 INFO - PROCESS | 4132 | |i|pagename|runs| 03:56:33 INFO - PROCESS | 4132 | |0;ai-astar;107;111;109;110;110;110;111;110;109;111 03:56:33 INFO - PROCESS | 4132 | |1;audio-beat-detection;150;125;126;165;125;123;120;121;157;124 03:56:33 INFO - PROCESS | 4132 | |2;audio-dft;162;162;161;162;162;163;162;163;162;161 03:56:33 INFO - PROCESS | 4132 | |3;audio-fft;76;76;83;118;76;75;76;76;99;75 03:56:33 INFO - PROCESS | 4132 | |4;audio-oscillator;82;81;111;82;82;82;109;82;81;120 03:56:33 INFO - PROCESS | 4132 | |5;imaging-gaussian-blur;116;117;116;116;117;117;117;117;116;117 03:56:33 INFO - PROCESS | 4132 | |6;imaging-darkroom;146;145;145;146;145;145;145;146;146;145 03:56:33 INFO - PROCESS | 4132 | |7;imaging-desaturate;94;85;84;84;85;85;84;85;85;85 03:56:33 INFO - PROCESS | 4132 | |8;json-parse-financial;55;53;54;54;54;54;54;53;55;54 03:56:33 INFO - PROCESS | 4132 | |9;json-stringify-tinderbox;62;62;61;62;62;62;61;61;61;62 03:56:33 INFO - PROCESS | 4132 | |10;stanford-crypto-aes;81;80;81;86;81;89;79;80;80;83 03:56:33 INFO - PROCESS | 4132 | |11;stanford-crypto-ccm;132;136;134;142;131;133;132;147;165;131 03:56:33 INFO - PROCESS | 4132 | |12;stanford-crypto-pbkdf2;169;167;168;167;166;166;170;165;163;164 03:56:33 INFO - PROCESS | 4132 | |13;stanford-crypto-sha256-iterative;66;66;70;68;66;63;65;65;66;64 03:56:33 INFO - PROCESS | 4132 | __end_tp_report 03:56:33 INFO - PROCESS | 4132 | __start_cc_report 03:56:33 INFO - PROCESS | 4132 | _x_x_mozilla_cycle_collect,1700 03:56:33 INFO - PROCESS | 4132 | __end_cc_report 03:56:33 INFO - PROCESS | 4132 | __startTimestamp1477479393258__endTimestamp 03:56:33 INFO - PROCESS | 4132 | 03:56:33 INFO - PROCESS | 4132 | ------- Summary: start ------- 03:56:33 INFO - PROCESS | 4132 | Number of tests: 14 03:56:33 INFO - PROCESS | 4132 | 03:56:33 INFO - PROCESS | 4132 | [#0] ai-astar Cycles:10 Average:109.80 Median:110.00 stddev:1.23 (1.1%) stddev-sans-first:0.78 03:56:33 INFO - PROCESS | 4132 | Values: 107.0 111.0 109.0 110.0 110.0 110.0 111.0 110.0 109.0 111.0 03:56:33 INFO - PROCESS | 4132 | 03:56:33 INFO - PROCESS | 4132 | [#1] audio-beat-detection Cycles:10 Average:133.60 Median:125.50 stddev:16.85 (13.4%) stddev-sans-first:16.80 03:56:33 INFO - PROCESS | 4132 | Values: 150.0 125.0 126.0 165.0 125.0 123.0 120.0 121.0 157.0 124.0 03:56:33 INFO - PROCESS | 4132 | 03:56:33 INFO - PROCESS | 4132 | [#2] audio-dft Cycles:10 Average:162.00 Median:162.00 stddev:0.67 (0.4%) stddev-sans-first:0.71 03:56:33 INFO - PROCESS | 4132 | Values: 162.0 162.0 161.0 162.0 162.0 163.0 162.0 163.0 162.0 161.0 03:56:33 INFO - PROCESS | 4132 | 03:56:33 INFO - PROCESS | 4132 | [#3] audio-fft Cycles:10 Average:83.00 Median:76.00 stddev:14.35 (18.9%) stddev-sans-first:15.00 03:56:33 INFO - PROCESS | 4132 | Values: 76.0 76.0 83.0 118.0 76.0 75.0 76.0 76.0 99.0 75.0 03:56:33 INFO - PROCESS | 4132 | 03:56:33 INFO - PROCESS | 4132 | [#4] audio-oscillator Cycles:10 Average:91.20 Median:82.00 stddev:15.53 (18.9%) stddev-sans-first:16.11 03:56:33 INFO - PROCESS | 4132 | Values: 82.0 81.0 111.0 82.0 82.0 82.0 109.0 82.0 81.0 120.0 03:56:33 INFO - PROCESS | 4132 | 03:56:33 INFO - PROCESS | 4132 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.50 03:56:33 INFO - PROCESS | 4132 | Values: 116.0 117.0 116.0 116.0 117.0 117.0 117.0 117.0 116.0 117.0 03:56:33 INFO - PROCESS | 4132 | 03:56:33 INFO - PROCESS | 4132 | [#6] imaging-darkroom Cycles:10 Average:145.40 Median:145.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 03:56:33 INFO - PROCESS | 4132 | Values: 146.0 145.0 145.0 146.0 145.0 145.0 145.0 146.0 146.0 145.0 03:56:33 INFO - PROCESS | 4132 | 03:56:33 INFO - PROCESS | 4132 | [#7] imaging-desaturate Cycles:10 Average:85.60 Median:85.00 stddev:2.99 (3.5%) stddev-sans-first:0.50 03:56:33 INFO - PROCESS | 4132 | Values: 94.0 85.0 84.0 84.0 85.0 85.0 84.0 85.0 85.0 85.0 03:56:33 INFO - PROCESS | 4132 | 03:56:33 INFO - PROCESS | 4132 | [#8] json-parse-financial Cycles:10 Average:54.00 Median:54.00 stddev:0.67 (1.2%) stddev-sans-first:0.60 03:56:33 INFO - PROCESS | 4132 | Values: 55.0 53.0 54.0 54.0 54.0 54.0 54.0 53.0 55.0 54.0 03:56:33 INFO - PROCESS | 4132 | 03:56:33 INFO - PROCESS | 4132 | [#9] json-stringify-tinderbox Cycles:10 Average:61.60 Median:62.00 stddev:0.52 (0.8%) stddev-sans-first:0.53 03:56:33 INFO - PROCESS | 4132 | Values: 62.0 62.0 61.0 62.0 62.0 62.0 61.0 61.0 61.0 62.0 03:56:33 INFO - PROCESS | 4132 | 03:56:33 INFO - PROCESS | 4132 | [#10] stanford-crypto-aes Cycles:10 Average:82.00 Median:81.00 stddev:3.16 (3.9%) stddev-sans-first:3.33 03:56:33 INFO - PROCESS | 4132 | Values: 81.0 80.0 81.0 86.0 81.0 89.0 79.0 80.0 80.0 83.0 03:56:33 INFO - PROCESS | 4132 | 03:56:33 INFO - PROCESS | 4132 | [#11] stanford-crypto-ccm Cycles:10 Average:138.30 Median:135.00 stddev:10.75 (8.0%) stddev-sans-first:11.16 03:56:33 INFO - PROCESS | 4132 | Values: 132.0 136.0 134.0 142.0 131.0 133.0 132.0 147.0 165.0 131.0 03:56:33 INFO - PROCESS | 4132 | 03:56:33 INFO - PROCESS | 4132 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.50 Median:167.00 stddev:2.17 (1.3%) stddev-sans-first:2.11 03:56:33 INFO - PROCESS | 4132 | Values: 169.0 167.0 168.0 167.0 166.0 166.0 170.0 165.0 163.0 164.0 03:56:33 INFO - PROCESS | 4132 | 03:56:33 INFO - PROCESS | 4132 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.90 Median:66.00 stddev:1.97 (3.0%) stddev-sans-first:2.09 03:56:33 INFO - PROCESS | 4132 | Values: 66.0 66.0 70.0 68.0 66.0 63.0 65.0 65.0 66.0 64.0 03:56:33 INFO - PROCESS | 4132 | -------- Summary: end -------- 03:56:33 INFO - PROCESS | 4132 | 03:56:34 INFO - TEST-INFO | 4132: exit 0 03:56:34 INFO - TEST-OK | kraken | took 61631ms 03:56:34 INFO - SUITE-END | took 1180s 03:56:34 INFO - Completed test suite (00:19:40) 03:56:34 INFO - javascript benchmark 03:56:34 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3042.5588289697994, 3057.847107644617, 3086.8765249390026, 3099.4575949208884, 3106.3166103457233, 5273.683578985264, 5326.62713610047, 5331.3069300990865, 5380.192971054344, 5425.321834770659, 5382.2464854920245, 5389.649672771267, 5399.298091248133, 5413.296271484712, 5417.783288668458, 4876.317315575822, 4894.265860120975, 4920.876978075541, 4934.235193544989, 4961.950380496203, 4979.900401991958, 4985.6759310644875, 5025.949740502585, 5050.217216331474, 5055.368078990126, 5041.470645582216, 5049.4193167785625, 5049.873753156164, 5071.746412679369, 5080.0, 5036.7229802361035, 5045.041442125985, 5049.924251136236, 5051.772670229849, 5118.38579370478, 4626.907461850744, 4745.596624286905, 4822.324874517571, 4867.51324867514, 4885.340479035356, 5360.865978350534, 5429.321334833146, 5429.429909859447, 5447.101228297366, 5466.699331536764, 5697.6296540724725, 5701.629394089371, 5722.9141562876175, 5799.159121927297, 5913.142594323842, 5828.650280983112, 5844.094165404369, 5847.26909136358, 5848.619839710405, 5853.50245229156, 5222.634415590872, 5262.236975638511, 5354.036273470812, 5441.401445840955, 5449.23710680509, 5900.675462849498, 5919.911201331984, 5958.19564358806, 5958.940410595838, 6021.217241758543, 5654.321481422256, 5688.203651488795, 5699.0, 5703.486686198179, 5705.686187259657, 5654.688992105392, 5684.459976302244, 5740.512056475246, 5742.224799652077, 5745.253117094751, 5750.079987202028, 5758.913616295759, 5773.653580785166, 5830.650160990354, 5846.239988801429, 5750.367459579443, 5759.798407055733, 5763.106718458645, 5790.044642634002, 5816.1566572846705, 4312.245357062501, 4323.48118225815, 4453.977730111329, 4471.664625153061, 4517.367568540407, 3922.646961773454, 3939.4681717967705, 3947.92104157921, 3988.6210809973004, 3998.3202855514633, 5451.318585176853, 5509.0, 5511.641743286674, 5514.476124768141, 5574.637648552831, 5834.620749651259, 5836.299644042657, 5845.386234445407, 5848.0, 5856.297244330623, 5356.517913387814, 5408.729563521808, 5462.590305727007, 5518.834434966958, 5541.750621222055, 5049.343585333883, 5050.116229659795, 5076.111680455905, 5095.847124586268, 5112.565431938327, 5986.940130598812, 6036.758529658852, 6040.305364883095, 6042.969785151134, 6046.486048685911, 5716.742746576331, 5726.455986681259, 5780.208135478016, 5872.765089396376, 5884.735186916685, 5991.400859913973, 5993.041113421831, 6042.516598672008, 6102.908456373069, 6111.8777624446375, 5722.456366645162, 5723.055695810144, 5723.198752174616, 5729.140628905531, 5733.31200255972, 5642.774289028557, 5692.402297758841, 5754.424557544212, 5773.047447171338, 5780.710964451677, 5573.637713548606, 5640.097584386643, 5643.576731745217, 5644.717764111696, 5647.491725744702, 5592.524635406036, 5605.467480589337, 5607.271054762855, 5609.971950140386, 5615.438456154516, 5616.073347897551, 5631.155326701028, 5631.267935168402, 5633.63381380209, 5660.490555849993, 5678.4605462480995, 5730.169125476866, 5755.366909639853, 5759.625624334405, 5761.193432919311, 5514.696691681996, 5529.861753456195, 5531.115021596686, 5531.253280807039, 5538.556915446674], "value": 5342.998409869803, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [582.1297160744688, 608.817354793562, 611.8562137897593, 614.1555361378105, 635.8219698484423, 30032.549511757315, 33789.1552711182, 33941.15147121317, 34000.31999360015, 42801.35797963033, 42001.36997945033, 46061.0, 46064.309035364495, 46106.769466152626, 46204.0, 8821.117888211176, 8940.597673104694, 8947.865782013276, 8960.103989601053, 8980.057094005133, 8030.678772849079, 8230.382721295897, 8889.066648001964, 8985.640574377017, 8987.101289870994, 8216.794580135514, 8265.95867020664, 10488.632897848576, 10844.295120817122, 10846.29499082561, 10643.254972151952, 10808.297460665031, 10819.0, 10819.459027048695, 10822.0, 10608.469576521144, 10659.147268218523, 10680.412577308245, 10680.78638427227, 10682.359058456517, 41644.583554164376, 41711.1657766846, 41785.79107104445, 42003.789981050206, 42034.369484457755, 3371.814550199738, 3516.191276006533, 3609.9458508122398, 3830.9616903830884, 3839.1361943562756, 30460.695393046008, 30630.234244143852, 31448.0, 31604.841975790205, 31718.841405793053, 4236.279832428495, 4306.80619372129, 4471.955280447187, 4488.438945131858, 4519.751413672247, 330260.0, 333781.0, 334835.0, 335682.0, 335874.99999999756, 57013.0, 57363.42636573581, 57396.42603573911, 57422.71288643614, 57436.425635743944, 59504.0, 59707.40292597105, 59925.700371497864, 60068.399316007155, 60183.398166018655, 15359.539213823604, 15552.0, 15578.9221053894, 15614.29735661898, 15702.842971570139, 11731.76536469266, 11762.176647634755, 11769.293842369485, 11770.176087673952, 11774.234674746114, 14623.122612643063, 14970.40118395252, 15092.471763488225, 16044.636205922627, 16656.08391538477, 5760.683162426023, 5955.34491205967, 6037.396260373927, 6090.786822461193, 6130.908036379458, 884.2748945864458, 951.3198063384575, 989.2877128467492, 1044.5821671331375, 1125.774845030997, 31783.56753116856, 31885.20286992844, 32012.679873201436, 32145.678543214268, 32435.837820810746, 1012.2205901455985, 1043.5773511727762, 1099.5272033025876, 1101.5869049106584, 1138.2942575603179, 16042.0, 16971.915140424466, 16973.575660608585, 16988.660226795393, 16995.660086798194, 517428.0, 521974.0, 522545.0, 522694.0, 522847.0, 50512.0, 51288.74355628272, 56713.716431417575, 58050.419495804505, 58139.418605814244, 1246.9314187719763, 1251.0679543739973, 1272.7200015996466, 1284.5825106840127, 1286.4339690536322, 30677.0, 33588.496172556945, 33687.66312336845, 33894.491582625786, 34080.829595851865, 50537.24194137017, 51107.2333914999, 51112.0, 51113.0, 51122.74438627783, 449961.0, 507276.0, 517485.0, 519746.0, 522148.0, 27036.324091897073, 27312.59031114495, 27433.725662743116, 27772.583411249252, 27807.0, 47103.76448117737, 47243.0, 47835.521644783104, 48081.519184809105, 49190.50809492003, 39288.0, 39666.40500392439, 39954.80022599868, 40650.390244146955, 41527.1694566113, 39723.40414893837, 39741.40387894126, 40187.59812401838, 40810.79594602008, 41433.79283103565, 40860.387094193014, 40976.59023409847, 42304.0, 42350.788246058575, 42495.78752106219, 33531.0, 36371.81814090913, 36725.81637091797, 37203.25593488061, 37461.81269093637, 27868.721312786613, 28052.438951220454, 28309.15072547827, 28578.285542861595, 28631.0], "value": 19885.508724242314, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [365.78235949609973, 366.6590071233753, 391.80801407310406, 397.3265315290583, 408.5954904644403, 14144.0, 15476.613084672888, 18571.535711607215, 19134.52163695908, 19142.23431062759, 15210.315535800888, 15335.233238338094, 15356.385744570203, 15462.458813941514, 15480.380784768624, 4157.979210103946, 5523.088690366085, 5755.65466072037, 5764.048931926227, 5764.481196692297, 4279.229738647043, 6091.329953705089, 6346.0, 6440.581362211465, 6542.50931180161, 6264.686765661721, 6417.26201486828, 6463.159789227418, 6492.772752953648, 6501.7724379646725, 6415.4546863516425, 6442.645654489002, 6449.419552240297, 6456.7740129095255, 6457.483401327906, 5482.396936337, 5639.436056394369, 5688.4311568843195, 5694.316681998187, 5695.629784064064, 22670.319890403316, 22962.77037229623, 23269.06923723049, 23325.0, 23515.882420587957, 2149.6560550312033, 2285.8171346292256, 2320.93037208884, 2534.4677617700304, 2768.806183567151, 9740.269479789044, 10297.279190456671, 10320.690379288633, 10333.431661258628, 13954.93022534891, 1836.366453573515, 1908.8186622270862, 1919.2227148005081, 1938.176275083098, 1950.2296592845746, 84853.57573212156, 86788.24599818046, 87301.56349218213, 88554.0, 90352.5482372584, 10632.468376581295, 10840.620578279722, 10850.171673605328, 10857.185711071543, 10940.671779846618, 14947.252637368305, 14974.700505989818, 15081.924590376977, 15111.395544178109, 15151.848481515044, 7599.058628498629, 7878.684852605947, 7989.241022102891, 8096.7166149184495, 8109.0, 6718.428933540606, 6864.553804002724, 7036.401905838061, 7047.823804404931, 7052.0, 4514.977425112854, 4554.385158003627, 4558.635309175258, 4724.102420540086, 4781.665283430196, 1831.8259765322273, 1943.407260785474, 1973.9506512337018, 1978.0999645161417, 1978.871373360727, 812.8536863364533, 841.8568843296654, 956.0, 1004.1163775877181, 1056.5087234436023, 18100.818991809912, 18917.0, 18980.905095474434, 19212.903935480233, 19513.414597562096, 973.9172170365598, 977.9462129582942, 982.0964712464549, 986.4623780039896, 989.2086330935223, 10121.69634910954, 10804.783904322027, 10830.729231769268, 10840.349579025284, 10893.346399215914, 452052.0, 467641.0, 471410.0, 473689.0, 482300.0, 90313.0, 92262.53868730614, 92764.53617731867, 92926.0, 93288.0, 944.6740874398322, 960.7550074730899, 962.5764663548016, 964.6864768950119, 970.2819913264134, 16204.136524299385, 16776.916115419346, 17268.0, 17380.21789019472, 17634.82365176332, 40568.79715601403, 40971.0, 41006.1798764029, 41897.58102418937, 42729.0, 58918.70540647269, 58984.70507647434, 60087.39912600818, 60115.39884601098, 60442.0, 8451.154884511745, 8491.108433614629, 8528.403011789364, 8659.393842430969, 8913.153250441197, 11479.827802583135, 12475.75048499043, 12569.0, 13031.218126912416, 13046.282454464716, 11031.779364412507, 11160.274582152135, 11520.596779112691, 11826.113041522092, 11919.463624137108, 10754.784904301714, 11292.7741445169, 11369.43152842338, 11392.145589080686, 11893.345865977455, 11169.441527923735, 11259.437028148724, 11359.54561817518, 11404.0, 11601.883981160081, 8349.206825351583, 8418.95790521068, 8618.827623447622, 8681.956590217262, 8772.605232764668, 11332.886671133183, 11695.473703683525, 11698.94150529242, 11743.471543780379, 12207.0], "value": 9098.309285542045, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1460.6567456647686, 1497.6779992301654, 1598.4964736108125, 1733.6706025855078, 1781.27858217422, 8233.053198882131, 8753.693620723276, 8783.297336213103, 8786.12138786121, 8787.824243515133, 7544.962275188616, 7739.419543534229, 8347.707830225943, 8572.271356934669, 8590.055093939662, 2278.977210227897, 2299.5630830142304, 2302.5164715409783, 2304.942376440594, 2314.271004633535, 2316.085146367184, 2341.4146463384154, 2380.1074597026113, 2384.3204686664303, 2384.9046038158453, 2277.350954977832, 2282.6918366020623, 2299.908003679851, 2308.145985985188, 2310.3069079276233, 2222.0, 2222.111155537798, 2233.7207849018873, 2236.4185311818965, 2240.9439764005865, 2211.9557608847895, 2240.451089483087, 2242.6972358731527, 2262.049939025597, 2271.8636881787147, 8791.252743516809, 8793.692220772306, 8831.3376496763, 8843.734687959372, 8858.911410885938, 5103.719295438749, 5221.765020574083, 5231.058409486291, 5233.241180028875, 5233.764480598345, 2994.6107006089287, 3082.568440418343, 3272.198311413695, 3273.9508907366408, 3288.030031140819, 1046.4819914142547, 1057.6774083904406, 1068.4016950507742, 1073.5276478349579, 1098.758273179899, 11979.221350612183, 11989.880101198964, 12096.153269271155, 12131.0, 12167.878321216764, 4406.20688276107, 4585.151746926829, 4650.813967441332, 4659.277811939155, 4686.554777296152, 10399.688009359732, 10400.635977740743, 10408.583656653649, 10413.843792343121, 10413.947930260452, 5317.335333083364, 5323.387810401776, 5328.946710532845, 5331.067063263913, 5334.51989320963, 4263.5096963849555, 4282.164977829356, 4767.523247675204, 4850.83022094225, 4875.341828853059, 3744.7004239661305, 3854.6530812226474, 3869.129445874712, 3948.980255098706, 3961.782101984361, 1208.250884451628, 1218.2081646929566, 1226.3439060102803, 1253.5173958026044, 1254.3978890132787, 787.4330482053027, 837.7151768398652, 846.9703560375481, 871.9825603487894, 948.2650945517279, 5296.179092240709, 5467.726613669301, 5622.465865742748, 5653.830385088454, 5692.0, 850.3834719828199, 867.9392442528963, 884.8186121845006, 885.1590988560764, 936.134075979716, 3503.964960350364, 3640.5631324241263, 3693.242885208526, 3712.7029837612927, 3725.5529336479253, 10683.0, 11143.052840508486, 11151.05216056628, 11153.10775137987, 11155.944220279009, 10973.177011723992, 10992.395418252074, 11008.779824403628, 11018.889811101786, 11076.058535024453, 7943.4042446815565, 8174.3460523158, 8210.630521626661, 8322.375821813388, 8327.791805204797, 5307.52232299095, 5447.836564903059, 5519.751611177587, 5531.612787104864, 5597.608167428241, 9699.951500242454, 9913.801723965624, 9916.752081198028, 10018.048285412875, 10034.397936123563, 10054.095131438205, 10147.695569132939, 10148.137408320375, 10246.590136394461, 10302.278840481094, 7010.719571217094, 7116.3951064158055, 7580.658870350958, 7616.771496855104, 7761.18507556721, 8414.116517765546, 8689.391742577958, 8713.956430217808, 8748.475091494276, 8760.080191579793, 7622.3521000713345, 7679.961600192187, 7701.691932322644, 7837.216278372117, 7951.284384405431, 7636.350910172475, 7684.6157692116285, 7748.573828439265, 7813.648385822766, 7931.246531579491, 7035.33164349386, 7065.540739851893, 7137.464690148156, 7138.928610714034, 7148.142222933281, 4655.4180727409075, 4689.249720044776, 4749.335093087039, 4879.512048795092, 5070.2394640802695, 4813.807447702053, 4866.562009419169, 4884.584810291023, 4983.152864013199, 4986.675866068694], "value": 4530.404959185538, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [328.5302018114096, 334.7305419137594, 340.83810190159676, 341.83093819138554, 345.41107411862777, 5124.8975020499565, 5223.850752834375, 5240.737963101848, 5313.89372212556, 5341.919871201935, 5099.133147364948, 5170.715610641413, 5176.912848301852, 5213.661112027725, 5231.189165679316, 4131.73143745657, 4132.5040995080635, 4133.875983720493, 4147.979260103695, 4152.73007254529, 3907.941380879289, 4083.9183216335655, 4137.13120244749, 4147.917041659165, 4159.481789146955, 4049.9392509112386, 4064.9390259146135, 4067.4712287402594, 4068.125353049094, 4084.8978775530554, 4016.6786657067655, 4037.1118353962374, 4040.2525532776235, 4046.1300820323627, 4067.2882245607047, 3543.4330507118993, 3543.94684079739, 3551.94672079919, 3573.87491437801, 3597.8740744074094, 5073.0, 5115.360579927509, 5125.308083408767, 5125.871853203663, 5129.897402051975, 4657.417822772153, 4664.277037059262, 4669.696469729491, 4683.836065737717, 4692.366530518405, 5439.728013599304, 5460.6177567570285, 5461.18082287656, 5461.399246082928, 5483.287172667528, 3845.384738441836, 3846.2499812536566, 3880.844766209348, 3881.913064341989, 3896.376579747227, 5607.439256074401, 5655.519280861132, 5665.716714164275, 5671.886562268732, 5682.431756824284, 4036.495438070241, 4038.273110840077, 4040.8585699500377, 4053.7365071270274, 4081.428599996003, 4029.3351596986167, 4070.9796451017555, 4082.2856000199845, 4104.753714777123, 4138.337865941435, 4649.418822647169, 4661.790219440133, 4666.393368862026, 4667.906641867144, 4672.761718144694, 5489.368722596872, 5492.780288788404, 5496.560275178056, 5500.339959204921, 5567.582431317667, 1340.2561578324123, 1340.8200783310624, 1365.3582816076428, 1369.5617402431326, 1386.895982801294, 843.9367047471342, 880.7137680253815, 895.820835832823, 900.7883147460342, 905.2667339455063, 4651.511591282934, 4678.081986385566, 4683.250679891201, 4689.577937985529, 4691.483936766953, 4902.7988142905215, 4923.310736496894, 4924.227278179852, 4936.827211047596, 4942.728149951788, 4622.214223581999, 4648.44277167146, 4653.7207767534055, 4669.649776266793, 4680.4149481314835, 2788.2852045991567, 2996.1760515858314, 3013.141254742388, 3017.879284828582, 3033.5449682547796, 5790.334111577223, 5795.1886735857015, 5804.506616937608, 5809.854753631109, 5818.44724751148, 5548.306461692288, 5716.971415142898, 5732.165706973812, 5802.750459742558, 5808.419158084243, 5729.455701708331, 5758.1362795581, 5758.452946970031, 5758.712064396764, 5797.391273916262, 5634.295713035871, 5657.349404818334, 5667.801626943037, 5674.0, 5679.602427830012, 5390.649607775482, 5586.720663966867, 5594.545418191218, 5602.943970560243, 5612.0, 5803.158542011469, 5813.447722466359, 5817.127430885401, 5824.883502329845, 5865.208196893535, 3980.582038885875, 4059.6955228358584, 4079.9184016318914, 4085.080012394289, 4110.815013324348, 5345.995251780582, 5612.5509959202345, 5628.859278517906, 5635.577331700057, 5661.348944871393, 5299.443558426464, 5383.711922433029, 5467.39858615544, 5481.3970463248215, 5514.255575497417, 5424.83725488236, 5476.616636835383, 5504.431322002648, 5507.807226747044, 5511.917321240265, 5320.627556071193, 5458.153986132156, 5465.016297066566, 5497.8075767347955, 5512.5589952802875, 5526.944730552643, 5552.722363881709, 5559.749811258423, 5586.011483856118, 5594.272744543347, 5458.3897750163005, 5464.808731694372, 5483.972580137074, 5487.945120548743, 5496.6701997880255], "value": 4143.146203910341, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [727.5198369076411, 766.3600893254132, 771.1324759645399, 777.5218240781918, 815.5473712089791, 12308.19996700215, 12666.683332916682, 12686.746265074693, 12726.68183295418, 12772.105952583312, 12596.118271720983, 12747.490100395997, 12806.871931280684, 12809.117948461591, 12830.871691283084, 780.9062912450514, 790.6007466229546, 794.7655441644729, 795.5187111797366, 795.7016118955391, 783.478986473997, 785.1245860865151, 785.681798871458, 785.9410544209179, 786.2844811221789, 822.3667775812621, 822.9094799572042, 824.0646865807322, 824.3981893217955, 824.4517395931698, 816.3550794872015, 817.7955511122219, 818.2840014986887, 818.5907046476761, 818.6561644109458, 604.5375287904757, 605.1830029460193, 605.279717136606, 605.2948315212772, 605.3220393159689, 11883.405829708567, 11989.400529973467, 12016.218945768585, 12022.218555793845, 12758.489660413572, 11322.32066076038, 11889.643310700692, 12250.44872980709, 12323.260604363766, 12359.567415140516, 11649.883501164964, 11924.10569207313, 12021.459034343388, 12023.278603283743, 12614.180078294974, 4289.892752681208, 4331.631811296043, 4379.846705365297, 4385.2106620808245, 4523.864284071483, 65698.67150664264, 67255.66372168157, 67485.66257168683, 67832.32167678358, 68875.0, 10290.639827606148, 10336.379817210842, 10452.268341216193, 10488.108510776518, 10649.094826939641, 18245.7263141053, 18449.53876153107, 18656.253749849853, 18703.532411689543, 18988.715169272473, 7525.36034437079, 7561.09266887977, 7596.08846938371, 7636.3890888728765, 7653.885191722128, 4198.454200953856, 4366.781660916941, 4420.646348292129, 4476.552344765562, 4585.426821647294, 3231.6929891660725, 3328.417526932777, 3350.447176215946, 3559.750817442806, 3761.153740408386, 645.6255371884296, 650.222983534681, 650.278191207759, 662.3707477895922, 664.9335066493409, 578.2887048929756, 599.3856297295307, 677.9795613482074, 680.4138026800027, 687.4328678839977, 8823.867641985375, 9262.259019278576, 9479.336446448682, 9554.187894028946, 9556.95221523888, 564.2692712936757, 566.303446760487, 574.5776854012298, 694.4236283884364, 697.0589703899797, 4255.319148936155, 4436.423264975597, 4482.0, 4589.154982007693, 4628.39830821991, 52352.0, 53161.7341913288, 53296.46703532915, 53466.0, 71732.2826771736, 46065.0, 46215.76892115518, 64590.35409645843, 70305.64847175732, 71538.0, 62324.15840990288, 64655.0, 64731.0, 64841.67579162074, 65407.34592654108, 8771.780705482413, 9231.446113232958, 9269.86095208559, 9336.758268784552, 9376.156145946898, 42114.57885421229, 43659.345109822745, 44166.0, 44331.77834110809, 44757.55242447664, 55511.0, 60501.69749151226, 60719.69640151771, 61674.69162654158, 63735.0, 11673.416329183678, 11831.467583958914, 12097.879021209676, 12110.878891210976, 12628.494860205488, 13209.273489958145, 13355.0, 13752.724945501233, 13909.930450347683, 14085.295735213404, 12045.33750643688, 12229.449674764835, 12512.124151309321, 12967.157134786208, 13187.208767473981, 12616.36918154107, 12676.683082923, 12687.555935542581, 12724.427400766803, 13507.932460337635, 12186.939065304618, 12223.449944752685, 12492.437840297027, 12649.87350126487, 12861.614151575468, 9842.311038227255, 10180.338278011906, 10218.795624087625, 10248.436336001592, 10285.897141028794, 8802.471851688919, 9056.909430905607, 9122.390323739763, 9957.950210248902, 10017.0], "value": 6741.45888090758, "unit": "score"}], "name": "dromaeo_css", "value": 7045.713108929884, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 111.0, 109.0, 110.0, 110.0, 110.0, 111.0, 110.0, 109.0, 111.0], "value": 109.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 125.0, 126.0, 165.0, 125.0, 123.0, 120.0, 121.0, 157.0, 124.0], "value": 133.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 161.0, 162.0, 162.0, 163.0, 162.0, 163.0, 162.0, 161.0], "value": 162.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 83.0, 118.0, 76.0, 75.0, 76.0, 76.0, 99.0, 75.0], "value": 83.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 81.0, 111.0, 82.0, 82.0, 82.0, 109.0, 82.0, 81.0, 120.0], "value": 91.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 116.0, 116.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 145.0, 146.0, 145.0, 145.0, 145.0, 146.0, 146.0, 145.0], "value": 145.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 85.0, 84.0, 84.0, 85.0, 85.0, 84.0, 85.0, 85.0, 85.0], "value": 85.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 53.0, 54.0, 54.0, 54.0, 54.0, 54.0, 53.0, 55.0, 54.0], "value": 54.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 61.0, 62.0, 62.0, 62.0, 61.0, 61.0, 61.0, 62.0], "value": 61.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 80.0, 81.0, 86.0, 81.0, 89.0, 79.0, 80.0, 80.0, 83.0], "value": 82.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 136.0, 134.0, 142.0, 131.0, 133.0, 132.0, 147.0, 165.0, 131.0], "value": 138.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 167.0, 168.0, 167.0, 166.0, 166.0, 170.0, 165.0, 163.0, 164.0], "value": 166.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 70.0, 68.0, 66.0, 63.0, 65.0, 65.0, 66.0, 64.0], "value": 65.9, "unit": "score"}], "name": "kraken", "value": 1495.5, "alertThreshold": 2.0}]} 03:56:35 INFO - Return code: 0 03:56:35 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:56:35 INFO - # TBPL SUCCESS # 03:56:35 INFO - Running post-action listener: _resource_record_post_action 03:56:35 INFO - [mozharness: 2016-10-26 10:56:35.064792Z] Finished run-tests step (success) 03:56:35 INFO - Running post-run listener: _resource_record_post_run 03:56:35 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 4096; Write bytes: 403677184; Read time: 12; Write time: 264900 03:56:35 INFO - TinderboxPrint: CPU usage
13.1% 03:56:35 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 03:56:35 INFO - TinderboxPrint: I/O write bytes / time
403,677,184 / 264,900 03:56:35 INFO - TinderboxPrint: CPU idle
8,308.1 (86.9%) 03:56:35 INFO - TinderboxPrint: CPU user
1,200.5 (12.6%) 03:56:35 INFO - TinderboxPrint: Swap in / out
0 / 0 03:56:35 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 114192384; Read time: 0; Write time: 70156 03:56:35 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 0; Write bytes: 288227328; Read time: 0; Write time: 194716 03:56:35 INFO - Running post-run listener: _upload_blobber_files 03:56:35 INFO - Blob upload gear active. 03:56:35 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:56:35 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 03:56:35 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'] 03:56:35 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 03:56:36 INFO - (blobuploader) - INFO - Open directory for files ... 03:56:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:56:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:56:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:56:39 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:56:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:56:39 INFO - (blobuploader) - INFO - Done attempting. 03:56:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:56:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:56:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:56:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:56:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:56:40 INFO - (blobuploader) - INFO - Done attempting. 03:56:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:56:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:56:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:56:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:56:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:56:41 INFO - (blobuploader) - INFO - Done attempting. 03:56:41 INFO - (blobuploader) - INFO - Iteration through files over. 03:56:41 INFO - Return code: 0 03:56:41 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:56:41 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:56:41 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4a7fabf6f5c6888304790a86e0d2ec14ebc27b7fb8a572daa9ae28835c99ffd41be3413afd0e5a372baec43fb6b64970ca5dd47e7ce4c94bf8e0378d3a993e4f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cb8afa3ccde4e4a82f8d39cbc27001c1455a6fc030a6f0a57a66888864881a29e44a72c3437d769f5d96fbd539a1a72b51a7b478955b383f41837accf8460e4a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0138399fdd36ad14d10073f407c15937b0166d5adb3c18c0c70ae044c07c38d8f41799a735b6a0b2a4ad29f82f82b9999d386b900d2f7a8f4036dc34eb5fc28b"} 03:56:41 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:56:41 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:56:41 INFO - Contents: 03:56:41 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4a7fabf6f5c6888304790a86e0d2ec14ebc27b7fb8a572daa9ae28835c99ffd41be3413afd0e5a372baec43fb6b64970ca5dd47e7ce4c94bf8e0378d3a993e4f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cb8afa3ccde4e4a82f8d39cbc27001c1455a6fc030a6f0a57a66888864881a29e44a72c3437d769f5d96fbd539a1a72b51a7b478955b383f41837accf8460e4a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0138399fdd36ad14d10073f407c15937b0166d5adb3c18c0c70ae044c07c38d8f41799a735b6a0b2a4ad29f82f82b9999d386b900d2f7a8f4036dc34eb5fc28b"} 03:56:41 INFO - Running post-run listener: copy_logs_to_upload_dir 03:56:41 INFO - Copying logs to upload dir... 03:56:41 INFO - mkdir: /builds/slave/test/build/upload/logs 03:56:41 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1241.682093 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-10-26 03:56:41.351815) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-26 03:56:41.355794) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1477476345.565501-940132543 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/4a7fabf6f5c6888304790a86e0d2ec14ebc27b7fb8a572daa9ae28835c99ffd41be3413afd0e5a372baec43fb6b64970ca5dd47e7ce4c94bf8e0378d3a993e4f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cb8afa3ccde4e4a82f8d39cbc27001c1455a6fc030a6f0a57a66888864881a29e44a72c3437d769f5d96fbd539a1a72b51a7b478955b383f41837accf8460e4a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0138399fdd36ad14d10073f407c15937b0166d5adb3c18c0c70ae044c07c38d8f41799a735b6a0b2a4ad29f82f82b9999d386b900d2f7a8f4036dc34eb5fc28b"} build_url:https://queue.taskcluster.net/v1/task/Cpqc0s_UQDGAAt8wCYrSRg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011264 build_url: 'https://queue.taskcluster.net/v1/task/Cpqc0s_UQDGAAt8wCYrSRg/artifacts/public/build/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/4a7fabf6f5c6888304790a86e0d2ec14ebc27b7fb8a572daa9ae28835c99ffd41be3413afd0e5a372baec43fb6b64970ca5dd47e7ce4c94bf8e0378d3a993e4f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cb8afa3ccde4e4a82f8d39cbc27001c1455a6fc030a6f0a57a66888864881a29e44a72c3437d769f5d96fbd539a1a72b51a7b478955b383f41837accf8460e4a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0138399fdd36ad14d10073f407c15937b0166d5adb3c18c0c70ae044c07c38d8f41799a735b6a0b2a4ad29f82f82b9999d386b900d2f7a8f4036dc34eb5fc28b"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-26 03:56:41.381666) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 03:56:41.382076) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1477476345.565501-940132543 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004467 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 03:56:41.464616) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-26 03:56:41.464946) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-26 03:56:41.465304) ========= ========= Total master_lag: 0.17 =========