builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-006 starttime: 1465430985.8 results: success (0) buildid: 20160608143002 builduid: 97e75280e81449e3b3a4410e9740a2e3 revision: 97074800423c429ca7ae01ca5db8c2e61b0fee17 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-08 17:09:45.795945) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-08 17:09:45.796983) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-08 17:09:45.797747) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-08 17:09:45.812265) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 17:09:45.813079) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1465430985.230124-1110190402 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-08 17:09:45-- 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: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 38.8M=0s 2016-06-08 17:09:46 (38.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.075835 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 17:09:45.906499) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 17:09:45.907155) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1465430985.230124-1110190402 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019489 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 17:09:45.960280) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-08 17:09:45.961065) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 97074800423c429ca7ae01ca5db8c2e61b0fee17 --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 97074800423c429ca7ae01ca5db8c2e61b0fee17 --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=e31afd3c0f0de4e86ebe4d94000001b5-1465430985.230124-1110190402 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-08 17:09:46,171 truncating revision to first 12 chars 2016-06-08 17:09:46,171 Setting DEBUG logging. 2016-06-08 17:09:46,171 attempt 1/10 2016-06-08 17:09:46,171 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/97074800423c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-08 17:09:46,853 unpacking tar archive at: fx-team-97074800423c/testing/mozharness/ program finished with exit code 0 elapsedTime=1.115526 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-08 17:09:47.094334) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-08 17:09:47.095117) ========= script_repo_revision: 97074800423c429ca7ae01ca5db8c2e61b0fee17 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-08 17:09:47.096065) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-08 17:09:47.096758) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-08 17:09:47.109633) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-06-08 17:09:47.109946) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=e31afd3c0f0de4e86ebe4d94000001b5-1465430985.230124-1110190402 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:09:47 INFO - MultiFileLogger online at 20160608 17:09:47 in /builds/slave/test 17:09:47 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 17:09:47 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:09:47 INFO - {'append_to_log': False, 17:09:47 INFO - 'base_work_dir': '/builds/slave/test', 17:09:47 INFO - 'blob_upload_branch': 'Fx-Team', 17:09:47 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:09:47 INFO - 'branch': 'Fx-Team', 17:09:47 INFO - 'buildbot_json_path': 'buildprops.json', 17:09:47 INFO - 'config_files': ('talos/linux_config.py',), 17:09:47 INFO - 'default_actions': ('clobber', 17:09:47 INFO - 'read-buildbot-config', 17:09:47 INFO - 'download-and-extract', 17:09:47 INFO - 'populate-webroot', 17:09:47 INFO - 'create-virtualenv', 17:09:47 INFO - 'install', 17:09:47 INFO - 'run-tests'), 17:09:47 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:09:47 INFO - 'download_minidump_stackwalk': True, 17:09:47 INFO - 'download_symbols': 'ondemand', 17:09:47 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:09:47 INFO - 'tooltool.py': '/tools/tooltool.py', 17:09:47 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:09:47 INFO - '/tools/misc-python/virtualenv.py')}, 17:09:47 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:09:47 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:09:47 INFO - 'installer_path': 'installer.exe', 17:09:47 INFO - 'log_level': 'info', 17:09:47 INFO - 'log_name': 'talos', 17:09:47 INFO - 'log_to_console': True, 17:09:47 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:09:47 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:09:47 INFO - 'opt_config_files': (), 17:09:47 INFO - 'pip_index': False, 17:09:47 INFO - 'sps_profile': False, 17:09:47 INFO - 'sps_profile_interval': 0, 17:09:47 INFO - 'suite': 'dromaeojs-e10s', 17:09:47 INFO - 'system_bits': '32', 17:09:47 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:09:47 INFO - 'title': 'talos-linux64-ix-006', 17:09:47 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:09:47 INFO - 'use_talos_json': True, 17:09:47 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:09:47 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:09:47 INFO - 'work_dir': 'build'} 17:09:47 INFO - ##### 17:09:47 INFO - ##### Running clobber step. 17:09:47 INFO - ##### 17:09:47 INFO - Running pre-action listener: _resource_record_pre_action 17:09:47 INFO - Running main action method: clobber 17:09:47 INFO - rmtree: /builds/slave/test/build 17:09:47 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:09:48 INFO - Running post-action listener: _resource_record_post_action 17:09:48 INFO - ##### 17:09:48 INFO - ##### Finished clobber step (success) 17:09:48 INFO - ##### 17:09:48 INFO - ##### 17:09:48 INFO - ##### Running read-buildbot-config step. 17:09:48 INFO - ##### 17:09:48 INFO - Running pre-action listener: _resource_record_pre_action 17:09:48 INFO - Running main action method: read_buildbot_config 17:09:48 INFO - Using buildbot properties: 17:09:48 INFO - { 17:09:48 INFO - "project": "", 17:09:48 INFO - "product": "firefox", 17:09:48 INFO - "script_repo_revision": "production", 17:09:48 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 17:09:48 INFO - "repository": "", 17:09:48 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 17:09:48 INFO - "buildid": "20160608143002", 17:09:48 INFO - "pgo_build": "True", 17:09:48 INFO - "basedir": "/builds/slave/test", 17:09:48 INFO - "buildnumber": 442, 17:09:48 INFO - "slavename": "talos-linux64-ix-006", 17:09:48 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 17:09:48 INFO - "platform": "ubuntu64_hw", 17:09:48 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 17:09:48 INFO - "branch": "fx-team", 17:09:48 INFO - "repo_path": "integration/fx-team", 17:09:48 INFO - "revision": "97074800423c429ca7ae01ca5db8c2e61b0fee17", 17:09:48 INFO - "stage_platform": "linux64-pgo", 17:09:48 INFO - "builduid": "97e75280e81449e3b3a4410e9740a2e3", 17:09:48 INFO - "slavebuilddir": "test" 17:09:48 INFO - } 17:09:48 INFO - Found installer url https://queue.taskcluster.net/v1/task/bJEfQ-NhQuCzc0N3W4tp8Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 17:09:48 INFO - Running post-action listener: _resource_record_post_action 17:09:48 INFO - ##### 17:09:48 INFO - ##### Finished read-buildbot-config step (success) 17:09:48 INFO - ##### 17:09:48 INFO - ##### 17:09:48 INFO - ##### Running download-and-extract step. 17:09:48 INFO - ##### 17:09:48 INFO - Running pre-action listener: _resource_record_pre_action 17:09:48 INFO - Running main action method: download_and_extract 17:09:48 INFO - mkdir: /builds/slave/test/build/tests 17:09:48 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:09:48 INFO - https://queue.taskcluster.net/v1/task/bJEfQ-NhQuCzc0N3W4tp8Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 17:09:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bJEfQ-NhQuCzc0N3W4tp8Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 17:09:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bJEfQ-NhQuCzc0N3W4tp8Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 17:09:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bJEfQ-NhQuCzc0N3W4tp8Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 17:09:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bJEfQ-NhQuCzc0N3W4tp8Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 17:09:49 INFO - Downloaded 1361 bytes. 17:09:49 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 17:09:49 INFO - Using the following test package requirements: 17:09:49 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 17:09:49 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:09:49 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 17:09:49 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:09:49 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 17:09:49 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:09:49 INFO - u'jsshell-linux-x86_64.zip'], 17:09:49 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:09:49 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 17:09:49 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 17:09:49 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:09:49 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 17:09:49 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:09:49 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 17:09:49 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:09:49 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 17:09:49 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:09:49 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 17:09:49 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:09:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:09:49 INFO - https://queue.taskcluster.net/v1/task/bJEfQ-NhQuCzc0N3W4tp8Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:09:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bJEfQ-NhQuCzc0N3W4tp8Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 17:09:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bJEfQ-NhQuCzc0N3W4tp8Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 17:09:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bJEfQ-NhQuCzc0N3W4tp8Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 17:09:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bJEfQ-NhQuCzc0N3W4tp8Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:09:50 INFO - Downloaded 24450461 bytes. 17:09:50 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:09:50 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 17:09:51 INFO - Return code: 0 17:09:51 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 17:09:51 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:09:51 INFO - https://queue.taskcluster.net/v1/task/bJEfQ-NhQuCzc0N3W4tp8Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:09:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bJEfQ-NhQuCzc0N3W4tp8Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 17:09:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bJEfQ-NhQuCzc0N3W4tp8Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 17:09:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bJEfQ-NhQuCzc0N3W4tp8Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 17:09:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bJEfQ-NhQuCzc0N3W4tp8Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:09:52 INFO - Downloaded 24450461 bytes. 17:09:52 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:09:52 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 17:09:54 INFO - Return code: 0 17:09:54 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:09:54 INFO - https://queue.taskcluster.net/v1/task/bJEfQ-NhQuCzc0N3W4tp8Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 17:09:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bJEfQ-NhQuCzc0N3W4tp8Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 17:09:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bJEfQ-NhQuCzc0N3W4tp8Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 17:09:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bJEfQ-NhQuCzc0N3W4tp8Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 17:09:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bJEfQ-NhQuCzc0N3W4tp8Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 17:09:55 INFO - Downloaded 10833369 bytes. 17:09:55 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:09:55 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 17:09:55 INFO - Return code: 0 17:09:55 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:09:55 INFO - https://queue.taskcluster.net/v1/task/bJEfQ-NhQuCzc0N3W4tp8Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 17:09:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bJEfQ-NhQuCzc0N3W4tp8Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 17:09:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bJEfQ-NhQuCzc0N3W4tp8Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 17:09:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bJEfQ-NhQuCzc0N3W4tp8Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 17:09:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bJEfQ-NhQuCzc0N3W4tp8Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 17:09:56 INFO - Downloaded 59325241 bytes. 17:09:56 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bJEfQ-NhQuCzc0N3W4tp8Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 17:09:56 INFO - mkdir: /builds/slave/test/properties 17:09:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:09:56 INFO - Writing to file /builds/slave/test/properties/build_url 17:09:56 INFO - Contents: 17:09:56 INFO - build_url:https://queue.taskcluster.net/v1/task/bJEfQ-NhQuCzc0N3W4tp8Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 17:09:57 INFO - Running post-action listener: _resource_record_post_action 17:09:57 INFO - Running post-action listener: set_extra_try_arguments 17:09:57 INFO - ##### 17:09:57 INFO - ##### Finished download-and-extract step (success) 17:09:57 INFO - ##### 17:09:57 INFO - ##### 17:09:57 INFO - ##### Running populate-webroot step. 17:09:57 INFO - ##### 17:09:57 INFO - Running pre-action listener: _resource_record_pre_action 17:09:57 INFO - Running main action method: populate_webroot 17:09:57 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:09:57 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:09:57 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:09:57 INFO - '--tppagecycles', 17:09:57 INFO - '7'], 17:09:57 INFO - 'tests': ['tsvgm']}}, 17:09:57 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:09:57 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:09:57 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:09:57 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:09:57 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:09:57 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:09:57 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:09:57 INFO - 'talos_options': ['--disable-e10s'], 17:09:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:09:57 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:09:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:09:57 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:09:57 INFO - 'talos_options': ['--disable-e10s'], 17:09:57 INFO - 'tests': ['damp', 'tps']}, 17:09:57 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:09:57 INFO - 'tests': ['damp', 'tps']}, 17:09:57 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:09:57 INFO - 'tests': ['dromaeo_dom']}, 17:09:57 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:09:57 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:09:57 INFO - 'tests': ['a11yr', 17:09:57 INFO - 'ts_paint', 17:09:57 INFO - 'tpaint', 17:09:57 INFO - 'sessionrestore', 17:09:57 INFO - 'sessionrestore_no_auto_restore', 17:09:57 INFO - 'tabpaint']}, 17:09:57 INFO - 'other-e10s': {'tests': ['a11yr', 17:09:57 INFO - 'ts_paint', 17:09:57 INFO - 'tpaint', 17:09:57 INFO - 'sessionrestore', 17:09:57 INFO - 'sessionrestore_no_auto_restore', 17:09:57 INFO - 'tabpaint']}, 17:09:57 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:09:57 INFO - 'ts_paint', 17:09:57 INFO - 'tpaint', 17:09:57 INFO - 'sessionrestore', 17:09:57 INFO - 'sessionrestore_no_auto_restore', 17:09:57 INFO - 'tabpaint']}, 17:09:57 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:09:57 INFO - 'ts_paint', 17:09:57 INFO - 'tpaint', 17:09:57 INFO - 'sessionrestore', 17:09:57 INFO - 'sessionrestore_no_auto_restore', 17:09:57 INFO - 'tabpaint']}, 17:09:57 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:09:57 INFO - 'tests': ['a11yr', 17:09:57 INFO - 'ts_paint', 17:09:57 INFO - 'tpaint', 17:09:57 INFO - 'sessionrestore', 17:09:57 INFO - 'sessionrestore_no_auto_restore', 17:09:57 INFO - 'tabpaint']}, 17:09:57 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:09:57 INFO - 'tests': ['a11yr', 17:09:57 INFO - 'ts_paint', 17:09:57 INFO - 'tpaint', 17:09:57 INFO - 'sessionrestore', 17:09:57 INFO - 'sessionrestore_no_auto_restore', 17:09:57 INFO - 'tabpaint']}, 17:09:57 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:09:57 INFO - 'tests': ['tsvgx', 17:09:57 INFO - 'tsvgr_opacity', 17:09:57 INFO - 'tart', 17:09:57 INFO - 'tscrollx', 17:09:57 INFO - 'cart']}, 17:09:57 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:09:57 INFO - 'tsvgr_opacity', 17:09:57 INFO - 'tart', 17:09:57 INFO - 'tscrollx', 17:09:57 INFO - 'cart']}, 17:09:57 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:09:57 INFO - 'talos_options': ['--disable-e10s'], 17:09:57 INFO - 'tests': ['tp5o']}, 17:09:57 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:09:57 INFO - 'tests': ['tp5o']}, 17:09:57 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:09:57 INFO - 'talos_options': ['--disable-e10s', 17:09:57 INFO - '--xperf_path', 17:09:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:09:57 INFO - 'tests': ['tp5n']}, 17:09:57 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:09:57 INFO - 'talos_options': ['--xperf_path', 17:09:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:09:57 INFO - 'tests': ['tp5n']}}, 17:09:57 INFO - 'talos.zip': {'path': '', 17:09:57 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:09:57 INFO - Running post-action listener: _resource_record_post_action 17:09:57 INFO - ##### 17:09:57 INFO - ##### Finished populate-webroot step (success) 17:09:57 INFO - ##### 17:09:57 INFO - ##### 17:09:57 INFO - ##### Running create-virtualenv step. 17:09:57 INFO - ##### 17:09:57 INFO - Running pre-action listener: _resource_record_pre_action 17:09:57 INFO - Running main action method: create_virtualenv 17:09:57 INFO - Creating virtualenv /builds/slave/test/build/venv 17:09:57 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 17:09:57 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:09:57 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:09:57 INFO - Using real prefix '/usr' 17:09:57 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:09:58 INFO - Installing distribute.............................................................................................................................................................................................done. 17:10:00 INFO - Installing pip.................done. 17:10:00 INFO - Return code: 0 17:10:00 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:10: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:10:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:10:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:10: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:10:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:10:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:10:00 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 0x7f80d878ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x198d350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a1c1c0>, '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 0x1a1d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a1d550>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1465430985.230124-1110190402', '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 17:10:00 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 17:10:00 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 17:10:00 INFO - Using env: {'DISPLAY': ':0', 17:10:00 INFO - 'HOME': '/home/cltbld', 17:10:00 INFO - 'LANG': 'en_US.UTF-8', 17:10:00 INFO - 'LANGUAGE': 'en_US:en', 17:10:00 INFO - 'LOGNAME': 'cltbld', 17:10:00 INFO - 'MAIL': '/var/mail/cltbld', 17:10:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:10:00 INFO - 'MOZ_NO_REMOTE': '1', 17:10:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:10:00 INFO - 'NO_EM_RESTART': '1', 17:10:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:10:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:10:00 INFO - 'PWD': '/builds/slave/test', 17:10:00 INFO - 'SHELL': '/bin/bash', 17:10:00 INFO - 'SHLVL': '1', 17:10:00 INFO - 'TERM': 'linux', 17:10:00 INFO - 'TMOUT': '86400', 17:10:00 INFO - 'USER': 'cltbld', 17:10:00 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1465430985.230124-1110190402', 17:10:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:10:00 INFO - '_': '/tools/buildbot/bin/python'} 17:10:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:10:00 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 17:10:00 INFO - Cleaning up... 17:10:00 INFO - Return code: 0 17:10:00 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:10: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:10:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:10:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:10: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:10:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:10:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:10:00 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 0x7f80d878ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x198d350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a1c1c0>, '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 0x1a1d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a1d550>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1465430985.230124-1110190402', '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 17:10:00 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 17:10:00 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 17:10:00 INFO - Using env: {'DISPLAY': ':0', 17:10:00 INFO - 'HOME': '/home/cltbld', 17:10:00 INFO - 'LANG': 'en_US.UTF-8', 17:10:00 INFO - 'LANGUAGE': 'en_US:en', 17:10:00 INFO - 'LOGNAME': 'cltbld', 17:10:00 INFO - 'MAIL': '/var/mail/cltbld', 17:10:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:10:00 INFO - 'MOZ_NO_REMOTE': '1', 17:10:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:10:00 INFO - 'NO_EM_RESTART': '1', 17:10:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:10:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:10:00 INFO - 'PWD': '/builds/slave/test', 17:10:00 INFO - 'SHELL': '/bin/bash', 17:10:00 INFO - 'SHLVL': '1', 17:10:00 INFO - 'TERM': 'linux', 17:10:00 INFO - 'TMOUT': '86400', 17:10:00 INFO - 'USER': 'cltbld', 17:10:00 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1465430985.230124-1110190402', 17:10:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:10:00 INFO - '_': '/tools/buildbot/bin/python'} 17:10:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:10:00 INFO - Downloading/unpacking psutil>=3.1.1 17:10:00 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 17:10:00 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 17:10:00 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 17:10:00 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 17:10:00 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 17:10:00 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 17:10:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:10:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:10:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:10:02 INFO - Installing collected packages: psutil 17:10:02 INFO - Running setup.py install for psutil 17:10:02 INFO - building 'psutil._psutil_linux' extension 17:10:02 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 17:10:02 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 17:10:02 INFO - building 'psutil._psutil_posix' extension 17:10:02 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 17:10:02 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 17:10:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:10:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:10:02 INFO - Successfully installed psutil 17:10:02 INFO - Cleaning up... 17:10:02 INFO - Return code: 0 17:10:02 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:10:02 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:10:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:10:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:10:02 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:10:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:10:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:10:02 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 0x7f80d878ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x198d350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a1c1c0>, '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 0x1a1d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a1d550>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1465430985.230124-1110190402', '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 17:10:02 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 17:10:02 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 17:10:02 INFO - Using env: {'DISPLAY': ':0', 17:10:02 INFO - 'HOME': '/home/cltbld', 17:10:02 INFO - 'LANG': 'en_US.UTF-8', 17:10:02 INFO - 'LANGUAGE': 'en_US:en', 17:10:02 INFO - 'LOGNAME': 'cltbld', 17:10:02 INFO - 'MAIL': '/var/mail/cltbld', 17:10:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:10:02 INFO - 'MOZ_NO_REMOTE': '1', 17:10:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:10:02 INFO - 'NO_EM_RESTART': '1', 17:10:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:10:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:10:02 INFO - 'PWD': '/builds/slave/test', 17:10:02 INFO - 'SHELL': '/bin/bash', 17:10:02 INFO - 'SHLVL': '1', 17:10:02 INFO - 'TERM': 'linux', 17:10:02 INFO - 'TMOUT': '86400', 17:10:02 INFO - 'USER': 'cltbld', 17:10:02 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1465430985.230124-1110190402', 17:10:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:10:02 INFO - '_': '/tools/buildbot/bin/python'} 17:10:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:10:03 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:10:03 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 17:10:03 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 17:10:03 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 17:10:03 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 17:10:03 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 17:10:03 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 17:10:05 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:10:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:10:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:10:05 INFO - Installing collected packages: mozsystemmonitor 17:10:05 INFO - Running setup.py install for mozsystemmonitor 17:10:05 INFO - Successfully installed mozsystemmonitor 17:10:05 INFO - Cleaning up... 17:10:05 INFO - Return code: 0 17:10:05 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:10:05 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:10:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:10:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:10:05 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:10:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:10:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:10:05 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 0x7f80d878ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x198d350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a1c1c0>, '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 0x1a1d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a1d550>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1465430985.230124-1110190402', '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 17:10:05 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 17:10:05 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 17:10:05 INFO - Using env: {'DISPLAY': ':0', 17:10:05 INFO - 'HOME': '/home/cltbld', 17:10:05 INFO - 'LANG': 'en_US.UTF-8', 17:10:05 INFO - 'LANGUAGE': 'en_US:en', 17:10:05 INFO - 'LOGNAME': 'cltbld', 17:10:05 INFO - 'MAIL': '/var/mail/cltbld', 17:10:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:10:05 INFO - 'MOZ_NO_REMOTE': '1', 17:10:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:10:05 INFO - 'NO_EM_RESTART': '1', 17:10:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:10:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:10:05 INFO - 'PWD': '/builds/slave/test', 17:10:05 INFO - 'SHELL': '/bin/bash', 17:10:05 INFO - 'SHLVL': '1', 17:10:05 INFO - 'TERM': 'linux', 17:10:05 INFO - 'TMOUT': '86400', 17:10:05 INFO - 'USER': 'cltbld', 17:10:05 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1465430985.230124-1110190402', 17:10:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:10:05 INFO - '_': '/tools/buildbot/bin/python'} 17:10:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:10:05 INFO - Downloading/unpacking jsonschema==2.5.1 17:10:05 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 17:10:05 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 17:10:05 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 17:10:05 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 17:10:05 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 17:10:05 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 17:10:07 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:10:07 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:10:07 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 17:10:07 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 17:10:07 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 17:10:07 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 17:10:07 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 17:10:07 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 17:10:07 INFO - Downloading functools32-3.2.3-2.tar.gz 17:10:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:10:07 INFO - warning: no files found matching '*.txt' 17:10:07 INFO - no previously-included directories found matching 'build' 17:10:07 INFO - no previously-included directories found matching 'dist' 17:10:07 INFO - no previously-included directories found matching '.git*' 17:10:07 INFO - Installing collected packages: jsonschema, functools32 17:10:07 INFO - Running setup.py install for functools32 17:10:07 INFO - warning: no files found matching '*.txt' 17:10:07 INFO - no previously-included directories found matching 'build' 17:10:07 INFO - no previously-included directories found matching 'dist' 17:10:07 INFO - no previously-included directories found matching '.git*' 17:10:07 INFO - Successfully installed jsonschema functools32 17:10:07 INFO - Cleaning up... 17:10:07 INFO - Return code: 0 17:10:07 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:10:07 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:10:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:10:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:10:07 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:10:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:10:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:10:07 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 0x7f80d878ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x198d350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a1c1c0>, '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 0x1a1d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a1d550>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1465430985.230124-1110190402', '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 17:10:07 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 17:10:07 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 17:10:07 INFO - Using env: {'DISPLAY': ':0', 17:10:07 INFO - 'HOME': '/home/cltbld', 17:10:07 INFO - 'LANG': 'en_US.UTF-8', 17:10:07 INFO - 'LANGUAGE': 'en_US:en', 17:10:07 INFO - 'LOGNAME': 'cltbld', 17:10:07 INFO - 'MAIL': '/var/mail/cltbld', 17:10:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:10:07 INFO - 'MOZ_NO_REMOTE': '1', 17:10:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:10:07 INFO - 'NO_EM_RESTART': '1', 17:10:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:10:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:10:07 INFO - 'PWD': '/builds/slave/test', 17:10:07 INFO - 'SHELL': '/bin/bash', 17:10:07 INFO - 'SHLVL': '1', 17:10:07 INFO - 'TERM': 'linux', 17:10:07 INFO - 'TMOUT': '86400', 17:10:07 INFO - 'USER': 'cltbld', 17:10:07 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1465430985.230124-1110190402', 17:10:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:10:07 INFO - '_': '/tools/buildbot/bin/python'} 17:10:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:10:08 INFO - Downloading/unpacking blobuploader==1.2.4 17:10:08 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 17:10:08 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 17:10:08 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 17:10:08 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 17:10:08 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 17:10:08 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 17:10:09 INFO - Downloading blobuploader-1.2.4.tar.gz 17:10:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:10:10 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:10:10 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 17:10:10 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 17:10:10 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 17:10:10 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 17:10:10 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 17:10:10 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 17:10:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:10:10 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:10:10 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 17:10:10 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 17:10:10 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 17:10:10 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 17:10:10 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 17:10:10 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 17:10:10 INFO - Downloading docopt-0.6.1.tar.gz 17:10:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:10:10 INFO - Installing collected packages: blobuploader, requests, docopt 17:10:10 INFO - Running setup.py install for blobuploader 17:10:10 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:10:10 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:10:10 INFO - Running setup.py install for requests 17:10:11 INFO - Running setup.py install for docopt 17:10:11 INFO - Successfully installed blobuploader requests docopt 17:10:11 INFO - Cleaning up... 17:10:11 INFO - Return code: 0 17:10:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:10:11 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:10:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:10:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:10:11 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:10:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:10:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:10:11 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 0x7f80d878ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x198d350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a1c1c0>, '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 0x1a1d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a1d550>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1465430985.230124-1110190402', '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 17:10:11 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 17:10:11 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 17:10:11 INFO - Using env: {'DISPLAY': ':0', 17:10:11 INFO - 'HOME': '/home/cltbld', 17:10:11 INFO - 'LANG': 'en_US.UTF-8', 17:10:11 INFO - 'LANGUAGE': 'en_US:en', 17:10:11 INFO - 'LOGNAME': 'cltbld', 17:10:11 INFO - 'MAIL': '/var/mail/cltbld', 17:10:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:10:11 INFO - 'MOZ_NO_REMOTE': '1', 17:10:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:10:11 INFO - 'NO_EM_RESTART': '1', 17:10:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:10:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:10:11 INFO - 'PWD': '/builds/slave/test', 17:10:11 INFO - 'SHELL': '/bin/bash', 17:10:11 INFO - 'SHLVL': '1', 17:10:11 INFO - 'TERM': 'linux', 17:10:11 INFO - 'TMOUT': '86400', 17:10:11 INFO - 'USER': 'cltbld', 17:10:11 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1465430985.230124-1110190402', 17:10:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:10:11 INFO - '_': '/tools/buildbot/bin/python'} 17:10:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:10:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:10:11 INFO - Running setup.py (path:/tmp/pip-4Qs6Dv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:10:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:10:11 INFO - Running setup.py (path:/tmp/pip-EVwHCQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:10:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:10:11 INFO - Running setup.py (path:/tmp/pip-Fa8nHE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:10:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:10:11 INFO - Running setup.py (path:/tmp/pip-SqvPrh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:10:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:10:11 INFO - Running setup.py (path:/tmp/pip-MpQo9b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:10:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:10:11 INFO - Running setup.py (path:/tmp/pip-SJ68VA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:10:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:10:12 INFO - Running setup.py (path:/tmp/pip-QK5EX8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:10:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:10:12 INFO - Running setup.py (path:/tmp/pip-83Sogh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:10:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:10:12 INFO - Running setup.py (path:/tmp/pip-_EDLYS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:10:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:10:12 INFO - Running setup.py (path:/tmp/pip-m3iOUA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:10:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:10:12 INFO - Running setup.py (path:/tmp/pip-htG6Nc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:10:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:10:12 INFO - Running setup.py (path:/tmp/pip-q25pA2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:10:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:10:12 INFO - Running setup.py (path:/tmp/pip-BaieJD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:10:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:10:12 INFO - Running setup.py (path:/tmp/pip-fUpCVi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:10:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:10:12 INFO - Running setup.py (path:/tmp/pip-ZxZ4nn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:10:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:10:12 INFO - Running setup.py (path:/tmp/pip-OQ1Umg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:10:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:10:12 INFO - Running setup.py (path:/tmp/pip-VARRYe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:10:12 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:10:12 INFO - Running setup.py install for manifestparser 17:10:12 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:10:12 INFO - Running setup.py install for mozcrash 17:10:12 INFO - Running setup.py install for mozdebug 17:10:13 INFO - Running setup.py install for mozdevice 17:10:13 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:10:13 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:10:13 INFO - Running setup.py install for mozfile 17:10:13 INFO - Running setup.py install for mozhttpd 17:10:13 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:10:13 INFO - Running setup.py install for mozinfo 17:10:13 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:10:13 INFO - Running setup.py install for mozInstall 17:10:13 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:10:13 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:10:13 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:10:13 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:10:13 INFO - Running setup.py install for mozleak 17:10:13 INFO - Running setup.py install for mozlog 17:10:13 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:10:13 INFO - Running setup.py install for moznetwork 17:10:13 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:10:13 INFO - Running setup.py install for mozprocess 17:10:14 INFO - Running setup.py install for mozprofile 17:10:14 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:10:14 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:10:14 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:10:14 INFO - Running setup.py install for mozrunner 17:10:14 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:10:14 INFO - Running setup.py install for mozscreenshot 17:10:14 INFO - Running setup.py install for moztest 17:10:14 INFO - Running setup.py install for mozversion 17:10:14 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:10:14 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:10:14 INFO - Cleaning up... 17:10:14 INFO - Return code: 0 17:10:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:10:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:10:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:10:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:10:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:10:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:10:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:10:14 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 0x7f80d878ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x198d350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a1c1c0>, '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 0x1a1d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a1d550>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1465430985.230124-1110190402', '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 17:10:14 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 17:10:14 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 17:10:14 INFO - Using env: {'DISPLAY': ':0', 17:10:14 INFO - 'HOME': '/home/cltbld', 17:10:14 INFO - 'LANG': 'en_US.UTF-8', 17:10:14 INFO - 'LANGUAGE': 'en_US:en', 17:10:14 INFO - 'LOGNAME': 'cltbld', 17:10:14 INFO - 'MAIL': '/var/mail/cltbld', 17:10:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:10:14 INFO - 'MOZ_NO_REMOTE': '1', 17:10:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:10:14 INFO - 'NO_EM_RESTART': '1', 17:10:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:10:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:10:14 INFO - 'PWD': '/builds/slave/test', 17:10:14 INFO - 'SHELL': '/bin/bash', 17:10:14 INFO - 'SHLVL': '1', 17:10:14 INFO - 'TERM': 'linux', 17:10:14 INFO - 'TMOUT': '86400', 17:10:14 INFO - 'USER': 'cltbld', 17:10:14 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1465430985.230124-1110190402', 17:10:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:10:14 INFO - '_': '/tools/buildbot/bin/python'} 17:10:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:10:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:10:14 INFO - Running setup.py (path:/tmp/pip-EPDc8v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:10:14 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)) 17:10:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:10:14 INFO - Running setup.py (path:/tmp/pip-rOY11O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:10:14 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)) 17:10:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:10:14 INFO - Running setup.py (path:/tmp/pip-5vgabJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:10:15 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)) 17:10:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:10:15 INFO - Running setup.py (path:/tmp/pip-gRrYNO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:10:15 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)) 17:10:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:10:15 INFO - Running setup.py (path:/tmp/pip-8GK9nv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:10:15 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)) 17:10:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:10:15 INFO - Running setup.py (path:/tmp/pip-_cExmS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:10:15 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)) 17:10:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:10:15 INFO - Running setup.py (path:/tmp/pip-emMIcR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:10:15 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)) 17:10:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:10:15 INFO - Running setup.py (path:/tmp/pip-8mAYB3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:10:15 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)) 17:10:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:10:15 INFO - Running setup.py (path:/tmp/pip-ZIpRYX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:10:15 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)) 17:10:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:10:15 INFO - Running setup.py (path:/tmp/pip-Ls7uPZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:10:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 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)) 17:10:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:10:15 INFO - Running setup.py (path:/tmp/pip-Qhs938-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:10:15 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)) 17:10:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:10:15 INFO - Running setup.py (path:/tmp/pip-vURUsc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:10:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 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)) 17:10:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:10:15 INFO - Running setup.py (path:/tmp/pip-iuXNv6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:10:15 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)) 17:10:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:10:15 INFO - Running setup.py (path:/tmp/pip-Ysgxlu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:10:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 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)) 17:10:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:10:15 INFO - Running setup.py (path:/tmp/pip-vdd51x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:10:15 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)) 17:10:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:10:15 INFO - Running setup.py (path:/tmp/pip-cJePDc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:10:16 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)) 17:10:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:10:16 INFO - Running setup.py (path:/tmp/pip-dNfRrG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:10:16 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)) 17:10:16 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)) 17:10:16 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)) 17:10:16 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)) 17:10:16 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)) 17:10:16 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)) 17:10:16 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:10:16 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 17:10:16 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 17:10:16 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 17:10:16 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 17:10:16 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 17:10:16 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 17:10:17 INFO - Downloading blessings-1.6.tar.gz 17:10:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:10:18 INFO - Installing collected packages: blessings 17:10:18 INFO - Running setup.py install for blessings 17:10:18 INFO - Successfully installed blessings 17:10:18 INFO - Cleaning up... 17:10:18 INFO - Return code: 0 17:10:18 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:10:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:10:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:10:18 INFO - Reading from file tmpfile_stdout 17:10:18 INFO - Current package versions: 17:10:18 INFO - argparse == 1.2.1 17:10:18 INFO - blessings == 1.6 17:10:18 INFO - blobuploader == 1.2.4 17:10:18 INFO - docopt == 0.6.1 17:10:18 INFO - functools32 == 3.2.3-2 17:10:18 INFO - jsonschema == 2.5.1 17:10:18 INFO - manifestparser == 1.1 17:10:18 INFO - mozInstall == 1.12 17:10:18 INFO - mozcrash == 0.17 17:10:18 INFO - mozdebug == 0.1 17:10:18 INFO - mozdevice == 0.48 17:10:18 INFO - mozfile == 1.2 17:10:18 INFO - mozhttpd == 0.7 17:10:18 INFO - mozinfo == 0.9 17:10:18 INFO - mozleak == 0.1 17:10:18 INFO - mozlog == 3.2 17:10:18 INFO - moznetwork == 0.27 17:10:18 INFO - mozprocess == 0.22 17:10:18 INFO - mozprofile == 0.28 17:10:18 INFO - mozrunner == 6.11 17:10:18 INFO - mozscreenshot == 0.1 17:10:18 INFO - mozsystemmonitor == 0.3 17:10:18 INFO - moztest == 0.7 17:10:18 INFO - mozversion == 1.4 17:10:18 INFO - psutil == 3.1.1 17:10:18 INFO - requests == 1.2.3 17:10:18 INFO - wsgiref == 0.1.2 17:10:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:10:18 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:10:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:10:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:10:18 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:10:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:10:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:10:18 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 0x7f80d878ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x198d350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a1c1c0>, '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 0x1a1d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a1d550>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1465430985.230124-1110190402', '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 17:10:18 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 17:10:18 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 17:10:18 INFO - Using env: {'DISPLAY': ':0', 17:10:18 INFO - 'HOME': '/home/cltbld', 17:10:18 INFO - 'LANG': 'en_US.UTF-8', 17:10:18 INFO - 'LANGUAGE': 'en_US:en', 17:10:18 INFO - 'LOGNAME': 'cltbld', 17:10:18 INFO - 'MAIL': '/var/mail/cltbld', 17:10:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:10:18 INFO - 'MOZ_NO_REMOTE': '1', 17:10:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:10:18 INFO - 'NO_EM_RESTART': '1', 17:10:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:10:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:10:18 INFO - 'PWD': '/builds/slave/test', 17:10:18 INFO - 'SHELL': '/bin/bash', 17:10:18 INFO - 'SHLVL': '1', 17:10:18 INFO - 'TERM': 'linux', 17:10:18 INFO - 'TMOUT': '86400', 17:10:18 INFO - 'USER': 'cltbld', 17:10:18 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1465430985.230124-1110190402', 17:10:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:10:18 INFO - '_': '/tools/buildbot/bin/python'} 17:10:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:10:18 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)) 17:10:18 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)) 17:10:18 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)) 17:10:18 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)) 17:10:18 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)) 17:10:18 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)) 17:10:18 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)) 17:10:18 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)) 17:10:18 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)) 17:10:18 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)) 17:10:18 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)) 17:10:18 INFO - Cleaning up... 17:10:18 INFO - Return code: 0 17:10:18 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:10:18 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:10:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:10:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:10:18 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:10:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:10:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:10:18 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 0x7f80d878ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x198d350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a1c1c0>, '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 0x1a1d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a1d550>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1465430985.230124-1110190402', '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 17:10:18 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 17:10:18 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 17:10:18 INFO - Using env: {'DISPLAY': ':0', 17:10:18 INFO - 'HOME': '/home/cltbld', 17:10:18 INFO - 'LANG': 'en_US.UTF-8', 17:10:18 INFO - 'LANGUAGE': 'en_US:en', 17:10:18 INFO - 'LOGNAME': 'cltbld', 17:10:18 INFO - 'MAIL': '/var/mail/cltbld', 17:10:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:10:18 INFO - 'MOZ_NO_REMOTE': '1', 17:10:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:10:18 INFO - 'NO_EM_RESTART': '1', 17:10:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:10:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:10:18 INFO - 'PWD': '/builds/slave/test', 17:10:18 INFO - 'SHELL': '/bin/bash', 17:10:18 INFO - 'SHLVL': '1', 17:10:18 INFO - 'TERM': 'linux', 17:10:18 INFO - 'TMOUT': '86400', 17:10:18 INFO - 'USER': 'cltbld', 17:10:18 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1465430985.230124-1110190402', 17:10:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:10:18 INFO - '_': '/tools/buildbot/bin/python'} 17:10:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:10:18 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:10:18 INFO - Cleaning up... 17:10:18 INFO - Return code: 0 17:10:18 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 17:10:18 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:10:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:10:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:10:18 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:10:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:10:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:10:18 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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f80d878ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x198d350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a1c1c0>, '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 0x1a1d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a1d550>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1465430985.230124-1110190402', '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 17:10:18 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', 'flake8'] in /builds/slave/test/build 17:10:18 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 flake8 17:10:18 INFO - Using env: {'DISPLAY': ':0', 17:10:18 INFO - 'HOME': '/home/cltbld', 17:10:18 INFO - 'LANG': 'en_US.UTF-8', 17:10:18 INFO - 'LANGUAGE': 'en_US:en', 17:10:18 INFO - 'LOGNAME': 'cltbld', 17:10:18 INFO - 'MAIL': '/var/mail/cltbld', 17:10:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:10:18 INFO - 'MOZ_NO_REMOTE': '1', 17:10:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:10:18 INFO - 'NO_EM_RESTART': '1', 17:10:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:10:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:10:18 INFO - 'PWD': '/builds/slave/test', 17:10:18 INFO - 'SHELL': '/bin/bash', 17:10:18 INFO - 'SHLVL': '1', 17:10:18 INFO - 'TERM': 'linux', 17:10:18 INFO - 'TMOUT': '86400', 17:10:18 INFO - 'USER': 'cltbld', 17:10:18 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1465430985.230124-1110190402', 17:10:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:10:18 INFO - '_': '/tools/buildbot/bin/python'} 17:10:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:10:19 INFO - Downloading/unpacking flake8 17:10:19 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 17:10:19 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 17:10:19 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 17:10:19 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 17:10:19 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 17:10:19 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 17:10:20 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 17:10:21 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 17:10:21 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 17:10:21 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 17:10:21 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 17:10:21 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 17:10:21 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 17:10:21 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 17:10:21 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 17:10:21 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 17:10:21 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 17:10:21 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 17:10:21 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 17:10:21 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 17:10:21 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 17:10:21 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 17:10:21 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 17:10:21 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 17:10:21 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 17:10:21 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 17:10:21 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 17:10:21 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 17:10:21 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 17:10:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 17:10:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:10:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:10:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:10:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:10:21 INFO - no previously-included directories found matching 'docs/_build' 17:10:21 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 17:10:21 INFO - Running setup.py install for pep8 17:10:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:10:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:10:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:10:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:10:21 INFO - no previously-included directories found matching 'docs/_build' 17:10:21 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 17:10:21 INFO - Successfully installed flake8 mccabe pyflakes pep8 17:10:21 INFO - Cleaning up... 17:10:21 INFO - Return code: 0 17:10:21 INFO - Running post-action listener: _resource_record_post_action 17:10:21 INFO - Running post-action listener: _start_resource_monitoring 17:10:22 INFO - Starting resource monitoring. 17:10:22 INFO - ##### 17:10:22 INFO - ##### Finished create-virtualenv step (success) 17:10:22 INFO - ##### 17:10:22 INFO - ##### 17:10:22 INFO - ##### Running install step. 17:10:22 INFO - ##### 17:10:22 INFO - Running pre-action listener: _resource_record_pre_action 17:10:22 INFO - Running main action method: install 17:10:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:10:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:10:22 INFO - Reading from file tmpfile_stdout 17:10:22 INFO - Detecting whether we're running mozinstall >=1.0... 17:10:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:10:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:10:22 INFO - Reading from file tmpfile_stdout 17:10:22 INFO - Output received: 17:10:22 INFO - Usage: mozinstall [options] installer 17:10:22 INFO - Options: 17:10:22 INFO - -h, --help show this help message and exit 17:10:22 INFO - -d DEST, --destination=DEST 17:10:22 INFO - Directory to install application into. [default: 17:10:22 INFO - "/builds/slave/test"] 17:10:22 INFO - --app=APP Application being installed. [default: firefox] 17:10:22 INFO - mkdir: /builds/slave/test/build/application 17:10:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 17:10:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 17:10:39 INFO - Reading from file tmpfile_stdout 17:10:39 INFO - Output received: 17:10:39 INFO - /builds/slave/test/build/application/firefox/firefox 17:10:39 INFO - Running post-action listener: _resource_record_post_action 17:10:39 INFO - ##### 17:10:39 INFO - ##### Finished install step (success) 17:10:39 INFO - ##### 17:10:39 INFO - ##### 17:10:39 INFO - ##### Running run-tests step. 17:10:39 INFO - ##### 17:10:39 INFO - Running pre-action listener: _resource_record_pre_action 17:10:39 INFO - Running main action method: run_tests 17:10:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:10:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:10:39 INFO - Python 2.7.3 17:10:39 INFO - Return code: 0 17:10:39 INFO - grabbing minidump binary from tooltool 17:10:39 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:10:39 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 0x1a1c1c0>, '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 0x1a1d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a1d550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:10:39 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 17:10:39 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 17:10:39 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 17:10:39 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:10:39 INFO - Return code: 0 17:10:39 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:10:39 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:10:39 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:10:39 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:10:39 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:10:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 17:10:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 17:10:40 INFO - Return code: 0 17:10:40 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bJEfQ-NhQuCzc0N3W4tp8Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-006', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 17:10:40 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-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/bJEfQ-NhQuCzc0N3W4tp8Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-006 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 17:10:40 INFO - Using env: {'DISPLAY': ':0', 17:10:40 INFO - 'HOME': '/home/cltbld', 17:10:40 INFO - 'LANG': 'en_US.UTF-8', 17:10:40 INFO - 'LANGUAGE': 'en_US:en', 17:10:40 INFO - 'LOGNAME': 'cltbld', 17:10:40 INFO - 'MAIL': '/var/mail/cltbld', 17:10:40 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:10:40 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:10:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:10:40 INFO - 'MOZ_NO_REMOTE': '1', 17:10:40 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:10:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:10:40 INFO - 'NO_EM_RESTART': '1', 17:10:40 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:10:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:10:40 INFO - 'PWD': '/builds/slave/test', 17:10:40 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:10:40 INFO - 'SHELL': '/bin/bash', 17:10:40 INFO - 'SHLVL': '1', 17:10:40 INFO - 'TERM': 'linux', 17:10:40 INFO - 'TMOUT': '86400', 17:10:40 INFO - 'USER': 'cltbld', 17:10:40 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1465430985.230124-1110190402', 17:10:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:10:40 INFO - '_': '/tools/buildbot/bin/python'} 17:10:40 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bJEfQ-NhQuCzc0N3W4tp8Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-006', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 17:10:40 INFO - mozversion application_buildid: 20160608143002 17:10:40 INFO - mozversion application_changeset: 97074800423c429ca7ae01ca5db8c2e61b0fee17 17:10:40 INFO - mozversion application_display_name: Nightly 17:10:40 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:10:40 INFO - mozversion application_name: Firefox 17:10:40 INFO - mozversion application_remotingname: firefox 17:10:40 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 17:10:40 INFO - mozversion application_vendor: Mozilla 17:10:40 INFO - mozversion application_version: 50.0a1 17:10:40 INFO - mozversion platform_buildid: 20160608143002 17:10:40 INFO - mozversion platform_changeset: 97074800423c429ca7ae01ca5db8c2e61b0fee17 17:10:40 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 17:10:40 INFO - mozversion platform_version: 50.0a1 17:10:40 INFO - using testdate: 1465431040 17:10:40 INFO - actual date: 1465431040 17:10:40 INFO - starting webserver on 'localhost:33920' 17:10:40 INFO - SUITE-START | Running 2 tests 17:10:40 INFO - TEST-START | dromaeo_css 17:10:40 INFO - operating with platform_type : linux_ 17:10:40 INFO - Initialising browser for dromaeo_css test... 17:10:40 INFO - TEST-INFO | started process 7758 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfGXwKF/profile http://localhost:33920/getInfo.html) 17:10:44 INFO - PROCESS | 7758 | __metrics Screen width/height:1600/1200 17:10:44 INFO - PROCESS | 7758 | colorDepth:24 17:10:44 INFO - PROCESS | 7758 | Browser inner width/height: 1024/697 17:10:44 INFO - PROCESS | 7758 | __metrics 17:10:45 ERROR - PROCESS | 7758 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 17:10:46 INFO - TEST-INFO | 7758: exit 0 17:10:46 INFO - Browser initialized. 17:10:46 INFO - Running cycle 1/1 for dromaeo_css test... 17:10:46 INFO - TEST-INFO | started process 7877 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfGXwKF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:10:58 INFO - PROCESS | 7877 | RSS: Main: 167387136 17:10:58 INFO - PROCESS | 7877 | 17:11:47 INFO - PROCESS | 7877 | 1465431107660 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] 17:13:54 INFO - PROCESS | 7877 | Cycle 1(1): loaded http://localhost:33920/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33920/tests/dromaeo/cssquery-ext.html) 17:13:55 INFO - PROCESS | 7877 | RSS: Main: 170647552 17:13:55 INFO - PROCESS | 7877 | 17:16:58 INFO - PROCESS | 7877 | Cycle 1(1): loaded http://localhost:33920/tests/dromaeo/cssquery-ext.html (next: http://localhost:33920/tests/dromaeo/cssquery-jquery.html) 17:16:58 INFO - PROCESS | 7877 | RSS: Main: 170586112 17:16:58 INFO - PROCESS | 7877 | 17:20:00 INFO - PROCESS | 7877 | Cycle 1(1): loaded http://localhost:33920/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33920/tests/dromaeo/cssquery-mootools.html) 17:20:01 INFO - PROCESS | 7877 | RSS: Main: 172056576 17:20:01 INFO - PROCESS | 7877 | 17:23:02 INFO - PROCESS | 7877 | Cycle 1(1): loaded http://localhost:33920/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33920/tests/dromaeo/cssquery-prototype.html) 17:23:03 INFO - PROCESS | 7877 | RSS: Main: 169046016 17:23:03 INFO - PROCESS | 7877 | 17:26:06 INFO - PROCESS | 7877 | Cycle 1(1): loaded http://localhost:33920/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33920/tests/dromaeo/cssquery-yui.html) 17:26:06 INFO - PROCESS | 7877 | RSS: Main: 171368448 17:26:06 INFO - PROCESS | 7877 | 17:29:09 INFO - PROCESS | 7877 | Cycle 1(1): loaded http://localhost:33920/tests/dromaeo/cssquery-yui.html (next: http://localhost:33920/tests/dromaeo/cssquery-dojo.html) 17:29:09 INFO - PROCESS | 7877 | RSS: Main: 172085248 17:29:09 INFO - PROCESS | 7877 | 17:29:09 INFO - PROCESS | 7877 | __start_tp_report 17:29:09 INFO - PROCESS | 7877 | _x_x_mozilla_page_load 17:29:09 INFO - PROCESS | 7877 | _x_x_mozilla_page_load_details 17:29:09 INFO - PROCESS | 7877 | |i|pagename|runs| 17:29:09 INFO - PROCESS | 7877 | |0;dojo.html;3141.403133404653;3185.9840700796494;3192.4892017277234;3223.7421006319482;3234.822084785337;5358.464153584644;5390.541803946664;5400.972995135024;5437.32033495813;5442.156465747806;5254.054270231366;5309.548688361494;5396.487333703301;5442.102053161224;5464.972675136629;4834.2265237562;4847.587955023819;4860.1008813369635;4922.655414121013;4973.0551195272965;635.6647458945585;4899.730514821684;4949.628777841658;4955;5000.049990501811;4763.04739052191;4922.458529561745;4983.750812459362;5001.649884508086;5010.624203184758;4992.47579004203;5011.072951503984;5020.397552293712;5032.220005899091;5084.644074914758;4732.1482133216;4824.565789078964;4969.378827646544;5002.699838009731;5008.624353173526;5353.250544923714;5397.514223719845;5409.594280428944;5456.83629491112;5490;5827.737751801179;5829.183914252008;5837.5913686041995;5839.795607153772;5874.206982057411;5487.5609951203805;5678.971605141989;5719.027765279912;5793.362730099686;5801.071828507461;5376.542993845528;5389.78440862365;5413.133898576249;5427.728613569345;5431.34823821144;5885.941140588625;5896.262967129109;5900.704964751745;5941.7623295067715;5951.970240148771;5499.890002199933;5637.351704553947;5639.8590035249445;5673.3475650299915;5761.279840019997;5725.1698503716725;5745.540356771448;5766;5819.941800582024;5864.501517371071;5711.571632127607;5724.370319264877;5740.942590574125;5762.1068734346245;5776.277965254343;5802.82591522255;5882.735276912549;5885.764569417175;5909.556783241274;5919.378465261172;4379.737215767064;4390.956090439118;4391.8682439526865;4430.379746835446;4445.51099379068;3854.383298672199;3890;3968.2857085724845;3977.801109944549;3998.140399814054;5307.495787900143;5430.647007944471;5505.504504594525;5548.91676624851;5595.944040559623;5748.655080695172;5820.35976042635;5834.504067154255;5843.0066888629035;5848.502877255481;5350.571954243651;5391.245225668409;5554.055810512223;5575.275214222206;5582.7766889323975;4929.433115191727;4943.65394422387;4985.5762260208285;4987.401511818605;5006.89986200274;5924.20023296858;5993.250843644457;6028.367021462684;6039.758409663652;6041.607295525777;5652.576056795839;5777.682227477361;5818.127280907813;5821.097729851795;5826.533877289722;6042.818715438544;6080.6351618901235;6087.604305720114;6097.390260973867;6107.297660769068;5762.510186634183;5769.59612827098;5771.7402716877;5772.451617096369;5774.595778295647;5617.157426386075;5723.170140329546;5771.307443106854;5789.623674461147;5881.206037184926;5649.322081350264;5654.547636189012;5677.432256774289;5678.403767604342;5686.147077938343;5618.606697531133;5655.943440565707;5657.688827114548;5660.122680984454;5664.405237450009;5318.282031925795;5516.089845175501;5571.665700057847;5586.13414920688;5648.124540696034;5689.146628005832;5729.455701708331;5757.65454072757;5767.134929760569;5790.1893734877995;5391.083515802401;5588.86027849307;5656.349519805275;5657.066584013756;5660.688662123623 17:29:09 INFO - PROCESS | 7877 | |1;ext.html;579.5479525969743;617.9845503862402;628.3747671067289;639.8368416053906;666.6666666666664;41509.377359339596;43184;43221;46885.29672054922;46925.765371173096;43591;44251.77874110633;44266.77866610663;44331.33502997449;44430.11139777202;8666.176713212251;8824.338174636896;8880.24517915978;8880.955595222047;8883.777905552348;8735.95632021839;8755.95622021889;8794.956025219864;8839.690610828622;8854.158854908774;8826.249768769661;8860.601272942733;8870.86693699595;8899.33255005874;8903.24322432594;8831.73504794854;8867.822643547157;8871.423357481808;8885.289176865868;8891;8700.608472618747;8782.077881822444;8800.779980500538;8834.64661413549;8845.469271843709;40815.7959210205;40972.385414218814;41055.384169237484;41352.37971430431;41495.7925210375;3219.2917558137174;3625.6011838697723;3657.65252301031;3904.7852368119743;3931.6461518463475;30641.233969150726;31133.221669458217;31297.8435107823;33010.339793204;33030.339393212;4065.532463766675;4069.1658210066867;4146.543880173179;4200.537940826537;4201.621854033121;315496;316556;317126;317372;318561.40719296486;54879.451205488236;55070.44929550734;55355.72322138363;55477.1678424824;55532;34575.65424345775;35335;35420.291594167975;37276.25447491035;37294.50821967091;17310.65378692419;17447.651046979245;17463.47609571715;17469.213885374935;17528;13173.47306107764;13423.731525369438;13449.798253026212;13454.93272533631;13460.528881489297;19077.236910523425;19131.23475060982;19149.90425047866;19183.52041198981;19284.614307713768;7075.964620176866;7103.396211322096;7158.06945097134;7158.427325813923;7179.246179151219;1016.2276669731058;1065.8561094252332;1170.9590164344206;1174.8413964114907;1188.6731148933939;31148.53277200844;31367.372652546823;31466.213344666565;31697.8415107923;31794.364112718078;1084.295208114716;1152.8501294831785;1178.0869825885009;1182.1075088308273;1201.8497687789027;16069.758953615705;16492.83507164937;16666.16669166561;16747.330106795835;16963.15184240783;489425;491237;491887;494721;495376;38647.22705545873;39588;39729.40405893914;39752.801235994215;39803.2039359217;1350.9870293263164;1385.3696568061507;1387.4034165308813;1390.3743315507859;1396.7346204221164;29889.028109883326;31160.68839311578;31413.685863141076;31844.840775795972;31897.68102318947;48840.2673959898;48922.75538622284;49321.26018109659;49381.506184937694;49410.258846116616;413129;415071;416255;416941;416949;27099;27106.72893271121;27506.449871002867;27556.724432755414;27742.86128569344;46388;47203.52796471991;47210.763946181425;47457.525424746695;47755;38706;39829.80085099556;40234.79882600568;40602.9849253771;41093;39359.40960885532;41029;41396;41681.79159104306;41769;36166;39310.2137957245;40081;41285.58714412817;41318.38022429606;35736;36451.27097458089;37026.62973370232;37043.25913481662;37156.44265335968;27566.862165689043;28049.29876753016;28072.409624768752;28128.578071329357;28340.25781920851 17:29:09 INFO - PROCESS | 7877 | |2;jquery.html;388.2681146039714;394.615250131122;397.46937837986286;403.32845811723485;417.51985217000447;13595.728085438286;17679.469615911512;18618.255269789224;19257.229710811567;19295.13171907266;18134.727979080326;18368.81631183688;18474.44576662699;19458.416247512563;19497.805021949775;5507.614466987313;5589.664620122785;5694.145878118274;5726.62776919501;5731.054376027951;5595.21666966625;5641.435856414346;5714.114312281603;6606.2402823675175;6983.266756990519;6772.932270677279;6967;7047.577145371294;7062.929370706279;7089.8227544311285;6809.931900680979;7077.079979602644;7085.362317391434;7088.822779430504;7432.925670743278;7151.964240178766;7177.9282207177785;7183.640817959081;7188.928110718878;7206.963965180141;23534;24714.25857224268;25405.491890162095;25449.618255725993;26115.347116322246;2294.3919861236786;2301.298104078272;2341.683872677184;2355.823313251496;2418.3470462975074;15245.466408675644;15839.683206335809;15928;16134.193290335554;16327.83672163275;1941.1190566300863;2088.968665470019;2168.5662867426577;2174.9565008699738;2392.1866565367686;88547;93239.53380233055;94124;94264;95376.52311738467;15965.44120955761;17593.912030439766;17612.647747044986;17645.38241161553;18223;31745.20636984094;31865.362692746014;31872.20319491985;31948.68051319457;32279;9440.669576564787;9959.751006224902;10010.64962726301;10065.295429319878;10149.39103653783;8092.9190708092165;8112.269895709414;8136.088019315456;8312.127226641236;8444.113368096385;8717.433366831136;8889.4666320021;8914.37599368038;8960.775980600407;9099.225650997992;3576.6959808416054;3583.8606409596955;3631.128529153037;3645.781253124821;3734.2718169957143;940.6848705683673;971.7667759737612;1005.7083445800636;1021.6117875207523;1040.3341861208833;18841.905790471235;19122;19213.231470741015;19370.70943935842;19482.318118865773;948.5636607160645;948.5866059571327;949.2548349545574;959.3764053365229;988.0810845913226;10388.324758890649;10391.53238104287;10422.166226701846;10440;10730.409827459565;483568;489522;490233.84181553475;492737;495831;93974.5301273503;96440;97131;97425.51287243661;98372;1011.8785745710562;1053.6522947427331;1053.889341619119;1059.4755595979884;1068.0227591753614;16635.83364166343;16636.916815415847;17080.829191707922;17208.397706080228;17356.652866942844;38216.42675359928;38966.80516597399;39526.40710389289;39806.20387592174;40699.46444139993;56428;57040;57078.0059762837;57817.42182578288;58060.709696451246;8281.917180828115;8325.375596830141;8421.284190843848;8670.436421632574;8725.345599079967;9535.23718102564;12547.749045018865;13106.148100373826;13204.075714699879;13376;11302.378369189773;11608.361540115375;11681.182317237712;11769.352685602375;11873.406329683308;11464;11501.53993840237;11776.116791240862;11793.233439826385;11960.940195298968;10643.521041552995;11353.432328383382;11477.82783258235;11583.6524904253;11811.468483918072;8077.27304542594;8221.876671850046;8360.12218717026;8387.790305242417;8515.446495977742;10627.415492148006;11086.944565277123;11174;11217.60738374153;11550 17:29:09 INFO - PROCESS | 7877 | |3;mootools.html;1519.5289460267318;1539.5766164304819;1684.1410880450967;1806.5765374615112;1812.5559237986688;7929.365650747941;8844.292456603473;8848.601812918418;9454.669086581971;9459.905400945998;8951.104889511045;9164.083591640832;9191.448513089203;9252.074792520745;9260.305477089212;2318.6058370077085;2367.2898130560848;2368.9576586301973;2370.01644317608;2370.8340416170877;2291.472961218921;2319.130326127702;2355.3522781235124;2359.516299158677;2364.219807463533;2337.439014636492;2340.6723058771786;2346.2022912209845;2360.0795689680954;2373.1338061607476;2234.72065991751;2235.6870038194666;2237.2617036377956;2251.7185351831104;2304.585174668559;2254.571631390047;2256.3231030690727;2258.040332858545;2265.0486795545744;2268.160780511205;9159.679411220575;9195.08049195082;9212.815743685156;9228.8615670765;9246.815063698756;5090.287359769635;5220.973895130538;5228.294180285651;5237.528622423962;5239.371275446971;3199.4560924642633;3229.3056992746674;3375.7974521528786;3402.2855200407944;3421.81180035098;1064.8775390830076;1121.478512491687;1124.4434005167413;1125.5385292030228;1128.5598616539555;12885.098043136984;12957.546485873043;12989.090763646549;13007.674808129872;13023.674408139777;4519.977400112978;4653.278741795028;4701.506341834058;4731.503192164773;4762.78567464465;10861.782764344669;10865.402402867918;10867.510962006729;10875.78248435027;10893.945530272456;5327;5345.438728933484;5360.410354860962;5405.702686352289;5417;4294.957050429518;4664.416947881515;4774.95225047745;4805.8558243252055;4993;3990.3016972029777;4008.158286759813;4067.5525692173837;4068.2066996935905;4154.729942553724;1237.9319137447526;1254.1158483269273;1257.2645002673355;1265.9177153484993;1268.055298802398;880.9955950220208;1024.9077583017565;1027.4708525109575;1030.5002073994108;1042.0881728487573;6112.572119951649;6199.256089269316;6284.245890493079;6319.24169099711;6360.968195158995;440.74877319927333;442.5640743867288;447.7112262590611;447.83653966302717;451.7402493566147;4301.935470967938;4359.673024523174;4360.847370342023;4361.978190109029;4370.847020354272;11147.888521114848;11384.658460246206;11396.715082122848;11433.485493152828;11528.884711152949;10664.360138391567;10940.288881222696;11253.943730281297;11282.323060616389;11382.943085284685;8453.873191902127;8606.397552171287;8660.653573856975;8709;8716.78208044804;6137.60105593135;6375.139356187041;6384.45732112757;6414.03789431589;6422.582532135396;10532.368057916243;10600.363978161335;10686.839697404701;10699.411532365795;10750.623728169476;9943.552540135855;10369.222308326755;10376.118029967236;10632.681019569425;10692;7270.781876543712;7758.88361674564;8005.8398832024195;8055.798605034921;8165.836683266182;8996.145366190201;9002.50486223264;9024.774380640274;9040.63837446521;9139.680111196076;7906.130325664058;8035.718749843727;8059.597020148852;8065.516069035877;8282.875756863532;7800.141984381827;7874.842503150019;7875.921240787748;7926.24700653437;7940.563269020028;7261.092363454568;7300;7338.229485904117;7360.1535823381;7393.186749457663;5140.357455318085;5276.762545685377;5484.670919744828;5525.972370138124;5575.275214222125;5421.945780542144;5445.346558413015;5478.616496845182;5607.2149899014985;5611.80358687444 17:29:09 INFO - PROCESS | 7877 | |4;prototype.html;315.6653946816375;327.6363236807144;329.9241174529858;330.40691957935536;330.7420212234457;5538.141588053848;5584.46947539983;5624.381318055016;5636.4363563643665;5760.164776107462;5615.943840561593;5659.830205093844;5716.39977802331;5727.341355744091;5737.741801618927;4379.868603941887;4382.758948257844;4388.727269091975;4397.582229688182;4398.824047038114;4123.886550631328;4151.111244383813;4243.957560424403;4281.336392859112;4285.764282964436;4210.705250632457;4226.598473145046;4250.553691862357;4252.532221455637;4253.680973926952;4252.766097864616;4274.658027357804;4279.764612946286;4281.544274946533;4283.850065247717;3575.6781889629797;3658.1951970566433;3720.2373513429684;3720.7023438124884;3724.9627503724887;5239.21411788231;5346.304980352529;5366.570674346082;5383.353997520284;5406.243125962368;4869.8782530436665;4882.487338829407;4898.289747986522;4909.22628714775;4954.826581069681;5561.58288128392;5811.5350771938565;5831.183634291203;5838.328592211908;5880.353161152269;4102.835886564534;4104.958950410488;4115.835366585333;4131.256373852705;4132.830264111336;5889.760631652574;6110;6191.349908259613;6200.162977998003;6253.404836992642;4161.479815023122;4187.43469631602;4187.769672668032;4204.5375008749015;4205.453291072141;4236.618704316565;4255.510616279105;4268.487781466182;4269.462993322401;4273.67947403946;4902.7058376497525;4916.5820905222745;4950.282209079735;4964.726940018261;4978.751062446936;5576.693281869455;5918.940810591925;5923.614965027259;5925.200097986803;5925.259342582177;1442.5239670908575;1477.8448262932452;1482.303317440801;1488.8064551608438;1495.4167874528941;905.5789058087889;930.265090578449;946.6024269806697;946.6260826973445;946.8863736351544;5079.187330027252;5085.542301192911;5583.330000399978;5658.405867383865;5799.739011744482;6055.878882422327;6057.183974096291;6098.75604975796;6109.725062372204;6153.4154255345675;5421.2952316199435;5728.255326807572;5768.644368573382;5780.277465316835;5780.855478612984;3227.8224697641385;3228.9838550807094;3257.696921231479;3270.705636492727;3272.5582046423906;6291.748330066837;6293.181886354836;6314.494840412756;6318.336574659595;6336.461400780985;5854.443827836349;6137.539684523678;6216.4405203531;6239.656818875005;6252.6873656317;6314.936850631527;6350.4284614384005;6359.395857393541;6397.7440902364315;6399.648019358887;6001.879962400641;6088.573799833969;6106.877862442815;6125.571210015256;6183;6068.4841788448475;6068.998615228438;6075.453209211192;6107.755689772537;6113.724882380393;6057.394790380465;6362.141110949962;6370.681465926593;6411.3909178627955;6417.406252498616;4208.558101399309;4232.576742325866;4245.830166793294;4258.5954334338185;4278.871633850989;5992.760289588542;6006.069059295816;6018.247719035121;6143.324234334309;6153.600015998945;5881.7647294107755;5931.851703707269;5956.463918247378;5970.5522085844605;6009.399060093956;5922.851928701644;5932.940670593412;5972.462478376967;5973.283206015306;5978.551608629283;5623.578231632726;5753.597248192754;5802.071668533014;5804.477597016289;5818.592698511233;5626.424601111696;5686;5871.823845284648;5886.705664716661;5891.58758886891;5674.290713660793;5756.712164391847;5812.505936995402;5814.244148260699;5823.195863412617 17:29:09 INFO - PROCESS | 7877 | |5;yui.html;656.8850451171044;664.7473959895245;682.00427376031;751.714348547552;761.779084065621;14583;15308.234588270583;15542.222888855555;15665.530034098967;15704;14193.574192774207;14308.35612397442;14332.785008224884;14335.56993290203;14417.279136043207;670.3631550027493;774.4578794843604;807.2049031703797;807.4791759315239;807.7657479330987;775.8758598624221;808.4785313472806;811.0632219786156;814.5519964019795;814.6822739131743;829.7593697827623;833.891594092767;834.56185502611;835.7743409279491;841.6170642357744;827.6523859978823;828;830.5971603772166;837;839.588601585225;607.380471918645;608.342989571262;610.7190692281556;611.1138848669402;611.1749138662814;14441.205733684643;14515.92742036283;14521.056131351428;14533.418663253457;14561.49034783788;14406.495772647908;14600.269986500633;14640.560783176521;14842.777358339634;14876.925615371854;10670.306430082097;10905.509252083675;10938.179636527293;11491.367974761384;11544.653660390202;3802.790846503441;4436.64506839452;4437.778111094464;4448.888777780549;4534.88662783433;65758.34241657618;73193.63403183004;73461.26538734598;73529;74183.62908185425;10601.469926503643;10826.18803589734;10863.293885897392;10868.836967445495;11041.33751974884;21134.154633814476;21262.893685531784;21267;21276.680849787266;21348.679769803464;8151.714689985822;8307.875381869277;8308.501489910625;8400.621972011275;8451.492910425271;4501.594856462869;4562.794674239667;4609.8847528811375;4629.745364004944;4644.256918892961;3536.2397084626414;3616.511770910946;3627.2020155565733;3638.290533345972;3645.6901163400876;581.1079992211935;588.6615196262167;590.6485641043572;597.9133025711247;604.3110853626869;668.6322522612544;679.8538314262457;698.7554355975368;738.7451329291385;746.9551826890404;9061.59222834974;9316.813663726687;9416.482093484925;9424.528773561431;9436.197923176469;659.6965395917836;698.671624336561;707.7204504220907;740.2190688823235;770.8535378278109;4180.143070670505;4371.912561748747;4420.226460369422;4438.933415998763;4466.1514312281215;108106;108688.45655771671;110910.44544777225;111166;114149;63992.68003660045;93950.5302473497;95136;95167;95263.52368238253;84636.57681711552;85017;85856.57071714601;86202.56898715466;86366.56816715877;9044.864327034968;9074.183323500916;9110;9148.399030169827;9235.353525253167;50308.74845625748;51407.22889156591;51989.480105199975;52917.73541132424;53311.200331994274;57102.428975709714;75121.62439187769;76940;77707.61146194233;79058.20941790509;10295.330803497749;10486.26596138263;10532;11318.943405283251;11981;12217.328046957147;12368.134230603771;12420.130590858553;12740.171888827197;12766;11773.882261177621;11846.644600661994;12028.398580071136;12120.393980301125;12612;11716.531338746354;11975.221610595283;12025.4588543514;12537.247765134121;12538.87461125377;11927.522899084286;12043.156979011384;12258;12840.871591283967;12860.292683902475;9865.457399843077;10094.141997929964;10107.848382274125;10143.08712215904;10394.428306442916;9945.353552019096;10177;10184.388936663823;10329.638462654071;10339.121174700234 17:29:09 INFO - PROCESS | 7877 | __end_tp_report 17:29:09 INFO - PROCESS | 7877 | __start_cc_report 17:29:09 INFO - PROCESS | 7877 | _x_x_mozilla_cycle_collect,337 17:29:09 INFO - PROCESS | 7877 | __end_cc_report 17:29:09 INFO - PROCESS | 7877 | __startTimestamp1465432149716__endTimestamp 17:29:09 INFO - PROCESS | 7877 | 17:29:09 INFO - PROCESS | 7877 | ------- Summary: start ------- 17:29:09 INFO - PROCESS | 7877 | Number of tests: 6 17:29:09 INFO - PROCESS | 7877 | 17:29:09 INFO - PROCESS | 7877 | [#0] dojo.html Cycles:165 Average:5358.74 Median:5617.16 stddev:712.28 (12.7%) stddev-sans-first:692.90 17:29:09 INFO - PROCESS | 7877 | Values: 3141.4 3186.0 3192.5 3223.7 3234.8 5358.5 5390.5 5401.0 5437.3 5442.2 5254.1 5309.5 5396.5 5442.1 5465.0 4834.2 4847.6 4860.1 4922.7 4973.1 635.7 4899.7 4949.6 4955.0 5000.0 4763.0 4922.5 4983.8 5001.6 5010.6 4992.5 5011.1 5020.4 5032.2 5084.6 4732.1 4824.6 4969.4 5002.7 5008.6 5353.3 5397.5 5409.6 5456.8 5490.0 5827.7 5829.2 5837.6 5839.8 5874.2 5487.6 5679.0 5719.0 5793.4 5801.1 5376.5 5389.8 5413.1 5427.7 5431.3 5885.9 5896.3 5900.7 5941.8 5952.0 5499.9 5637.4 5639.9 5673.3 5761.3 5725.2 5745.5 5766.0 5819.9 5864.5 5711.6 5724.4 5740.9 5762.1 5776.3 5802.8 5882.7 5885.8 5909.6 5919.4 4379.7 4391.0 4391.9 4430.4 4445.5 3854.4 3890.0 3968.3 3977.8 3998.1 5307.5 5430.6 5505.5 5548.9 5595.9 5748.7 5820.4 5834.5 5843.0 5848.5 5350.6 5391.2 5554.1 5575.3 5582.8 4929.4 4943.7 4985.6 4987.4 5006.9 5924.2 5993.3 6028.4 6039.8 6041.6 5652.6 5777.7 5818.1 5821.1 5826.5 6042.8 6080.6 6087.6 6097.4 6107.3 5762.5 5769.6 5771.7 5772.5 5774.6 5617.2 5723.2 5771.3 5789.6 5881.2 5649.3 5654.5 5677.4 5678.4 5686.1 5618.6 5655.9 5657.7 5660.1 5664.4 5318.3 5516.1 5571.7 5586.1 5648.1 5689.1 5729.5 5757.7 5767.1 5790.2 5391.1 5588.9 5656.3 5657.1 5660.7 17:29:09 INFO - PROCESS | 7877 | 17:29:09 INFO - PROCESS | 7877 | [#1] ext.html Cycles:180 Average:56095.27 Median:40157.90 stddev:109736.15 (273.3%) stddev-sans-first:109964.82 17:29:09 INFO - PROCESS | 7877 | Values: 579.5 618.0 628.4 639.8 666.7 41509.4 43184.0 43221.0 46885.3 46925.8 43591.0 44251.8 44266.8 44331.3 44430.1 8666.2 8824.3 8880.2 8881.0 8883.8 8736.0 8756.0 8795.0 8839.7 8854.2 8826.2 8860.6 8870.9 8899.3 8903.2 8831.7 8867.8 8871.4 8885.3 8891.0 8700.6 8782.1 8800.8 8834.6 8845.5 40815.8 40972.4 41055.4 41352.4 41495.8 3219.3 3625.6 3657.7 3904.8 3931.6 30641.2 31133.2 31297.8 33010.3 33030.3 4065.5 4069.2 4146.5 4200.5 4201.6 315496.0 316556.0 317126.0 317372.0 318561.4 54879.5 55070.4 55355.7 55477.2 55532.0 34575.7 35335.0 35420.3 37276.3 37294.5 17310.7 17447.7 17463.5 17469.2 17528.0 13173.5 13423.7 13449.8 13454.9 13460.5 19077.2 19131.2 19149.9 19183.5 19284.6 7076.0 7103.4 7158.1 7158.4 7179.2 1016.2 1065.9 1171.0 1174.8 1188.7 31148.5 31367.4 31466.2 31697.8 31794.4 1084.3 1152.9 1178.1 1182.1 1201.8 16069.8 16492.8 16666.2 16747.3 16963.2 489425.0 491237.0 491887.0 494721.0 495376.0 38647.2 39588.0 39729.4 39752.8 39803.2 1351.0 1385.4 1387.4 1390.4 1396.7 29889.0 31160.7 31413.7 31844.8 31897.7 48840.3 48922.8 49321.3 49381.5 49410.3 413129.0 415071.0 416255.0 416941.0 416949.0 27099.0 27106.7 27506.4 27556.7 27742.9 46388.0 47203.5 47210.8 47457.5 47755.0 38706.0 39829.8 40234.8 40603.0 41093.0 39359.4 41029.0 41396.0 41681.8 41769.0 36166.0 39310.2 40081.0 41285.6 41318.4 35736.0 36451.3 37026.6 37043.3 37156.4 27566.9 28049.3 28072.4 28128.6 28340.3 17:29:09 INFO - PROCESS | 7877 | 17:29:09 INFO - PROCESS | 7877 | [#2] jquery.html Cycles:180 Average:30470.52 Median:3580.28 stddev:80999.49 (2262.4%) stddev-sans-first:81195.22 17:29:09 INFO - PROCESS | 7877 | Values: 388.3 394.6 397.5 403.3 417.5 13595.7 17679.5 18618.3 19257.2 19295.1 18134.7 18368.8 18474.4 19458.4 19497.8 5507.6 5589.7 5694.1 5726.6 5731.1 5595.2 5641.4 5714.1 6606.2 6983.3 6772.9 6967.0 7047.6 7062.9 7089.8 6809.9 7077.1 7085.4 7088.8 7432.9 7152.0 7177.9 7183.6 7188.9 7207.0 23534.0 24714.3 25405.5 25449.6 26115.3 2294.4 2301.3 2341.7 2355.8 2418.3 15245.5 15839.7 15928.0 16134.2 16327.8 1941.1 2089.0 2168.6 2175.0 2392.2 88547.0 93239.5 94124.0 94264.0 95376.5 15965.4 17593.9 17612.6 17645.4 18223.0 31745.2 31865.4 31872.2 31948.7 32279.0 9440.7 9959.8 10010.6 10065.3 10149.4 8092.9 8112.3 8136.1 8312.1 8444.1 8717.4 8889.5 8914.4 8960.8 9099.2 3576.7 3583.9 3631.1 3645.8 3734.3 940.7 971.8 1005.7 1021.6 1040.3 18841.9 19122.0 19213.2 19370.7 19482.3 948.6 948.6 949.3 959.4 988.1 10388.3 10391.5 10422.2 10440.0 10730.4 483568.0 489522.0 490233.8 492737.0 495831.0 93974.5 96440.0 97131.0 97425.5 98372.0 1011.9 1053.7 1053.9 1059.5 1068.0 16635.8 16636.9 17080.8 17208.4 17356.7 38216.4 38966.8 39526.4 39806.2 40699.5 56428.0 57040.0 57078.0 57817.4 58060.7 8281.9 8325.4 8421.3 8670.4 8725.3 9535.2 12547.7 13106.1 13204.1 13376.0 11302.4 11608.4 11681.2 11769.4 11873.4 11464.0 11501.5 11776.1 11793.2 11960.9 10643.5 11353.4 11477.8 11583.7 11811.5 8077.3 8221.9 8360.1 8387.8 8515.4 10627.4 11086.9 11174.0 11217.6 11550.0 17:29:09 INFO - PROCESS | 7877 | 17:29:09 INFO - PROCESS | 7877 | [#3] mootools.html Cycles:180 Average:5992.41 Median:445.14 stddev:3485.60 (783.0%) stddev-sans-first:3479.17 17:29:09 INFO - PROCESS | 7877 | Values: 1519.5 1539.6 1684.1 1806.6 1812.6 7929.4 8844.3 8848.6 9454.7 9459.9 8951.1 9164.1 9191.4 9252.1 9260.3 2318.6 2367.3 2369.0 2370.0 2370.8 2291.5 2319.1 2355.4 2359.5 2364.2 2337.4 2340.7 2346.2 2360.1 2373.1 2234.7 2235.7 2237.3 2251.7 2304.6 2254.6 2256.3 2258.0 2265.0 2268.2 9159.7 9195.1 9212.8 9228.9 9246.8 5090.3 5221.0 5228.3 5237.5 5239.4 3199.5 3229.3 3375.8 3402.3 3421.8 1064.9 1121.5 1124.4 1125.5 1128.6 12885.1 12957.5 12989.1 13007.7 13023.7 4520.0 4653.3 4701.5 4731.5 4762.8 10861.8 10865.4 10867.5 10875.8 10893.9 5327.0 5345.4 5360.4 5405.7 5417.0 4295.0 4664.4 4775.0 4805.9 4993.0 3990.3 4008.2 4067.6 4068.2 4154.7 1237.9 1254.1 1257.3 1265.9 1268.1 881.0 1024.9 1027.5 1030.5 1042.1 6112.6 6199.3 6284.2 6319.2 6361.0 440.7 442.6 447.7 447.8 451.7 4301.9 4359.7 4360.8 4362.0 4370.8 11147.9 11384.7 11396.7 11433.5 11528.9 10664.4 10940.3 11253.9 11282.3 11382.9 8453.9 8606.4 8660.7 8709.0 8716.8 6137.6 6375.1 6384.5 6414.0 6422.6 10532.4 10600.4 10686.8 10699.4 10750.6 9943.6 10369.2 10376.1 10632.7 10692.0 7270.8 7758.9 8005.8 8055.8 8165.8 8996.1 9002.5 9024.8 9040.6 9139.7 7906.1 8035.7 8059.6 8065.5 8282.9 7800.1 7874.8 7875.9 7926.2 7940.6 7261.1 7300.0 7338.2 7360.2 7393.2 5140.4 5276.8 5484.7 5526.0 5575.3 5421.9 5445.3 5478.6 5607.2 5611.8 17:29:09 INFO - PROCESS | 7877 | 17:29:09 INFO - PROCESS | 7877 | [#4] prototype.html Cycles:180 Average:4937.29 Median:5680.15 stddev:1491.26 (26.3%) stddev-sans-first:1454.54 17:29:09 INFO - PROCESS | 7877 | Values: 315.7 327.6 329.9 330.4 330.7 5538.1 5584.5 5624.4 5636.4 5760.2 5615.9 5659.8 5716.4 5727.3 5737.7 4379.9 4382.8 4388.7 4397.6 4398.8 4123.9 4151.1 4244.0 4281.3 4285.8 4210.7 4226.6 4250.6 4252.5 4253.7 4252.8 4274.7 4279.8 4281.5 4283.9 3575.7 3658.2 3720.2 3720.7 3725.0 5239.2 5346.3 5366.6 5383.4 5406.2 4869.9 4882.5 4898.3 4909.2 4954.8 5561.6 5811.5 5831.2 5838.3 5880.4 4102.8 4105.0 4115.8 4131.3 4132.8 5889.8 6110.0 6191.3 6200.2 6253.4 4161.5 4187.4 4187.8 4204.5 4205.5 4236.6 4255.5 4268.5 4269.5 4273.7 4902.7 4916.6 4950.3 4964.7 4978.8 5576.7 5918.9 5923.6 5925.2 5925.3 1442.5 1477.8 1482.3 1488.8 1495.4 905.6 930.3 946.6 946.6 946.9 5079.2 5085.5 5583.3 5658.4 5799.7 6055.9 6057.2 6098.8 6109.7 6153.4 5421.3 5728.3 5768.6 5780.3 5780.9 3227.8 3229.0 3257.7 3270.7 3272.6 6291.7 6293.2 6314.5 6318.3 6336.5 5854.4 6137.5 6216.4 6239.7 6252.7 6314.9 6350.4 6359.4 6397.7 6399.6 6001.9 6088.6 6106.9 6125.6 6183.0 6068.5 6069.0 6075.5 6107.8 6113.7 6057.4 6362.1 6370.7 6411.4 6417.4 4208.6 4232.6 4245.8 4258.6 4278.9 5992.8 6006.1 6018.2 6143.3 6153.6 5881.8 5931.9 5956.5 5970.6 6009.4 5922.9 5932.9 5972.5 5973.3 5978.6 5623.6 5753.6 5802.1 5804.5 5818.6 5626.4 5686.0 5871.8 5886.7 5891.6 5674.3 5756.7 5812.5 5814.2 5823.2 17:29:09 INFO - PROCESS | 7877 | 17:29:09 INFO - PROCESS | 7877 | [#5] yui.html Cycles:180 Average:19856.05 Median:4619.82 stddev:28718.56 (621.6%) stddev-sans-first:28762.94 17:29:09 INFO - PROCESS | 7877 | Values: 656.9 664.7 682.0 751.7 761.8 14583.0 15308.2 15542.2 15665.5 15704.0 14193.6 14308.4 14332.8 14335.6 14417.3 670.4 774.5 807.2 807.5 807.8 775.9 808.5 811.1 814.6 814.7 829.8 833.9 834.6 835.8 841.6 827.7 828.0 830.6 837.0 839.6 607.4 608.3 610.7 611.1 611.2 14441.2 14515.9 14521.1 14533.4 14561.5 14406.5 14600.3 14640.6 14842.8 14876.9 10670.3 10905.5 10938.2 11491.4 11544.7 3802.8 4436.6 4437.8 4448.9 4534.9 65758.3 73193.6 73461.3 73529.0 74183.6 10601.5 10826.2 10863.3 10868.8 11041.3 21134.2 21262.9 21267.0 21276.7 21348.7 8151.7 8307.9 8308.5 8400.6 8451.5 4501.6 4562.8 4609.9 4629.7 4644.3 3536.2 3616.5 3627.2 3638.3 3645.7 581.1 588.7 590.6 597.9 604.3 668.6 679.9 698.8 738.7 747.0 9061.6 9316.8 9416.5 9424.5 9436.2 659.7 698.7 707.7 740.2 770.9 4180.1 4371.9 4420.2 4438.9 4466.2 108106.0 108688.5 110910.4 111166.0 114149.0 63992.7 93950.5 95136.0 95167.0 95263.5 84636.6 85017.0 85856.6 86202.6 86366.6 9044.9 9074.2 9110.0 9148.4 9235.4 50308.7 51407.2 51989.5 52917.7 53311.2 57102.4 75121.6 76940.0 77707.6 79058.2 10295.3 10486.3 10532.0 11318.9 11981.0 12217.3 12368.1 12420.1 12740.2 12766.0 11773.9 11846.6 12028.4 12120.4 12612.0 11716.5 11975.2 12025.5 12537.2 12538.9 11927.5 12043.2 12258.0 12840.9 12860.3 9865.5 10094.1 10107.8 10143.1 10394.4 9945.4 10177.0 10184.4 10329.6 10339.1 17:29:09 INFO - PROCESS | 7877 | -------- Summary: end -------- 17:29:09 INFO - PROCESS | 7877 | 17:29:10 INFO - TEST-INFO | 7877: exit 0 17:29:10 INFO - TEST-OK | dromaeo_css | took 1110104ms 17:29:10 INFO - TEST-START | kraken 17:29:10 INFO - operating with platform_type : linux_ 17:29:10 INFO - Initialising browser for kraken test... 17:29:10 INFO - TEST-INFO | started process 8114 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpa1BU31/profile http://localhost:33920/getInfo.html) 17:29:14 INFO - PROCESS | 8114 | __metrics Screen width/height:1600/1200 17:29:14 INFO - PROCESS | 8114 | colorDepth:24 17:29:14 INFO - PROCESS | 8114 | Browser inner width/height: 1024/697 17:29:14 INFO - PROCESS | 8114 | __metrics 17:29:15 ERROR - PROCESS | 8114 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 17:29:16 INFO - TEST-INFO | 8114: exit 0 17:29:16 INFO - Browser initialized. 17:29:16 INFO - Running cycle 1/1 for kraken test... 17:29:16 INFO - TEST-INFO | started process 8237 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpa1BU31/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:29:28 INFO - PROCESS | 8237 | RSS: Main: 167137280 17:29:28 INFO - PROCESS | 8237 | 17:29:30 INFO - PROCESS | 8237 | Cycle 1(1): loaded http://localhost:33920/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33920/tests/kraken/driver.html?testName=audio-beat-detection) 17:29:31 INFO - PROCESS | 8237 | RSS: Main: 172462080 17:29:31 INFO - PROCESS | 8237 | 17:29:34 INFO - PROCESS | 8237 | Cycle 1(1): loaded http://localhost:33920/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33920/tests/kraken/driver.html?testName=audio-dft) 17:29:35 INFO - PROCESS | 8237 | RSS: Main: 171704320 17:29:35 INFO - PROCESS | 8237 | 17:29:37 INFO - PROCESS | 8237 | Cycle 1(1): loaded http://localhost:33920/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33920/tests/kraken/driver.html?testName=audio-fft) 17:29:38 INFO - PROCESS | 8237 | RSS: Main: 166588416 17:29:38 INFO - PROCESS | 8237 | 17:29:40 INFO - PROCESS | 8237 | Cycle 1(1): loaded http://localhost:33920/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33920/tests/kraken/driver.html?testName=audio-oscillator) 17:29:41 INFO - PROCESS | 8237 | RSS: Main: 167194624 17:29:41 INFO - PROCESS | 8237 | 17:29:43 INFO - PROCESS | 8237 | Cycle 1(1): loaded http://localhost:33920/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33920/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:29:44 INFO - PROCESS | 8237 | RSS: Main: 168005632 17:29:44 INFO - PROCESS | 8237 | 17:29:47 INFO - PROCESS | 8237 | Cycle 1(1): loaded http://localhost:33920/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33920/tests/kraken/driver.html?testName=imaging-darkroom) 17:29:47 INFO - PROCESS | 8237 | RSS: Main: 167518208 17:29:47 INFO - PROCESS | 8237 | 17:29:51 INFO - PROCESS | 8237 | Cycle 1(1): loaded http://localhost:33920/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33920/tests/kraken/driver.html?testName=imaging-desaturate) 17:29:51 INFO - PROCESS | 8237 | RSS: Main: 166068224 17:29:51 INFO - PROCESS | 8237 | 17:29:54 INFO - PROCESS | 8237 | Cycle 1(1): loaded http://localhost:33920/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33920/tests/kraken/driver.html?testName=json-parse-financial) 17:29:55 INFO - PROCESS | 8237 | RSS: Main: 167288832 17:29:55 INFO - PROCESS | 8237 | 17:29:56 INFO - PROCESS | 8237 | Cycle 1(1): loaded http://localhost:33920/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33920/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:29:57 INFO - PROCESS | 8237 | RSS: Main: 167698432 17:29:57 INFO - PROCESS | 8237 | 17:29:59 INFO - PROCESS | 8237 | Cycle 1(1): loaded http://localhost:33920/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33920/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:29:59 INFO - PROCESS | 8237 | RSS: Main: 168169472 17:29:59 INFO - PROCESS | 8237 | 17:30:01 INFO - PROCESS | 8237 | Cycle 1(1): loaded http://localhost:33920/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33920/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:30:02 INFO - PROCESS | 8237 | RSS: Main: 168206336 17:30:02 INFO - PROCESS | 8237 | 17:30:05 INFO - PROCESS | 8237 | Cycle 1(1): loaded http://localhost:33920/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33920/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:30:05 INFO - PROCESS | 8237 | RSS: Main: 168292352 17:30:05 INFO - PROCESS | 8237 | 17:30:08 INFO - PROCESS | 8237 | Cycle 1(1): loaded http://localhost:33920/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33920/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:30:09 INFO - PROCESS | 8237 | RSS: Main: 167936000 17:30:09 INFO - PROCESS | 8237 | 17:30:10 INFO - PROCESS | 8237 | Cycle 1(1): loaded http://localhost:33920/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33920/tests/kraken/driver.html?testName=ai-astar) 17:30:11 INFO - PROCESS | 8237 | RSS: Main: 168697856 17:30:11 INFO - PROCESS | 8237 | 17:30:11 INFO - PROCESS | 8237 | __start_tp_report 17:30:11 INFO - PROCESS | 8237 | _x_x_mozilla_page_load 17:30:11 INFO - PROCESS | 8237 | _x_x_mozilla_page_load_details 17:30:11 INFO - PROCESS | 8237 | |i|pagename|runs| 17:30:11 INFO - PROCESS | 8237 | |0;ai-astar;110;105;111;112;112;111;111;110;109;110 17:30:11 INFO - PROCESS | 8237 | |1;audio-beat-detection;153;130;164;182;127;155;160;127;195;134 17:30:11 INFO - PROCESS | 8237 | |2;audio-dft;163;162;163;162;161;165;168;162;162;164 17:30:11 INFO - PROCESS | 8237 | |3;audio-fft;77;75;75;148;77;76;75;76;171;77 17:30:11 INFO - PROCESS | 8237 | |4;audio-oscillator;85;85;142;85;85;86;147;84;84;159 17:30:11 INFO - PROCESS | 8237 | |5;imaging-gaussian-blur;117;119;117;118;118;117;117;117;117;124 17:30:11 INFO - PROCESS | 8237 | |6;imaging-darkroom;148;147;151;148;149;148;148;151;150;151 17:30:11 INFO - PROCESS | 8237 | |7;imaging-desaturate;95;96;95;96;96;95;96;96;96;95 17:30:11 INFO - PROCESS | 8237 | |8;json-parse-financial;54;54;57;54;55;53;52;53;54;54 17:30:11 INFO - PROCESS | 8237 | |9;json-stringify-tinderbox;62;62;61;68;62;62;63;63;62;63 17:30:11 INFO - PROCESS | 8237 | |10;stanford-crypto-aes;79;79;85;79;81;80;80;79;109;79 17:30:11 INFO - PROCESS | 8237 | |11;stanford-crypto-ccm;125;124;125;134;127;128;124;135;136;124 17:30:11 INFO - PROCESS | 8237 | |12;stanford-crypto-pbkdf2;173;167;163;164;161;166;162;160;162;166 17:30:11 INFO - PROCESS | 8237 | |13;stanford-crypto-sha256-iterative;64;65;68;63;62;63;62;63;65;62 17:30:11 INFO - PROCESS | 8237 | __end_tp_report 17:30:11 INFO - PROCESS | 8237 | __start_cc_report 17:30:11 INFO - PROCESS | 8237 | _x_x_mozilla_cycle_collect,868 17:30:11 INFO - PROCESS | 8237 | __end_cc_report 17:30:11 INFO - PROCESS | 8237 | __startTimestamp1465432211183__endTimestamp 17:30:11 INFO - PROCESS | 8237 | 17:30:11 INFO - PROCESS | 8237 | ------- Summary: start ------- 17:30:11 INFO - PROCESS | 8237 | Number of tests: 14 17:30:11 INFO - PROCESS | 8237 | 17:30:11 INFO - PROCESS | 8237 | [#0] ai-astar Cycles:10 Average:110.10 Median:111.00 stddev:2.02 (1.8%) stddev-sans-first:2.15 17:30:11 INFO - PROCESS | 8237 | Values: 110.0 105.0 111.0 112.0 112.0 111.0 111.0 110.0 109.0 110.0 17:30:11 INFO - PROCESS | 8237 | 17:30:11 INFO - PROCESS | 8237 | [#1] audio-beat-detection Cycles:10 Average:152.70 Median:157.50 stddev:23.62 (15.0%) stddev-sans-first:25.05 17:30:11 INFO - PROCESS | 8237 | Values: 153.0 130.0 164.0 182.0 127.0 155.0 160.0 127.0 195.0 134.0 17:30:11 INFO - PROCESS | 8237 | 17:30:11 INFO - PROCESS | 8237 | [#2] audio-dft Cycles:10 Average:163.20 Median:163.00 stddev:2.04 (1.3%) stddev-sans-first:2.17 17:30:11 INFO - PROCESS | 8237 | Values: 163.0 162.0 163.0 162.0 161.0 165.0 168.0 162.0 162.0 164.0 17:30:11 INFO - PROCESS | 8237 | 17:30:11 INFO - PROCESS | 8237 | [#3] audio-fft Cycles:10 Average:92.70 Median:76.00 stddev:35.63 (46.9%) stddev-sans-first:37.34 17:30:11 INFO - PROCESS | 8237 | Values: 77.0 75.0 75.0 148.0 77.0 76.0 75.0 76.0 171.0 77.0 17:30:11 INFO - PROCESS | 8237 | 17:30:11 INFO - PROCESS | 8237 | [#4] audio-oscillator Cycles:10 Average:104.20 Median:85.00 stddev:31.42 (37.0%) stddev-sans-first:32.55 17:30:11 INFO - PROCESS | 8237 | Values: 85.0 85.0 142.0 85.0 85.0 86.0 147.0 84.0 84.0 159.0 17:30:11 INFO - PROCESS | 8237 | 17:30:11 INFO - PROCESS | 8237 | [#5] imaging-gaussian-blur Cycles:10 Average:118.10 Median:117.50 stddev:2.18 (1.9%) stddev-sans-first:2.28 17:30:11 INFO - PROCESS | 8237 | Values: 117.0 119.0 117.0 118.0 118.0 117.0 117.0 117.0 117.0 124.0 17:30:11 INFO - PROCESS | 8237 | 17:30:11 INFO - PROCESS | 8237 | [#6] imaging-darkroom Cycles:10 Average:149.10 Median:149.50 stddev:1.52 (1.0%) stddev-sans-first:1.56 17:30:11 INFO - PROCESS | 8237 | Values: 148.0 147.0 151.0 148.0 149.0 148.0 148.0 151.0 150.0 151.0 17:30:11 INFO - PROCESS | 8237 | 17:30:11 INFO - PROCESS | 8237 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.52 (0.5%) stddev-sans-first:0.50 17:30:11 INFO - PROCESS | 8237 | Values: 95.0 96.0 95.0 96.0 96.0 95.0 96.0 96.0 96.0 95.0 17:30:11 INFO - PROCESS | 8237 | 17:30:11 INFO - PROCESS | 8237 | [#8] json-parse-financial Cycles:10 Average:54.00 Median:54.00 stddev:1.33 (2.5%) stddev-sans-first:1.41 17:30:11 INFO - PROCESS | 8237 | Values: 54.0 54.0 57.0 54.0 55.0 53.0 52.0 53.0 54.0 54.0 17:30:11 INFO - PROCESS | 8237 | 17:30:11 INFO - PROCESS | 8237 | [#9] json-stringify-tinderbox Cycles:10 Average:62.80 Median:62.50 stddev:1.93 (3.1%) stddev-sans-first:2.03 17:30:11 INFO - PROCESS | 8237 | Values: 62.0 62.0 61.0 68.0 62.0 62.0 63.0 63.0 62.0 63.0 17:30:11 INFO - PROCESS | 8237 | 17:30:11 INFO - PROCESS | 8237 | [#10] stanford-crypto-aes Cycles:10 Average:83.00 Median:79.50 stddev:9.32 (11.7%) stddev-sans-first:9.77 17:30:11 INFO - PROCESS | 8237 | Values: 79.0 79.0 85.0 79.0 81.0 80.0 80.0 79.0 109.0 79.0 17:30:11 INFO - PROCESS | 8237 | 17:30:11 INFO - PROCESS | 8237 | [#11] stanford-crypto-ccm Cycles:10 Average:128.20 Median:127.50 stddev:4.89 (3.8%) stddev-sans-first:5.05 17:30:11 INFO - PROCESS | 8237 | Values: 125.0 124.0 125.0 134.0 127.0 128.0 124.0 135.0 136.0 124.0 17:30:11 INFO - PROCESS | 8237 | 17:30:11 INFO - PROCESS | 8237 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.40 Median:165.00 stddev:3.81 (2.3%) stddev-sans-first:2.46 17:30:11 INFO - PROCESS | 8237 | Values: 173.0 167.0 163.0 164.0 161.0 166.0 162.0 160.0 162.0 166.0 17:30:11 INFO - PROCESS | 8237 | 17:30:11 INFO - PROCESS | 8237 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.70 Median:63.50 stddev:1.89 (3.0%) stddev-sans-first:2.00 17:30:11 INFO - PROCESS | 8237 | Values: 64.0 65.0 68.0 63.0 62.0 63.0 62.0 63.0 65.0 62.0 17:30:11 INFO - PROCESS | 8237 | -------- Summary: end -------- 17:30:11 INFO - PROCESS | 8237 | 17:30:12 INFO - TEST-INFO | 8237: exit 0 17:30:12 INFO - TEST-OK | kraken | took 61702ms 17:30:12 INFO - SUITE-END | took 1171s 17:30:12 INFO - Completed test suite (00:19:32) 17:30:12 INFO - javascript benchmark 17:30:12 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7366.683216775885, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3141.403133404653, 3185.9840700796494, 3192.4892017277234, 3223.7421006319482, 3234.822084785337, 5358.464153584644, 5390.541803946664, 5400.972995135024, 5437.32033495813, 5442.156465747806, 5254.054270231366, 5309.548688361494, 5396.487333703301, 5442.102053161224, 5464.972675136629, 4834.2265237562, 4847.587955023819, 4860.1008813369635, 4922.655414121013, 4973.0551195272965, 635.6647458945585, 4899.730514821684, 4949.628777841658, 4955.0, 5000.049990501811, 4763.04739052191, 4922.458529561745, 4983.750812459362, 5001.649884508086, 5010.624203184758, 4992.47579004203, 5011.072951503984, 5020.397552293712, 5032.220005899091, 5084.644074914758, 4732.1482133216, 4824.565789078964, 4969.378827646544, 5002.699838009731, 5008.624353173526, 5353.250544923714, 5397.514223719845, 5409.594280428944, 5456.83629491112, 5490.0, 5827.737751801179, 5829.183914252008, 5837.5913686041995, 5839.795607153772, 5874.206982057411, 5487.5609951203805, 5678.971605141989, 5719.027765279912, 5793.362730099686, 5801.071828507461, 5376.542993845528, 5389.78440862365, 5413.133898576249, 5427.728613569345, 5431.34823821144, 5885.941140588625, 5896.262967129109, 5900.704964751745, 5941.7623295067715, 5951.970240148771, 5499.890002199933, 5637.351704553947, 5639.8590035249445, 5673.3475650299915, 5761.279840019997, 5725.1698503716725, 5745.540356771448, 5766.0, 5819.941800582024, 5864.501517371071, 5711.571632127607, 5724.370319264877, 5740.942590574125, 5762.1068734346245, 5776.277965254343, 5802.82591522255, 5882.735276912549, 5885.764569417175, 5909.556783241274, 5919.378465261172, 4379.737215767064, 4390.956090439118, 4391.8682439526865, 4430.379746835446, 4445.51099379068, 3854.383298672199, 3890.0, 3968.2857085724845, 3977.801109944549, 3998.140399814054, 5307.495787900143, 5430.647007944471, 5505.504504594525, 5548.91676624851, 5595.944040559623, 5748.655080695172, 5820.35976042635, 5834.504067154255, 5843.0066888629035, 5848.502877255481, 5350.571954243651, 5391.245225668409, 5554.055810512223, 5575.275214222206, 5582.7766889323975, 4929.433115191727, 4943.65394422387, 4985.5762260208285, 4987.401511818605, 5006.89986200274, 5924.20023296858, 5993.250843644457, 6028.367021462684, 6039.758409663652, 6041.607295525777, 5652.576056795839, 5777.682227477361, 5818.127280907813, 5821.097729851795, 5826.533877289722, 6042.818715438544, 6080.6351618901235, 6087.604305720114, 6097.390260973867, 6107.297660769068, 5762.510186634183, 5769.59612827098, 5771.7402716877, 5772.451617096369, 5774.595778295647, 5617.157426386075, 5723.170140329546, 5771.307443106854, 5789.623674461147, 5881.206037184926, 5649.322081350264, 5654.547636189012, 5677.432256774289, 5678.403767604342, 5686.147077938343, 5618.606697531133, 5655.943440565707, 5657.688827114548, 5660.122680984454, 5664.405237450009, 5318.282031925795, 5516.089845175501, 5571.665700057847, 5586.13414920688, 5648.124540696034, 5689.146628005832, 5729.455701708331, 5757.65454072757, 5767.134929760569, 5790.1893734877995, 5391.083515802401, 5588.86027849307, 5656.349519805275, 5657.066584013756, 5660.688662123623], "value": 5313.440341434434, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [579.5479525969743, 617.9845503862402, 628.3747671067289, 639.8368416053906, 666.6666666666664, 41509.377359339596, 43184.0, 43221.0, 46885.29672054922, 46925.765371173096, 43591.0, 44251.77874110633, 44266.77866610663, 44331.33502997449, 44430.11139777202, 8666.176713212251, 8824.338174636896, 8880.24517915978, 8880.955595222047, 8883.777905552348, 8735.95632021839, 8755.95622021889, 8794.956025219864, 8839.690610828622, 8854.158854908774, 8826.249768769661, 8860.601272942733, 8870.86693699595, 8899.33255005874, 8903.24322432594, 8831.73504794854, 8867.822643547157, 8871.423357481808, 8885.289176865868, 8891.0, 8700.608472618747, 8782.077881822444, 8800.779980500538, 8834.64661413549, 8845.469271843709, 40815.7959210205, 40972.385414218814, 41055.384169237484, 41352.37971430431, 41495.7925210375, 3219.2917558137174, 3625.6011838697723, 3657.65252301031, 3904.7852368119743, 3931.6461518463475, 30641.233969150726, 31133.221669458217, 31297.8435107823, 33010.339793204, 33030.339393212, 4065.532463766675, 4069.1658210066867, 4146.543880173179, 4200.537940826537, 4201.621854033121, 315496.0, 316556.0, 317126.0, 317372.0, 318561.40719296486, 54879.451205488236, 55070.44929550734, 55355.72322138363, 55477.1678424824, 55532.0, 34575.65424345775, 35335.0, 35420.291594167975, 37276.25447491035, 37294.50821967091, 17310.65378692419, 17447.651046979245, 17463.47609571715, 17469.213885374935, 17528.0, 13173.47306107764, 13423.731525369438, 13449.798253026212, 13454.93272533631, 13460.528881489297, 19077.236910523425, 19131.23475060982, 19149.90425047866, 19183.52041198981, 19284.614307713768, 7075.964620176866, 7103.396211322096, 7158.06945097134, 7158.427325813923, 7179.246179151219, 1016.2276669731058, 1065.8561094252332, 1170.9590164344206, 1174.8413964114907, 1188.6731148933939, 31148.53277200844, 31367.372652546823, 31466.213344666565, 31697.8415107923, 31794.364112718078, 1084.295208114716, 1152.8501294831785, 1178.0869825885009, 1182.1075088308273, 1201.8497687789027, 16069.758953615705, 16492.83507164937, 16666.16669166561, 16747.330106795835, 16963.15184240783, 489425.0, 491237.0, 491887.0, 494721.0, 495376.0, 38647.22705545873, 39588.0, 39729.40405893914, 39752.801235994215, 39803.2039359217, 1350.9870293263164, 1385.3696568061507, 1387.4034165308813, 1390.3743315507859, 1396.7346204221164, 29889.028109883326, 31160.68839311578, 31413.685863141076, 31844.840775795972, 31897.68102318947, 48840.2673959898, 48922.75538622284, 49321.26018109659, 49381.506184937694, 49410.258846116616, 413129.0, 415071.0, 416255.0, 416941.0, 416949.0, 27099.0, 27106.72893271121, 27506.449871002867, 27556.724432755414, 27742.86128569344, 46388.0, 47203.52796471991, 47210.763946181425, 47457.525424746695, 47755.0, 38706.0, 39829.80085099556, 40234.79882600568, 40602.9849253771, 41093.0, 39359.40960885532, 41029.0, 41396.0, 41681.79159104306, 41769.0, 36166.0, 39310.2137957245, 40081.0, 41285.58714412817, 41318.38022429606, 35736.0, 36451.27097458089, 37026.62973370232, 37043.25913481662, 37156.44265335968, 27566.862165689043, 28049.29876753016, 28072.409624768752, 28128.578071329357, 28340.25781920851], "value": 19484.699059790753, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [388.2681146039714, 394.615250131122, 397.46937837986286, 403.32845811723485, 417.51985217000447, 13595.728085438286, 17679.469615911512, 18618.255269789224, 19257.229710811567, 19295.13171907266, 18134.727979080326, 18368.81631183688, 18474.44576662699, 19458.416247512563, 19497.805021949775, 5507.614466987313, 5589.664620122785, 5694.145878118274, 5726.62776919501, 5731.054376027951, 5595.21666966625, 5641.435856414346, 5714.114312281603, 6606.2402823675175, 6983.266756990519, 6772.932270677279, 6967.0, 7047.577145371294, 7062.929370706279, 7089.8227544311285, 6809.931900680979, 7077.079979602644, 7085.362317391434, 7088.822779430504, 7432.925670743278, 7151.964240178766, 7177.9282207177785, 7183.640817959081, 7188.928110718878, 7206.963965180141, 23534.0, 24714.25857224268, 25405.491890162095, 25449.618255725993, 26115.347116322246, 2294.3919861236786, 2301.298104078272, 2341.683872677184, 2355.823313251496, 2418.3470462975074, 15245.466408675644, 15839.683206335809, 15928.0, 16134.193290335554, 16327.83672163275, 1941.1190566300863, 2088.968665470019, 2168.5662867426577, 2174.9565008699738, 2392.1866565367686, 88547.0, 93239.53380233055, 94124.0, 94264.0, 95376.52311738467, 15965.44120955761, 17593.912030439766, 17612.647747044986, 17645.38241161553, 18223.0, 31745.20636984094, 31865.362692746014, 31872.20319491985, 31948.68051319457, 32279.0, 9440.669576564787, 9959.751006224902, 10010.64962726301, 10065.295429319878, 10149.39103653783, 8092.9190708092165, 8112.269895709414, 8136.088019315456, 8312.127226641236, 8444.113368096385, 8717.433366831136, 8889.4666320021, 8914.37599368038, 8960.775980600407, 9099.225650997992, 3576.6959808416054, 3583.8606409596955, 3631.128529153037, 3645.781253124821, 3734.2718169957143, 940.6848705683673, 971.7667759737612, 1005.7083445800636, 1021.6117875207523, 1040.3341861208833, 18841.905790471235, 19122.0, 19213.231470741015, 19370.70943935842, 19482.318118865773, 948.5636607160645, 948.5866059571327, 949.2548349545574, 959.3764053365229, 988.0810845913226, 10388.324758890649, 10391.53238104287, 10422.166226701846, 10440.0, 10730.409827459565, 483568.0, 489522.0, 490233.84181553475, 492737.0, 495831.0, 93974.5301273503, 96440.0, 97131.0, 97425.51287243661, 98372.0, 1011.8785745710562, 1053.6522947427331, 1053.889341619119, 1059.4755595979884, 1068.0227591753614, 16635.83364166343, 16636.916815415847, 17080.829191707922, 17208.397706080228, 17356.652866942844, 38216.42675359928, 38966.80516597399, 39526.40710389289, 39806.20387592174, 40699.46444139993, 56428.0, 57040.0, 57078.0059762837, 57817.42182578288, 58060.709696451246, 8281.917180828115, 8325.375596830141, 8421.284190843848, 8670.436421632574, 8725.345599079967, 9535.23718102564, 12547.749045018865, 13106.148100373826, 13204.075714699879, 13376.0, 11302.378369189773, 11608.361540115375, 11681.182317237712, 11769.352685602375, 11873.406329683308, 11464.0, 11501.53993840237, 11776.116791240862, 11793.233439826385, 11960.940195298968, 10643.521041552995, 11353.432328383382, 11477.82783258235, 11583.6524904253, 11811.468483918072, 8077.27304542594, 8221.876671850046, 8360.12218717026, 8387.790305242417, 8515.446495977742, 10627.415492148006, 11086.944565277123, 11174.0, 11217.60738374153, 11550.0], "value": 10256.727894234677, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1519.5289460267318, 1539.5766164304819, 1684.1410880450967, 1806.5765374615112, 1812.5559237986688, 7929.365650747941, 8844.292456603473, 8848.601812918418, 9454.669086581971, 9459.905400945998, 8951.104889511045, 9164.083591640832, 9191.448513089203, 9252.074792520745, 9260.305477089212, 2318.6058370077085, 2367.2898130560848, 2368.9576586301973, 2370.01644317608, 2370.8340416170877, 2291.472961218921, 2319.130326127702, 2355.3522781235124, 2359.516299158677, 2364.219807463533, 2337.439014636492, 2340.6723058771786, 2346.2022912209845, 2360.0795689680954, 2373.1338061607476, 2234.72065991751, 2235.6870038194666, 2237.2617036377956, 2251.7185351831104, 2304.585174668559, 2254.571631390047, 2256.3231030690727, 2258.040332858545, 2265.0486795545744, 2268.160780511205, 9159.679411220575, 9195.08049195082, 9212.815743685156, 9228.8615670765, 9246.815063698756, 5090.287359769635, 5220.973895130538, 5228.294180285651, 5237.528622423962, 5239.371275446971, 3199.4560924642633, 3229.3056992746674, 3375.7974521528786, 3402.2855200407944, 3421.81180035098, 1064.8775390830076, 1121.478512491687, 1124.4434005167413, 1125.5385292030228, 1128.5598616539555, 12885.098043136984, 12957.546485873043, 12989.090763646549, 13007.674808129872, 13023.674408139777, 4519.977400112978, 4653.278741795028, 4701.506341834058, 4731.503192164773, 4762.78567464465, 10861.782764344669, 10865.402402867918, 10867.510962006729, 10875.78248435027, 10893.945530272456, 5327.0, 5345.438728933484, 5360.410354860962, 5405.702686352289, 5417.0, 4294.957050429518, 4664.416947881515, 4774.95225047745, 4805.8558243252055, 4993.0, 3990.3016972029777, 4008.158286759813, 4067.5525692173837, 4068.2066996935905, 4154.729942553724, 1237.9319137447526, 1254.1158483269273, 1257.2645002673355, 1265.9177153484993, 1268.055298802398, 880.9955950220208, 1024.9077583017565, 1027.4708525109575, 1030.5002073994108, 1042.0881728487573, 6112.572119951649, 6199.256089269316, 6284.245890493079, 6319.24169099711, 6360.968195158995, 440.74877319927333, 442.5640743867288, 447.7112262590611, 447.83653966302717, 451.7402493566147, 4301.935470967938, 4359.673024523174, 4360.847370342023, 4361.978190109029, 4370.847020354272, 11147.888521114848, 11384.658460246206, 11396.715082122848, 11433.485493152828, 11528.884711152949, 10664.360138391567, 10940.288881222696, 11253.943730281297, 11282.323060616389, 11382.943085284685, 8453.873191902127, 8606.397552171287, 8660.653573856975, 8709.0, 8716.78208044804, 6137.60105593135, 6375.139356187041, 6384.45732112757, 6414.03789431589, 6422.582532135396, 10532.368057916243, 10600.363978161335, 10686.839697404701, 10699.411532365795, 10750.623728169476, 9943.552540135855, 10369.222308326755, 10376.118029967236, 10632.681019569425, 10692.0, 7270.781876543712, 7758.88361674564, 8005.8398832024195, 8055.798605034921, 8165.836683266182, 8996.145366190201, 9002.50486223264, 9024.774380640274, 9040.63837446521, 9139.680111196076, 7906.130325664058, 8035.718749843727, 8059.597020148852, 8065.516069035877, 8282.875756863532, 7800.141984381827, 7874.842503150019, 7875.921240787748, 7926.24700653437, 7940.563269020028, 7261.092363454568, 7300.0, 7338.229485904117, 7360.1535823381, 7393.186749457663, 5140.357455318085, 5276.762545685377, 5484.670919744828, 5525.972370138124, 5575.275214222125, 5421.945780542144, 5445.346558413015, 5478.616496845182, 5607.2149899014985, 5611.80358687444], "value": 4670.826234414484, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [315.6653946816375, 327.6363236807144, 329.9241174529858, 330.40691957935536, 330.7420212234457, 5538.141588053848, 5584.46947539983, 5624.381318055016, 5636.4363563643665, 5760.164776107462, 5615.943840561593, 5659.830205093844, 5716.39977802331, 5727.341355744091, 5737.741801618927, 4379.868603941887, 4382.758948257844, 4388.727269091975, 4397.582229688182, 4398.824047038114, 4123.886550631328, 4151.111244383813, 4243.957560424403, 4281.336392859112, 4285.764282964436, 4210.705250632457, 4226.598473145046, 4250.553691862357, 4252.532221455637, 4253.680973926952, 4252.766097864616, 4274.658027357804, 4279.764612946286, 4281.544274946533, 4283.850065247717, 3575.6781889629797, 3658.1951970566433, 3720.2373513429684, 3720.7023438124884, 3724.9627503724887, 5239.21411788231, 5346.304980352529, 5366.570674346082, 5383.353997520284, 5406.243125962368, 4869.8782530436665, 4882.487338829407, 4898.289747986522, 4909.22628714775, 4954.826581069681, 5561.58288128392, 5811.5350771938565, 5831.183634291203, 5838.328592211908, 5880.353161152269, 4102.835886564534, 4104.958950410488, 4115.835366585333, 4131.256373852705, 4132.830264111336, 5889.760631652574, 6110.0, 6191.349908259613, 6200.162977998003, 6253.404836992642, 4161.479815023122, 4187.43469631602, 4187.769672668032, 4204.5375008749015, 4205.453291072141, 4236.618704316565, 4255.510616279105, 4268.487781466182, 4269.462993322401, 4273.67947403946, 4902.7058376497525, 4916.5820905222745, 4950.282209079735, 4964.726940018261, 4978.751062446936, 5576.693281869455, 5918.940810591925, 5923.614965027259, 5925.200097986803, 5925.259342582177, 1442.5239670908575, 1477.8448262932452, 1482.303317440801, 1488.8064551608438, 1495.4167874528941, 905.5789058087889, 930.265090578449, 946.6024269806697, 946.6260826973445, 946.8863736351544, 5079.187330027252, 5085.542301192911, 5583.330000399978, 5658.405867383865, 5799.739011744482, 6055.878882422327, 6057.183974096291, 6098.75604975796, 6109.725062372204, 6153.4154255345675, 5421.2952316199435, 5728.255326807572, 5768.644368573382, 5780.277465316835, 5780.855478612984, 3227.8224697641385, 3228.9838550807094, 3257.696921231479, 3270.705636492727, 3272.5582046423906, 6291.748330066837, 6293.181886354836, 6314.494840412756, 6318.336574659595, 6336.461400780985, 5854.443827836349, 6137.539684523678, 6216.4405203531, 6239.656818875005, 6252.6873656317, 6314.936850631527, 6350.4284614384005, 6359.395857393541, 6397.7440902364315, 6399.648019358887, 6001.879962400641, 6088.573799833969, 6106.877862442815, 6125.571210015256, 6183.0, 6068.4841788448475, 6068.998615228438, 6075.453209211192, 6107.755689772537, 6113.724882380393, 6057.394790380465, 6362.141110949962, 6370.681465926593, 6411.3909178627955, 6417.406252498616, 4208.558101399309, 4232.576742325866, 4245.830166793294, 4258.5954334338185, 4278.871633850989, 5992.760289588542, 6006.069059295816, 6018.247719035121, 6143.324234334309, 6153.600015998945, 5881.7647294107755, 5931.851703707269, 5956.463918247378, 5970.5522085844605, 6009.399060093956, 5922.851928701644, 5932.940670593412, 5972.462478376967, 5973.283206015306, 5978.551608629283, 5623.578231632726, 5753.597248192754, 5802.071668533014, 5804.477597016289, 5818.592698511233, 5626.424601111696, 5686.0, 5871.823845284648, 5886.705664716661, 5891.58758886891, 5674.290713660793, 5756.712164391847, 5812.505936995402, 5814.244148260699, 5823.195863412617], "value": 4451.238628630745, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [656.8850451171044, 664.7473959895245, 682.00427376031, 751.714348547552, 761.779084065621, 14583.0, 15308.234588270583, 15542.222888855555, 15665.530034098967, 15704.0, 14193.574192774207, 14308.35612397442, 14332.785008224884, 14335.56993290203, 14417.279136043207, 670.3631550027493, 774.4578794843604, 807.2049031703797, 807.4791759315239, 807.7657479330987, 775.8758598624221, 808.4785313472806, 811.0632219786156, 814.5519964019795, 814.6822739131743, 829.7593697827623, 833.891594092767, 834.56185502611, 835.7743409279491, 841.6170642357744, 827.6523859978823, 828.0, 830.5971603772166, 837.0, 839.588601585225, 607.380471918645, 608.342989571262, 610.7190692281556, 611.1138848669402, 611.1749138662814, 14441.205733684643, 14515.92742036283, 14521.056131351428, 14533.418663253457, 14561.49034783788, 14406.495772647908, 14600.269986500633, 14640.560783176521, 14842.777358339634, 14876.925615371854, 10670.306430082097, 10905.509252083675, 10938.179636527293, 11491.367974761384, 11544.653660390202, 3802.790846503441, 4436.64506839452, 4437.778111094464, 4448.888777780549, 4534.88662783433, 65758.34241657618, 73193.63403183004, 73461.26538734598, 73529.0, 74183.62908185425, 10601.469926503643, 10826.18803589734, 10863.293885897392, 10868.836967445495, 11041.33751974884, 21134.154633814476, 21262.893685531784, 21267.0, 21276.680849787266, 21348.679769803464, 8151.714689985822, 8307.875381869277, 8308.501489910625, 8400.621972011275, 8451.492910425271, 4501.594856462869, 4562.794674239667, 4609.8847528811375, 4629.745364004944, 4644.256918892961, 3536.2397084626414, 3616.511770910946, 3627.2020155565733, 3638.290533345972, 3645.6901163400876, 581.1079992211935, 588.6615196262167, 590.6485641043572, 597.9133025711247, 604.3110853626869, 668.6322522612544, 679.8538314262457, 698.7554355975368, 738.7451329291385, 746.9551826890404, 9061.59222834974, 9316.813663726687, 9416.482093484925, 9424.528773561431, 9436.197923176469, 659.6965395917836, 698.671624336561, 707.7204504220907, 740.2190688823235, 770.8535378278109, 4180.143070670505, 4371.912561748747, 4420.226460369422, 4438.933415998763, 4466.1514312281215, 108106.0, 108688.45655771671, 110910.44544777225, 111166.0, 114149.0, 63992.68003660045, 93950.5302473497, 95136.0, 95167.0, 95263.52368238253, 84636.57681711552, 85017.0, 85856.57071714601, 86202.56898715466, 86366.56816715877, 9044.864327034968, 9074.183323500916, 9110.0, 9148.399030169827, 9235.353525253167, 50308.74845625748, 51407.22889156591, 51989.480105199975, 52917.73541132424, 53311.200331994274, 57102.428975709714, 75121.62439187769, 76940.0, 77707.61146194233, 79058.20941790509, 10295.330803497749, 10486.26596138263, 10532.0, 11318.943405283251, 11981.0, 12217.328046957147, 12368.134230603771, 12420.130590858553, 12740.171888827197, 12766.0, 11773.882261177621, 11846.644600661994, 12028.398580071136, 12120.393980301125, 12612.0, 11716.531338746354, 11975.221610595283, 12025.4588543514, 12537.247765134121, 12538.87461125377, 11927.522899084286, 12043.156979011384, 12258.0, 12840.871591283967, 12860.292683902475, 9865.457399843077, 10094.141997929964, 10107.848382274125, 10143.08712215904, 10394.428306442916, 9945.353552019096, 10177.0, 10184.388936663823, 10329.638462654071, 10339.121174700234], "value": 7238.287945811688, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1541.8000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 105.0, 111.0, 112.0, 112.0, 111.0, 111.0, 110.0, 109.0, 110.0], "value": 110.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 130.0, 164.0, 182.0, 127.0, 155.0, 160.0, 127.0, 195.0, 134.0], "value": 152.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 163.0, 162.0, 161.0, 165.0, 168.0, 162.0, 162.0, 164.0], "value": 163.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 75.0, 75.0, 148.0, 77.0, 76.0, 75.0, 76.0, 171.0, 77.0], "value": 92.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 142.0, 85.0, 85.0, 86.0, 147.0, 84.0, 84.0, 159.0], "value": 104.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 119.0, 117.0, 118.0, 118.0, 117.0, 117.0, 117.0, 117.0, 124.0], "value": 118.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 151.0, 148.0, 149.0, 148.0, 148.0, 151.0, 150.0, 151.0], "value": 149.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 96.0, 96.0, 95.0, 96.0, 96.0, 96.0, 95.0], "value": 95.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 57.0, 54.0, 55.0, 53.0, 52.0, 53.0, 54.0, 54.0], "value": 54.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 61.0, 68.0, 62.0, 62.0, 63.0, 63.0, 62.0, 63.0], "value": 62.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 85.0, 79.0, 81.0, 80.0, 80.0, 79.0, 109.0, 79.0], "value": 83.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 124.0, 125.0, 134.0, 127.0, 128.0, 124.0, 135.0, 136.0, 124.0], "value": 128.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 167.0, 163.0, 164.0, 161.0, 166.0, 162.0, 160.0, 162.0, 166.0], "value": 164.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 68.0, 63.0, 62.0, 63.0, 62.0, 63.0, 65.0, 62.0], "value": 63.7, "unit": "score"}]}]} 17:30:12 INFO - Return code: 0 17:30:12 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:30:12 ERROR - # TBPL SUCCESS # 17:30:12 INFO - Running post-action listener: _resource_record_post_action 17:30:12 INFO - ##### 17:30:12 INFO - ##### Finished run-tests step (success) 17:30:12 INFO - ##### 17:30:12 INFO - Running post-run listener: _resource_record_post_run 17:30:12 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 4096; Write bytes: 543309824; Read time: 12; Write time: 559132 17:30:12 INFO - TinderboxPrint: CPU usage
13.4% 17:30:12 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 17:30:12 INFO - TinderboxPrint: I/O write bytes / time
543,309,824 / 559,132 17:30:12 INFO - TinderboxPrint: CPU idle
8,218.9 (86.6%) 17:30:12 INFO - TinderboxPrint: CPU user
1,221.2 (12.9%) 17:30:12 INFO - TinderboxPrint: Swap in / out
0 / 0 17:30:12 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 248291328; Read time: 0; Write time: 295864 17:30:12 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 4096; Write bytes: 295018496; Read time: 12; Write time: 263268 17:30:13 INFO - Running post-run listener: _upload_blobber_files 17:30:13 INFO - Blob upload gear active. 17:30:13 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:30:13 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 17:30:13 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'] 17:30:13 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 17:30:13 INFO - (blobuploader) - INFO - Open directory for files ... 17:30:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:30:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:30:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:30:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:30:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:30:14 INFO - (blobuploader) - INFO - Done attempting. 17:30:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:30:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:30:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:30:19 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:30:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:30:19 INFO - (blobuploader) - INFO - Done attempting. 17:30:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:30:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:30:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:30:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:30:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:30:19 INFO - (blobuploader) - INFO - Done attempting. 17:30:19 INFO - (blobuploader) - INFO - Iteration through files over. 17:30:19 INFO - Return code: 0 17:30:19 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:30:19 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:30:19 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fb090a8fa8b5939a7e99762bf3d36e99cd7756c1c1379fa46b6d987681852658042d2bf185a1377ceb630192f5c9189523619c749b2ed99bff7efa26f0bebbbb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b784a59400906c66af20d24484e5575218dec6c99a02720e369ffeffe10e7d8d57599149e419961e86db5d8f18c3a80def426200c6a843417f0f1ce22729dec1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4df4ed75c66a93dc45ef8d070654778a262c8e3a4cd07c0ca21656c39e10ff69c1ca4a17a2cb800aba10e886622658f79d468094df05dc34b1ec928e26e829d4"} 17:30:19 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:30:19 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:30:19 INFO - Contents: 17:30:19 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fb090a8fa8b5939a7e99762bf3d36e99cd7756c1c1379fa46b6d987681852658042d2bf185a1377ceb630192f5c9189523619c749b2ed99bff7efa26f0bebbbb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b784a59400906c66af20d24484e5575218dec6c99a02720e369ffeffe10e7d8d57599149e419961e86db5d8f18c3a80def426200c6a843417f0f1ce22729dec1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4df4ed75c66a93dc45ef8d070654778a262c8e3a4cd07c0ca21656c39e10ff69c1ca4a17a2cb800aba10e886622658f79d468094df05dc34b1ec928e26e829d4"} 17:30:19 INFO - Running post-run listener: copy_logs_to_upload_dir 17:30:19 INFO - Copying logs to upload dir... 17:30:19 INFO - mkdir: /builds/slave/test/build/upload/logs 17:30:19 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1232.724813 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-06-08 17:30:19.849867) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-08 17:30:19.853043) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1465430985.230124-1110190402 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fb090a8fa8b5939a7e99762bf3d36e99cd7756c1c1379fa46b6d987681852658042d2bf185a1377ceb630192f5c9189523619c749b2ed99bff7efa26f0bebbbb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b784a59400906c66af20d24484e5575218dec6c99a02720e369ffeffe10e7d8d57599149e419961e86db5d8f18c3a80def426200c6a843417f0f1ce22729dec1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4df4ed75c66a93dc45ef8d070654778a262c8e3a4cd07c0ca21656c39e10ff69c1ca4a17a2cb800aba10e886622658f79d468094df05dc34b1ec928e26e829d4"} build_url:https://queue.taskcluster.net/v1/task/bJEfQ-NhQuCzc0N3W4tp8Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011395 build_url: 'https://queue.taskcluster.net/v1/task/bJEfQ-NhQuCzc0N3W4tp8Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fb090a8fa8b5939a7e99762bf3d36e99cd7756c1c1379fa46b6d987681852658042d2bf185a1377ceb630192f5c9189523619c749b2ed99bff7efa26f0bebbbb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b784a59400906c66af20d24484e5575218dec6c99a02720e369ffeffe10e7d8d57599149e419961e86db5d8f18c3a80def426200c6a843417f0f1ce22729dec1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4df4ed75c66a93dc45ef8d070654778a262c8e3a4cd07c0ca21656c39e10ff69c1ca4a17a2cb800aba10e886622658f79d468094df05dc34b1ec928e26e829d4"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-08 17:30:19.878857) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 17:30:19.879204) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1465430985.230124-1110190402 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004498 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 17:30:19.967618) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-08 17:30:19.967935) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-08 17:30:19.968228) ========= ========= Total master_lag: 0.18 =========