builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-031 starttime: 1465864864.68 results: success (0) buildid: 20160613162026 builduid: 991e4e4bb9f44c53bd2dc8dc8c188872 revision: 79bcc05ef105fb5362888694307faa261615c34d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-13 17:41:04.678834) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-13 17:41:04.679314) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-13 17:41:04.679637) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-13 17:41:04.708796) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-13 17:41:04.709110) ========= 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=db0483c52d987ecb441a263b000001ad-1465859452.452570-1278319449 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-13 17:41:04-- 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% 51.0M=0s 2016-06-13 17:41:04 (51.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.113743 ========= master_lag: 0.08 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-13 17:41:04.898274) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-13 17:41:04.898597) ========= 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=db0483c52d987ecb441a263b000001ad-1465859452.452570-1278319449 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.023013 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-13 17:41:04.948957) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-13 17:41:04.949317) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 79bcc05ef105fb5362888694307faa261615c34d --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 79bcc05ef105fb5362888694307faa261615c34d --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=db0483c52d987ecb441a263b000001ad-1465859452.452570-1278319449 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-13 17:41:05,118 truncating revision to first 12 chars 2016-06-13 17:41:05,118 Setting DEBUG logging. 2016-06-13 17:41:05,118 attempt 1/10 2016-06-13 17:41:05,118 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/79bcc05ef105?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-13 17:41:06,233 unpacking tar archive at: fx-team-79bcc05ef105/testing/mozharness/ program finished with exit code 0 elapsedTime=1.486015 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-13 17:41:06.459829) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-13 17:41:06.460859) ========= script_repo_revision: 79bcc05ef105fb5362888694307faa261615c34d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-13 17:41:06.462124) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-13 17:41:06.462885) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-13 17:41:06.473823) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2016-06-13 17:41:06.474164) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 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-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] 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=db0483c52d987ecb441a263b000001ad-1465859452.452570-1278319449 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:41:06 INFO - MultiFileLogger online at 20160613 17:41:06 in /builds/slave/test 17:41:06 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 17:41:06 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:41:06 INFO - {'append_to_log': False, 17:41:06 INFO - 'base_work_dir': '/builds/slave/test', 17:41:06 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 17:41:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:41:06 INFO - 'branch': 'Fx-Team-Non-PGO', 17:41:06 INFO - 'buildbot_json_path': 'buildprops.json', 17:41:06 INFO - 'config_files': ('talos/linux_config.py',), 17:41:06 INFO - 'default_actions': ('clobber', 17:41:06 INFO - 'read-buildbot-config', 17:41:06 INFO - 'download-and-extract', 17:41:06 INFO - 'populate-webroot', 17:41:06 INFO - 'create-virtualenv', 17:41:06 INFO - 'install', 17:41:06 INFO - 'run-tests'), 17:41:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:41:06 INFO - 'download_minidump_stackwalk': True, 17:41:06 INFO - 'download_symbols': 'ondemand', 17:41:06 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:41:06 INFO - 'tooltool.py': '/tools/tooltool.py', 17:41:06 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:41:06 INFO - '/tools/misc-python/virtualenv.py')}, 17:41:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:41:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:41:06 INFO - 'installer_path': 'installer.exe', 17:41:06 INFO - 'log_level': 'info', 17:41:06 INFO - 'log_name': 'talos', 17:41:06 INFO - 'log_to_console': True, 17:41:06 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:41:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:41:06 INFO - 'opt_config_files': (), 17:41:06 INFO - 'pip_index': False, 17:41:06 INFO - 'sps_profile': False, 17:41:06 INFO - 'sps_profile_interval': 0, 17:41:06 INFO - 'suite': 'dromaeojs-e10s', 17:41:06 INFO - 'system_bits': '32', 17:41:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:41:06 INFO - 'title': 'talos-linux64-ix-031', 17:41:06 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:41:06 INFO - 'use_talos_json': True, 17:41:06 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:41:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:41:06 INFO - 'work_dir': 'build'} 17:41:06 INFO - ##### 17:41:06 INFO - ##### Running clobber step. 17:41:06 INFO - ##### 17:41:06 INFO - Running pre-action listener: _resource_record_pre_action 17:41:06 INFO - Running main action method: clobber 17:41:06 INFO - rmtree: /builds/slave/test/build 17:41:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:41:07 INFO - Running post-action listener: _resource_record_post_action 17:41:07 INFO - ##### 17:41:07 INFO - ##### Finished clobber step (success) 17:41:07 INFO - ##### 17:41:07 INFO - ##### 17:41:07 INFO - ##### Running read-buildbot-config step. 17:41:07 INFO - ##### 17:41:07 INFO - Running pre-action listener: _resource_record_pre_action 17:41:07 INFO - Running main action method: read_buildbot_config 17:41:07 INFO - Using buildbot properties: 17:41:07 INFO - { 17:41:07 INFO - "project": "", 17:41:07 INFO - "product": "firefox", 17:41:07 INFO - "script_repo_revision": "production", 17:41:07 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 17:41:07 INFO - "repository": "", 17:41:07 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 17:41:07 INFO - "buildid": "20160613162026", 17:41:07 INFO - "pgo_build": "False", 17:41:07 INFO - "basedir": "/builds/slave/test", 17:41:07 INFO - "buildnumber": 1409, 17:41:07 INFO - "slavename": "talos-linux64-ix-031", 17:41:07 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 17:41:07 INFO - "platform": "ubuntu64_hw", 17:41:07 INFO - "scheduler": "tests-fx-team-linux64-talos", 17:41:07 INFO - "branch": "fx-team", 17:41:07 INFO - "repo_path": "integration/fx-team", 17:41:07 INFO - "revision": "79bcc05ef105fb5362888694307faa261615c34d", 17:41:07 INFO - "stage_platform": "linux64", 17:41:07 INFO - "builduid": "991e4e4bb9f44c53bd2dc8dc8c188872", 17:41:07 INFO - "slavebuilddir": "test" 17:41:07 INFO - } 17:41:07 INFO - Found installer url https://queue.taskcluster.net/v1/task/KZq_MUjzSQ2g6TfSIOyq1w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 17:41:07 INFO - Running post-action listener: _resource_record_post_action 17:41:07 INFO - ##### 17:41:07 INFO - ##### Finished read-buildbot-config step (success) 17:41:07 INFO - ##### 17:41:07 INFO - ##### 17:41:07 INFO - ##### Running download-and-extract step. 17:41:07 INFO - ##### 17:41:07 INFO - Running pre-action listener: _resource_record_pre_action 17:41:07 INFO - Running main action method: download_and_extract 17:41:07 INFO - mkdir: /builds/slave/test/build/tests 17:41: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:41:07 INFO - https://queue.taskcluster.net/v1/task/KZq_MUjzSQ2g6TfSIOyq1w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 17:41:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KZq_MUjzSQ2g6TfSIOyq1w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 17:41:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KZq_MUjzSQ2g6TfSIOyq1w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 17:41:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KZq_MUjzSQ2g6TfSIOyq1w/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:41:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KZq_MUjzSQ2g6TfSIOyq1w/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:41:12 INFO - Downloaded 1361 bytes. 17:41:12 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 17:41:12 INFO - Using the following test package requirements: 17:41:12 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 17:41:12 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:41:12 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 17:41:12 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:41:12 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 17:41:12 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:41:12 INFO - u'jsshell-linux-x86_64.zip'], 17:41:12 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:41:12 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 17:41:12 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 17:41:12 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:41:12 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 17:41:12 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:41:12 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 17:41:12 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:41:12 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 17:41:12 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:41:12 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 17:41:12 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:41:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:41:12 INFO - https://queue.taskcluster.net/v1/task/KZq_MUjzSQ2g6TfSIOyq1w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:41:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KZq_MUjzSQ2g6TfSIOyq1w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 17:41:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KZq_MUjzSQ2g6TfSIOyq1w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 17:41:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KZq_MUjzSQ2g6TfSIOyq1w/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:41:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KZq_MUjzSQ2g6TfSIOyq1w/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:41:20 INFO - Downloaded 22653673 bytes. 17:41:20 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:41:20 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:41:21 INFO - Return code: 0 17:41:21 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:41:21 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:41:21 INFO - https://queue.taskcluster.net/v1/task/KZq_MUjzSQ2g6TfSIOyq1w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:41:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KZq_MUjzSQ2g6TfSIOyq1w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 17:41:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KZq_MUjzSQ2g6TfSIOyq1w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 17:41:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KZq_MUjzSQ2g6TfSIOyq1w/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:41:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KZq_MUjzSQ2g6TfSIOyq1w/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:41:22 INFO - Downloaded 22653673 bytes. 17:41:22 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:41:22 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:41:24 INFO - Return code: 0 17:41:24 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:41:24 INFO - https://queue.taskcluster.net/v1/task/KZq_MUjzSQ2g6TfSIOyq1w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 17:41:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KZq_MUjzSQ2g6TfSIOyq1w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 17:41:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KZq_MUjzSQ2g6TfSIOyq1w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 17:41:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KZq_MUjzSQ2g6TfSIOyq1w/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:41:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KZq_MUjzSQ2g6TfSIOyq1w/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:41:26 INFO - Downloaded 14405384 bytes. 17:41:26 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:41:26 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:41:26 INFO - Return code: 0 17:41:26 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:41:26 INFO - https://queue.taskcluster.net/v1/task/KZq_MUjzSQ2g6TfSIOyq1w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 17:41:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KZq_MUjzSQ2g6TfSIOyq1w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 17:41:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KZq_MUjzSQ2g6TfSIOyq1w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 17:41:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KZq_MUjzSQ2g6TfSIOyq1w/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:41:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KZq_MUjzSQ2g6TfSIOyq1w/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:41:27 INFO - Downloaded 55402146 bytes. 17:41:27 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/KZq_MUjzSQ2g6TfSIOyq1w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 17:41:27 INFO - mkdir: /builds/slave/test/properties 17:41:27 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:41:27 INFO - Writing to file /builds/slave/test/properties/build_url 17:41:27 INFO - Contents: 17:41:27 INFO - build_url:https://queue.taskcluster.net/v1/task/KZq_MUjzSQ2g6TfSIOyq1w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 17:41:28 INFO - Running post-action listener: _resource_record_post_action 17:41:28 INFO - Running post-action listener: set_extra_try_arguments 17:41:28 INFO - ##### 17:41:28 INFO - ##### Finished download-and-extract step (success) 17:41:28 INFO - ##### 17:41:28 INFO - ##### 17:41:28 INFO - ##### Running populate-webroot step. 17:41:28 INFO - ##### 17:41:28 INFO - Running pre-action listener: _resource_record_pre_action 17:41:28 INFO - Running main action method: populate_webroot 17:41:28 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:41:28 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:41:28 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:41:28 INFO - '--tppagecycles', 17:41:28 INFO - '7'], 17:41:28 INFO - 'tests': ['tsvgm']}}, 17:41:28 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:41:28 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:41:28 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:41:28 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:41:28 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:41:28 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:41:28 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:41:28 INFO - 'talos_options': ['--disable-e10s'], 17:41:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:41:28 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:41:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:41:28 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:41:28 INFO - 'talos_options': ['--disable-e10s'], 17:41:28 INFO - 'tests': ['damp', 'tps']}, 17:41:28 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:41:28 INFO - 'tests': ['damp', 'tps']}, 17:41:28 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:41:28 INFO - 'tests': ['dromaeo_dom']}, 17:41:28 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:41:28 INFO - 'g4': {'talos_options': ['--disable-e10s'], 17:41:28 INFO - 'tests': ['basic_compositor_video']}, 17:41:28 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 17:41:28 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:41:28 INFO - 'tests': ['a11yr', 17:41:28 INFO - 'ts_paint', 17:41:28 INFO - 'tpaint', 17:41:28 INFO - 'sessionrestore', 17:41:28 INFO - 'sessionrestore_no_auto_restore', 17:41:28 INFO - 'tabpaint']}, 17:41:28 INFO - 'other-e10s': {'tests': ['a11yr', 17:41:28 INFO - 'ts_paint', 17:41:28 INFO - 'tpaint', 17:41:28 INFO - 'sessionrestore', 17:41:28 INFO - 'sessionrestore_no_auto_restore', 17:41:28 INFO - 'tabpaint']}, 17:41:28 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:41:28 INFO - 'ts_paint', 17:41:28 INFO - 'tpaint', 17:41:28 INFO - 'sessionrestore', 17:41:28 INFO - 'sessionrestore_no_auto_restore', 17:41:28 INFO - 'tabpaint']}, 17:41:28 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:41:28 INFO - 'ts_paint', 17:41:28 INFO - 'tpaint', 17:41:28 INFO - 'sessionrestore', 17:41:28 INFO - 'sessionrestore_no_auto_restore', 17:41:28 INFO - 'tabpaint']}, 17:41:28 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:41:28 INFO - 'tests': ['a11yr', 17:41:28 INFO - 'ts_paint', 17:41:28 INFO - 'tpaint', 17:41:28 INFO - 'sessionrestore', 17:41:28 INFO - 'sessionrestore_no_auto_restore', 17:41:28 INFO - 'tabpaint']}, 17:41:28 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:41:28 INFO - 'tests': ['a11yr', 17:41:28 INFO - 'ts_paint', 17:41:28 INFO - 'tpaint', 17:41:28 INFO - 'sessionrestore', 17:41:28 INFO - 'sessionrestore_no_auto_restore', 17:41:28 INFO - 'tabpaint']}, 17:41:28 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:41:28 INFO - 'tests': ['tsvgx', 17:41:28 INFO - 'tsvgr_opacity', 17:41:28 INFO - 'tart', 17:41:28 INFO - 'tscrollx', 17:41:28 INFO - 'cart']}, 17:41:28 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:41:28 INFO - 'tsvgr_opacity', 17:41:28 INFO - 'tart', 17:41:28 INFO - 'tscrollx', 17:41:28 INFO - 'cart']}, 17:41:28 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:41:28 INFO - 'talos_options': ['--disable-e10s'], 17:41:28 INFO - 'tests': ['tp5o']}, 17:41:28 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:41:28 INFO - 'tests': ['tp5o']}, 17:41:28 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:41:28 INFO - 'talos_options': ['--disable-e10s', 17:41:28 INFO - '--xperf_path', 17:41:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:41:28 INFO - 'tests': ['tp5n']}, 17:41:28 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:41:28 INFO - 'talos_options': ['--xperf_path', 17:41:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:41:28 INFO - 'tests': ['tp5n']}}, 17:41:28 INFO - 'talos.zip': {'path': '', 17:41:28 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:41:28 INFO - Running post-action listener: _resource_record_post_action 17:41:28 INFO - ##### 17:41:28 INFO - ##### Finished populate-webroot step (success) 17:41:28 INFO - ##### 17:41:28 INFO - ##### 17:41:28 INFO - ##### Running create-virtualenv step. 17:41:28 INFO - ##### 17:41:28 INFO - Running pre-action listener: _resource_record_pre_action 17:41:28 INFO - Running main action method: create_virtualenv 17:41:28 INFO - Creating virtualenv /builds/slave/test/build/venv 17:41:28 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:41:28 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:41:28 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:41:28 INFO - Using real prefix '/usr' 17:41:28 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:41:29 INFO - Installing distribute.............................................................................................................................................................................................done. 17:41:31 INFO - Installing pip.................done. 17:41:31 INFO - Return code: 0 17:41:31 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:41:31 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:41:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:41:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:41:31 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:41:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:41:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:41:31 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 0x7f74c6b18f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26528a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x271f020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27b12e0>, '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 0x271d140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x271d5d0>, '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': 'db0483c52d987ecb441a263b000001ad-1465859452.452570-1278319449', '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:41:31 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:41:31 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:41:31 INFO - Using env: {'DISPLAY': ':0', 17:41:31 INFO - 'HOME': '/home/cltbld', 17:41:31 INFO - 'LANG': 'en_US.UTF-8', 17:41:31 INFO - 'LANGUAGE': 'en_US:en', 17:41:31 INFO - 'LOGNAME': 'cltbld', 17:41:31 INFO - 'MAIL': '/var/mail/cltbld', 17:41:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:41:31 INFO - 'MOZ_NO_REMOTE': '1', 17:41:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:41:31 INFO - 'NO_EM_RESTART': '1', 17:41:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:41:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:41:31 INFO - 'PWD': '/builds/slave/test', 17:41:31 INFO - 'SHELL': '/bin/bash', 17:41:31 INFO - 'SHLVL': '1', 17:41:31 INFO - 'TERM': 'linux', 17:41:31 INFO - 'TMOUT': '86400', 17:41:31 INFO - 'USER': 'cltbld', 17:41:31 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1465859452.452570-1278319449', 17:41:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:41:31 INFO - '_': '/tools/buildbot/bin/python'} 17:41:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:41:31 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:41:31 INFO - Cleaning up... 17:41:31 INFO - Return code: 0 17:41:31 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:41:31 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:41:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:41:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:41:31 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:41:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:41:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:41:31 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 0x7f74c6b18f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26528a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x271f020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27b12e0>, '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 0x271d140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x271d5d0>, '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': 'db0483c52d987ecb441a263b000001ad-1465859452.452570-1278319449', '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:41:31 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:41:31 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:41:31 INFO - Using env: {'DISPLAY': ':0', 17:41:31 INFO - 'HOME': '/home/cltbld', 17:41:31 INFO - 'LANG': 'en_US.UTF-8', 17:41:31 INFO - 'LANGUAGE': 'en_US:en', 17:41:31 INFO - 'LOGNAME': 'cltbld', 17:41:31 INFO - 'MAIL': '/var/mail/cltbld', 17:41:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:41:31 INFO - 'MOZ_NO_REMOTE': '1', 17:41:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:41:31 INFO - 'NO_EM_RESTART': '1', 17:41:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:41:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:41:31 INFO - 'PWD': '/builds/slave/test', 17:41:31 INFO - 'SHELL': '/bin/bash', 17:41:31 INFO - 'SHLVL': '1', 17:41:31 INFO - 'TERM': 'linux', 17:41:31 INFO - 'TMOUT': '86400', 17:41:31 INFO - 'USER': 'cltbld', 17:41:31 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1465859452.452570-1278319449', 17:41:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:41:31 INFO - '_': '/tools/buildbot/bin/python'} 17:41:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:41:31 INFO - Downloading/unpacking psutil>=3.1.1 17:41:31 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:41:31 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:41:31 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:41:31 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:41:31 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:41:31 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:41:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:41:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:41:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:41:33 INFO - Installing collected packages: psutil 17:41:33 INFO - Running setup.py install for psutil 17:41:33 INFO - building 'psutil._psutil_linux' extension 17:41:33 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:41:33 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:41:33 INFO - building 'psutil._psutil_posix' extension 17:41:33 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:41:33 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:41:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:41:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:41:34 INFO - Successfully installed psutil 17:41:34 INFO - Cleaning up... 17:41:34 INFO - Return code: 0 17:41:34 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:41:34 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:41:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:41:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:41:34 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:41:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:41:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:41:34 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 0x7f74c6b18f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26528a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x271f020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27b12e0>, '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 0x271d140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x271d5d0>, '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': 'db0483c52d987ecb441a263b000001ad-1465859452.452570-1278319449', '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:41:34 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:41:34 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:41:34 INFO - Using env: {'DISPLAY': ':0', 17:41:34 INFO - 'HOME': '/home/cltbld', 17:41:34 INFO - 'LANG': 'en_US.UTF-8', 17:41:34 INFO - 'LANGUAGE': 'en_US:en', 17:41:34 INFO - 'LOGNAME': 'cltbld', 17:41:34 INFO - 'MAIL': '/var/mail/cltbld', 17:41:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:41:34 INFO - 'MOZ_NO_REMOTE': '1', 17:41:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:41:34 INFO - 'NO_EM_RESTART': '1', 17:41:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:41:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:41:34 INFO - 'PWD': '/builds/slave/test', 17:41:34 INFO - 'SHELL': '/bin/bash', 17:41:34 INFO - 'SHLVL': '1', 17:41:34 INFO - 'TERM': 'linux', 17:41:34 INFO - 'TMOUT': '86400', 17:41:34 INFO - 'USER': 'cltbld', 17:41:34 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1465859452.452570-1278319449', 17:41:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:41:34 INFO - '_': '/tools/buildbot/bin/python'} 17:41:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:41:34 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:41:34 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:41:34 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:41:34 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:41:34 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:41:34 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:41:34 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:41:36 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:41:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:41:36 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:41:36 INFO - Installing collected packages: mozsystemmonitor 17:41:36 INFO - Running setup.py install for mozsystemmonitor 17:41:36 INFO - Successfully installed mozsystemmonitor 17:41:36 INFO - Cleaning up... 17:41:36 INFO - Return code: 0 17:41:36 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:41:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:41:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:41:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:41:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:41:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:41:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:41:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f74c6b18f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26528a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x271f020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27b12e0>, '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 0x271d140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x271d5d0>, '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': 'db0483c52d987ecb441a263b000001ad-1465859452.452570-1278319449', '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:41:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 17:41:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 17:41:36 INFO - Using env: {'DISPLAY': ':0', 17:41:36 INFO - 'HOME': '/home/cltbld', 17:41:36 INFO - 'LANG': 'en_US.UTF-8', 17:41:36 INFO - 'LANGUAGE': 'en_US:en', 17:41:36 INFO - 'LOGNAME': 'cltbld', 17:41:36 INFO - 'MAIL': '/var/mail/cltbld', 17:41:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:41:36 INFO - 'MOZ_NO_REMOTE': '1', 17:41:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:41:36 INFO - 'NO_EM_RESTART': '1', 17:41:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:41:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:41:36 INFO - 'PWD': '/builds/slave/test', 17:41:36 INFO - 'SHELL': '/bin/bash', 17:41:36 INFO - 'SHLVL': '1', 17:41:36 INFO - 'TERM': 'linux', 17:41:36 INFO - 'TMOUT': '86400', 17:41:36 INFO - 'USER': 'cltbld', 17:41:36 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1465859452.452570-1278319449', 17:41:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:41:36 INFO - '_': '/tools/buildbot/bin/python'} 17:41:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:41:36 INFO - Downloading/unpacking jsonschema==2.5.1 17:41:36 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:41:36 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:41:36 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:41:36 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:41:36 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:41:36 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:41:38 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:41:38 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:41:38 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:41:38 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:41:38 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:41:38 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:41:38 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:41:38 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:41:38 INFO - Downloading functools32-3.2.3-2.tar.gz 17:41:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:41:38 INFO - warning: no files found matching '*.txt' 17:41:38 INFO - no previously-included directories found matching 'build' 17:41:38 INFO - no previously-included directories found matching 'dist' 17:41:38 INFO - no previously-included directories found matching '.git*' 17:41:38 INFO - Installing collected packages: jsonschema, functools32 17:41:38 INFO - Running setup.py install for functools32 17:41:38 INFO - warning: no files found matching '*.txt' 17:41:38 INFO - no previously-included directories found matching 'build' 17:41:38 INFO - no previously-included directories found matching 'dist' 17:41:38 INFO - no previously-included directories found matching '.git*' 17:41:38 INFO - Successfully installed jsonschema functools32 17:41:38 INFO - Cleaning up... 17:41:38 INFO - Return code: 0 17:41:38 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:41:38 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:41:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:41:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:41:38 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:41:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:41:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:41:38 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 0x7f74c6b18f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26528a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x271f020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27b12e0>, '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 0x271d140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x271d5d0>, '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': 'db0483c52d987ecb441a263b000001ad-1465859452.452570-1278319449', '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:41:38 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:41:38 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:41:38 INFO - Using env: {'DISPLAY': ':0', 17:41:38 INFO - 'HOME': '/home/cltbld', 17:41:38 INFO - 'LANG': 'en_US.UTF-8', 17:41:38 INFO - 'LANGUAGE': 'en_US:en', 17:41:38 INFO - 'LOGNAME': 'cltbld', 17:41:38 INFO - 'MAIL': '/var/mail/cltbld', 17:41:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:41:38 INFO - 'MOZ_NO_REMOTE': '1', 17:41:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:41:38 INFO - 'NO_EM_RESTART': '1', 17:41:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:41:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:41:38 INFO - 'PWD': '/builds/slave/test', 17:41:38 INFO - 'SHELL': '/bin/bash', 17:41:38 INFO - 'SHLVL': '1', 17:41:38 INFO - 'TERM': 'linux', 17:41:38 INFO - 'TMOUT': '86400', 17:41:38 INFO - 'USER': 'cltbld', 17:41:38 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1465859452.452570-1278319449', 17:41:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:41:38 INFO - '_': '/tools/buildbot/bin/python'} 17:41:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:41:39 INFO - Downloading/unpacking blobuploader==1.2.4 17:41:39 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:41:39 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:41:39 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:41:39 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:41:39 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:41:39 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:41:40 INFO - Downloading blobuploader-1.2.4.tar.gz 17:41:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:41:41 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:41:41 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:41:41 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:41:41 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:41:41 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:41:41 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:41:41 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:41:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:41:41 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:41:41 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:41:41 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:41:41 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:41:41 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:41:41 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:41:41 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:41:41 INFO - Downloading docopt-0.6.1.tar.gz 17:41:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:41:41 INFO - Installing collected packages: blobuploader, requests, docopt 17:41:41 INFO - Running setup.py install for blobuploader 17:41:41 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:41:41 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:41:41 INFO - Running setup.py install for requests 17:41:42 INFO - Running setup.py install for docopt 17:41:42 INFO - Successfully installed blobuploader requests docopt 17:41:42 INFO - Cleaning up... 17:41:42 INFO - Return code: 0 17:41:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:41:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:41:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:41:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:41:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:41:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:41:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:41:42 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 0x7f74c6b18f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26528a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x271f020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27b12e0>, '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 0x271d140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x271d5d0>, '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': 'db0483c52d987ecb441a263b000001ad-1465859452.452570-1278319449', '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:41:42 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:41:42 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:41:42 INFO - Using env: {'DISPLAY': ':0', 17:41:42 INFO - 'HOME': '/home/cltbld', 17:41:42 INFO - 'LANG': 'en_US.UTF-8', 17:41:42 INFO - 'LANGUAGE': 'en_US:en', 17:41:42 INFO - 'LOGNAME': 'cltbld', 17:41:42 INFO - 'MAIL': '/var/mail/cltbld', 17:41:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:41:42 INFO - 'MOZ_NO_REMOTE': '1', 17:41:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:41:42 INFO - 'NO_EM_RESTART': '1', 17:41:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:41:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:41:42 INFO - 'PWD': '/builds/slave/test', 17:41:42 INFO - 'SHELL': '/bin/bash', 17:41:42 INFO - 'SHLVL': '1', 17:41:42 INFO - 'TERM': 'linux', 17:41:42 INFO - 'TMOUT': '86400', 17:41:42 INFO - 'USER': 'cltbld', 17:41:42 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1465859452.452570-1278319449', 17:41:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:41:42 INFO - '_': '/tools/buildbot/bin/python'} 17:41:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:41:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:41:42 INFO - Running setup.py (path:/tmp/pip-Xj_nVP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:41:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:41:42 INFO - Running setup.py (path:/tmp/pip-jSySt_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:41:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:41:42 INFO - Running setup.py (path:/tmp/pip-kHj6o7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:41:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:41:42 INFO - Running setup.py (path:/tmp/pip-msJxQA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:41:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:41:42 INFO - Running setup.py (path:/tmp/pip-0t0PxF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:41:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:41:42 INFO - Running setup.py (path:/tmp/pip-jkldpD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:41:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:41:42 INFO - Running setup.py (path:/tmp/pip-cLLUhk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:41:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:41:43 INFO - Running setup.py (path:/tmp/pip-evTgJq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:41:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:41:43 INFO - Running setup.py (path:/tmp/pip-rPhlr3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:41:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:41:43 INFO - Running setup.py (path:/tmp/pip-tfwZ1k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:41:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:41:43 INFO - Running setup.py (path:/tmp/pip-VqcDv1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:41:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:41:43 INFO - Running setup.py (path:/tmp/pip-CKyVGO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:41:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:41:43 INFO - Running setup.py (path:/tmp/pip-72qtpc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:41:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:41:43 INFO - Running setup.py (path:/tmp/pip-0SBzNS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:41:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:41:43 INFO - Running setup.py (path:/tmp/pip-y8YPZx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:41:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:41:43 INFO - Running setup.py (path:/tmp/pip-pIfuS4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:41:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:41:43 INFO - Running setup.py (path:/tmp/pip-fHLfvQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:41:43 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:41:43 INFO - Running setup.py install for manifestparser 17:41:43 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:41:43 INFO - Running setup.py install for mozcrash 17:41:43 INFO - Running setup.py install for mozdebug 17:41:44 INFO - Running setup.py install for mozdevice 17:41:44 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:41:44 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:41:44 INFO - Running setup.py install for mozfile 17:41:44 INFO - Running setup.py install for mozhttpd 17:41:44 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:41:44 INFO - Running setup.py install for mozinfo 17:41:44 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:41:44 INFO - Running setup.py install for mozInstall 17:41:44 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:41:44 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:41:44 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:41:44 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:41:44 INFO - Running setup.py install for mozleak 17:41:44 INFO - Running setup.py install for mozlog 17:41:44 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:41:44 INFO - Running setup.py install for moznetwork 17:41:44 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:41:44 INFO - Running setup.py install for mozprocess 17:41:44 INFO - Running setup.py install for mozprofile 17:41:45 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:41:45 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:41:45 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:41:45 INFO - Running setup.py install for mozrunner 17:41:45 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:41:45 INFO - Running setup.py install for mozscreenshot 17:41:45 INFO - Running setup.py install for moztest 17:41:45 INFO - Running setup.py install for mozversion 17:41:45 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:41:45 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:41:45 INFO - Cleaning up... 17:41:45 INFO - Return code: 0 17:41:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:41:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:41:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:41:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:41:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:41:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:41:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:41:45 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 0x7f74c6b18f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26528a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x271f020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27b12e0>, '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 0x271d140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x271d5d0>, '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': 'db0483c52d987ecb441a263b000001ad-1465859452.452570-1278319449', '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:41:45 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:41:45 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:41:45 INFO - Using env: {'DISPLAY': ':0', 17:41:45 INFO - 'HOME': '/home/cltbld', 17:41:45 INFO - 'LANG': 'en_US.UTF-8', 17:41:45 INFO - 'LANGUAGE': 'en_US:en', 17:41:45 INFO - 'LOGNAME': 'cltbld', 17:41:45 INFO - 'MAIL': '/var/mail/cltbld', 17:41:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:41:45 INFO - 'MOZ_NO_REMOTE': '1', 17:41:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:41:45 INFO - 'NO_EM_RESTART': '1', 17:41:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:41:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:41:45 INFO - 'PWD': '/builds/slave/test', 17:41:45 INFO - 'SHELL': '/bin/bash', 17:41:45 INFO - 'SHLVL': '1', 17:41:45 INFO - 'TERM': 'linux', 17:41:45 INFO - 'TMOUT': '86400', 17:41:45 INFO - 'USER': 'cltbld', 17:41:45 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1465859452.452570-1278319449', 17:41:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:41:45 INFO - '_': '/tools/buildbot/bin/python'} 17:41:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:41:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:41:45 INFO - Running setup.py (path:/tmp/pip-ui_mGn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:41:45 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:41:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:41:45 INFO - Running setup.py (path:/tmp/pip-lZKrf2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:41:45 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:41:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:41:45 INFO - Running setup.py (path:/tmp/pip-yVTBeQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:41:45 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:41:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:41:45 INFO - Running setup.py (path:/tmp/pip-6b5N9d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:41:46 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:41:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:41:46 INFO - Running setup.py (path:/tmp/pip-vREhQG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:41:46 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:41:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:41:46 INFO - Running setup.py (path:/tmp/pip-X9WJMb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:41:46 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:41:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:41:46 INFO - Running setup.py (path:/tmp/pip-5_sIbW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:41:46 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:41:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:41:46 INFO - Running setup.py (path:/tmp/pip-dKehpg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:41:46 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:41:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:41:46 INFO - Running setup.py (path:/tmp/pip-fLNDIG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:41:46 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:41:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:41:46 INFO - Running setup.py (path:/tmp/pip-w4P7Bm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:41:46 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:41:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:41:46 INFO - Running setup.py (path:/tmp/pip-1gABmG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:41:46 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:41:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:41:46 INFO - Running setup.py (path:/tmp/pip-ncL1U6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:41:46 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:41:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:41:46 INFO - Running setup.py (path:/tmp/pip-9RkBQl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:41:46 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:41:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:41:46 INFO - Running setup.py (path:/tmp/pip-6XrV5d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:41:46 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:41:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:41:46 INFO - Running setup.py (path:/tmp/pip-uYXgYL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:41:46 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:41:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:41:46 INFO - Running setup.py (path:/tmp/pip-Ch5PgF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:41:46 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:41:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:41:46 INFO - Running setup.py (path:/tmp/pip-Jkf85X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:41:46 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:41:46 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:41:46 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:41:46 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:41:46 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:41:46 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:41:47 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:41:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:41:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:41:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:41:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:41:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:41:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:41:48 INFO - Downloading blessings-1.6.tar.gz 17:41:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:41:48 INFO - Installing collected packages: blessings 17:41:48 INFO - Running setup.py install for blessings 17:41:49 INFO - Successfully installed blessings 17:41:49 INFO - Cleaning up... 17:41:49 INFO - Return code: 0 17:41:49 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:41:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:41:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:41:49 INFO - Reading from file tmpfile_stdout 17:41:49 INFO - Current package versions: 17:41:49 INFO - argparse == 1.2.1 17:41:49 INFO - blessings == 1.6 17:41:49 INFO - blobuploader == 1.2.4 17:41:49 INFO - docopt == 0.6.1 17:41:49 INFO - functools32 == 3.2.3-2 17:41:49 INFO - jsonschema == 2.5.1 17:41:49 INFO - manifestparser == 1.1 17:41:49 INFO - mozInstall == 1.12 17:41:49 INFO - mozcrash == 0.17 17:41:49 INFO - mozdebug == 0.1 17:41:49 INFO - mozdevice == 0.48 17:41:49 INFO - mozfile == 1.2 17:41:49 INFO - mozhttpd == 0.7 17:41:49 INFO - mozinfo == 0.9 17:41:49 INFO - mozleak == 0.1 17:41:49 INFO - mozlog == 3.2 17:41:49 INFO - moznetwork == 0.27 17:41:49 INFO - mozprocess == 0.22 17:41:49 INFO - mozprofile == 0.28 17:41:49 INFO - mozrunner == 6.11 17:41:49 INFO - mozscreenshot == 0.1 17:41:49 INFO - mozsystemmonitor == 0.3 17:41:49 INFO - moztest == 0.7 17:41:49 INFO - mozversion == 1.4 17:41:49 INFO - psutil == 3.1.1 17:41:49 INFO - requests == 1.2.3 17:41:49 INFO - wsgiref == 0.1.2 17:41:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:41: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:41:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:41:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:41: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:41:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:41:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:41:49 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 0x7f74c6b18f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26528a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x271f020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27b12e0>, '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 0x271d140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x271d5d0>, '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': 'db0483c52d987ecb441a263b000001ad-1465859452.452570-1278319449', '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:41:49 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:41:49 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:41:49 INFO - Using env: {'DISPLAY': ':0', 17:41:49 INFO - 'HOME': '/home/cltbld', 17:41:49 INFO - 'LANG': 'en_US.UTF-8', 17:41:49 INFO - 'LANGUAGE': 'en_US:en', 17:41:49 INFO - 'LOGNAME': 'cltbld', 17:41:49 INFO - 'MAIL': '/var/mail/cltbld', 17:41:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:41:49 INFO - 'MOZ_NO_REMOTE': '1', 17:41:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:41:49 INFO - 'NO_EM_RESTART': '1', 17:41:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:41:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:41:49 INFO - 'PWD': '/builds/slave/test', 17:41:49 INFO - 'SHELL': '/bin/bash', 17:41:49 INFO - 'SHLVL': '1', 17:41:49 INFO - 'TERM': 'linux', 17:41:49 INFO - 'TMOUT': '86400', 17:41:49 INFO - 'USER': 'cltbld', 17:41:49 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1465859452.452570-1278319449', 17:41:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:41:49 INFO - '_': '/tools/buildbot/bin/python'} 17:41:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:41:49 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:41:49 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:41:49 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:41:49 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:41:49 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:41:49 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:41:49 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:41:49 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:41:49 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:41:49 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:41:49 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:41:49 INFO - Cleaning up... 17:41:49 INFO - Return code: 0 17:41:49 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:41: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:41:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:41:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:41: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:41:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:41:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:41:49 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 0x7f74c6b18f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26528a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x271f020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27b12e0>, '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 0x271d140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x271d5d0>, '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': 'db0483c52d987ecb441a263b000001ad-1465859452.452570-1278319449', '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:41:49 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:41:49 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:41:49 INFO - Using env: {'DISPLAY': ':0', 17:41:49 INFO - 'HOME': '/home/cltbld', 17:41:49 INFO - 'LANG': 'en_US.UTF-8', 17:41:49 INFO - 'LANGUAGE': 'en_US:en', 17:41:49 INFO - 'LOGNAME': 'cltbld', 17:41:49 INFO - 'MAIL': '/var/mail/cltbld', 17:41:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:41:49 INFO - 'MOZ_NO_REMOTE': '1', 17:41:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:41:49 INFO - 'NO_EM_RESTART': '1', 17:41:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:41:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:41:49 INFO - 'PWD': '/builds/slave/test', 17:41:49 INFO - 'SHELL': '/bin/bash', 17:41:49 INFO - 'SHLVL': '1', 17:41:49 INFO - 'TERM': 'linux', 17:41:49 INFO - 'TMOUT': '86400', 17:41:49 INFO - 'USER': 'cltbld', 17:41:49 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1465859452.452570-1278319449', 17:41:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:41:49 INFO - '_': '/tools/buildbot/bin/python'} 17:41:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:41:49 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:41:49 INFO - Cleaning up... 17:41:49 INFO - Return code: 0 17:41:49 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 17:41: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:41:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:41:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:41: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:41:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:41:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:41:49 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 0x7f74c6b18f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26528a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x271f020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27b12e0>, '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 0x271d140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x271d5d0>, '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': 'db0483c52d987ecb441a263b000001ad-1465859452.452570-1278319449', '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:41:49 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:41:49 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:41:49 INFO - Using env: {'DISPLAY': ':0', 17:41:49 INFO - 'HOME': '/home/cltbld', 17:41:49 INFO - 'LANG': 'en_US.UTF-8', 17:41:49 INFO - 'LANGUAGE': 'en_US:en', 17:41:49 INFO - 'LOGNAME': 'cltbld', 17:41:49 INFO - 'MAIL': '/var/mail/cltbld', 17:41:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:41:49 INFO - 'MOZ_NO_REMOTE': '1', 17:41:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:41:49 INFO - 'NO_EM_RESTART': '1', 17:41:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:41:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:41:49 INFO - 'PWD': '/builds/slave/test', 17:41:49 INFO - 'SHELL': '/bin/bash', 17:41:49 INFO - 'SHLVL': '1', 17:41:49 INFO - 'TERM': 'linux', 17:41:49 INFO - 'TMOUT': '86400', 17:41:49 INFO - 'USER': 'cltbld', 17:41:49 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1465859452.452570-1278319449', 17:41:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:41:49 INFO - '_': '/tools/buildbot/bin/python'} 17:41:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:41:49 INFO - Downloading/unpacking flake8 17:41:49 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:41:49 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:41:49 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:41:49 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:41:49 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:41:49 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:41:51 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 17:41:51 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 17:41:51 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:41:51 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:41:51 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:41:51 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:41:51 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:41:51 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:41:52 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 17:41:52 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 17:41:52 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:41:52 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:41:52 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:41:52 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:41:52 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:41:52 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:41:52 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 17:41:52 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:41:52 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:41:52 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:41:52 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:41:52 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:41:52 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:41:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 17:41:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:41:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:41:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:41:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:41:52 INFO - no previously-included directories found matching 'docs/_build' 17:41:52 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 17:41:52 INFO - Running setup.py install for pep8 17:41:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:41:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:41:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:41:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:41:52 INFO - no previously-included directories found matching 'docs/_build' 17:41:52 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 17:41:52 INFO - Successfully installed flake8 mccabe pyflakes pep8 17:41:52 INFO - Cleaning up... 17:41:52 INFO - Return code: 0 17:41:52 INFO - Running post-action listener: _resource_record_post_action 17:41:52 INFO - Running post-action listener: _start_resource_monitoring 17:41:52 INFO - Starting resource monitoring. 17:41:52 INFO - ##### 17:41:52 INFO - ##### Finished create-virtualenv step (success) 17:41:52 INFO - ##### 17:41:52 INFO - ##### 17:41:52 INFO - ##### Running install step. 17:41:52 INFO - ##### 17:41:52 INFO - Running pre-action listener: _resource_record_pre_action 17:41:52 INFO - Running main action method: install 17:41:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:41:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:41:53 INFO - Reading from file tmpfile_stdout 17:41:53 INFO - Detecting whether we're running mozinstall >=1.0... 17:41:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:41:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:41:53 INFO - Reading from file tmpfile_stdout 17:41:53 INFO - Output received: 17:41:53 INFO - Usage: mozinstall [options] installer 17:41:53 INFO - Options: 17:41:53 INFO - -h, --help show this help message and exit 17:41:53 INFO - -d DEST, --destination=DEST 17:41:53 INFO - Directory to install application into. [default: 17:41:53 INFO - "/builds/slave/test"] 17:41:53 INFO - --app=APP Application being installed. [default: firefox] 17:41:53 INFO - mkdir: /builds/slave/test/build/application 17:41:53 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:41:53 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:42:09 INFO - Reading from file tmpfile_stdout 17:42:09 INFO - Output received: 17:42:09 INFO - /builds/slave/test/build/application/firefox/firefox 17:42:09 INFO - Running post-action listener: _resource_record_post_action 17:42:09 INFO - ##### 17:42:09 INFO - ##### Finished install step (success) 17:42:09 INFO - ##### 17:42:09 INFO - ##### 17:42:09 INFO - ##### Running run-tests step. 17:42:09 INFO - ##### 17:42:09 INFO - Running pre-action listener: _resource_record_pre_action 17:42:09 INFO - Running main action method: run_tests 17:42:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:42:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:42:09 INFO - Python 2.7.3 17:42:09 INFO - Return code: 0 17:42:09 INFO - grabbing minidump binary from tooltool 17:42:09 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:42:09 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 0x27b12e0>, '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 0x271d140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x271d5d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:42:09 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:42:09 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:42:09 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:42:09 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:42:09 INFO - Return code: 0 17:42:09 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:42:09 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:42:09 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:42:09 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:42:09 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:42:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 17:42:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 17:42:10 INFO - Return code: 0 17:42:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/KZq_MUjzSQ2g6TfSIOyq1w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-031', '--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:42:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/KZq_MUjzSQ2g6TfSIOyq1w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-031 --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:42:10 INFO - Using env: {'DISPLAY': ':0', 17:42:10 INFO - 'HOME': '/home/cltbld', 17:42:10 INFO - 'LANG': 'en_US.UTF-8', 17:42:10 INFO - 'LANGUAGE': 'en_US:en', 17:42:10 INFO - 'LOGNAME': 'cltbld', 17:42:10 INFO - 'MAIL': '/var/mail/cltbld', 17:42:10 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:42:10 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:42:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:42:10 INFO - 'MOZ_NO_REMOTE': '1', 17:42:10 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:42:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:42:10 INFO - 'NO_EM_RESTART': '1', 17:42:10 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:42:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:42:10 INFO - 'PWD': '/builds/slave/test', 17:42:10 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:42:10 INFO - 'SHELL': '/bin/bash', 17:42:10 INFO - 'SHLVL': '1', 17:42:10 INFO - 'TERM': 'linux', 17:42:10 INFO - 'TMOUT': '86400', 17:42:10 INFO - 'USER': 'cltbld', 17:42:10 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1465859452.452570-1278319449', 17:42:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:42:10 INFO - '_': '/tools/buildbot/bin/python'} 17:42:10 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/KZq_MUjzSQ2g6TfSIOyq1w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-031', '--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:42:10 INFO - mozversion application_buildid: 20160613162026 17:42:10 INFO - mozversion application_changeset: 79bcc05ef105fb5362888694307faa261615c34d 17:42:10 INFO - mozversion application_display_name: Nightly 17:42:10 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:42:10 INFO - mozversion application_name: Firefox 17:42:10 INFO - mozversion application_remotingname: firefox 17:42:10 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 17:42:10 INFO - mozversion application_vendor: Mozilla 17:42:10 INFO - mozversion application_version: 50.0a1 17:42:10 INFO - mozversion platform_buildid: 20160613162026 17:42:10 INFO - mozversion platform_changeset: 79bcc05ef105fb5362888694307faa261615c34d 17:42:10 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 17:42:10 INFO - mozversion platform_version: 50.0a1 17:42:10 INFO - using testdate: 1465864930 17:42:10 INFO - actual date: 1465864930 17:42:10 INFO - starting webserver on 'localhost:45034' 17:42:10 INFO - SUITE-START | Running 2 tests 17:42:10 INFO - TEST-START | dromaeo_css 17:42:10 INFO - operating with platform_type : linux_ 17:42:10 INFO - Initialising browser for dromaeo_css test... 17:42:10 INFO - TEST-INFO | started process 15743 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp340uXA/profile http://localhost:45034/getInfo.html) 17:42:15 INFO - PROCESS | 15743 | __metrics Screen width/height:1600/1200 17:42:15 INFO - PROCESS | 15743 | colorDepth:24 17:42:15 INFO - PROCESS | 15743 | Browser inner width/height: 1024/697 17:42:15 INFO - PROCESS | 15743 | __metrics 17:42:16 ERROR - PROCESS | 15743 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 17:42:17 INFO - TEST-INFO | 15743: exit 0 17:42:17 INFO - Browser initialized. 17:42:17 INFO - Running cycle 1/1 for dromaeo_css test... 17:42:17 INFO - TEST-INFO | started process 15862 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp340uXA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:42:29 INFO - PROCESS | 15862 | RSS: Main: 186327040 17:42:29 INFO - PROCESS | 15862 | 17:43:18 INFO - PROCESS | 15862 | 1465864998872 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:45:31 INFO - PROCESS | 15862 | Cycle 1(1): loaded http://localhost:45034/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45034/tests/dromaeo/cssquery-ext.html) 17:45:31 INFO - PROCESS | 15862 | RSS: Main: 190107648 17:45:31 INFO - PROCESS | 15862 | 17:48:34 INFO - PROCESS | 15862 | Cycle 1(1): loaded http://localhost:45034/tests/dromaeo/cssquery-ext.html (next: http://localhost:45034/tests/dromaeo/cssquery-jquery.html) 17:48:34 INFO - PROCESS | 15862 | RSS: Main: 188313600 17:48:34 INFO - PROCESS | 15862 | 17:51:36 INFO - PROCESS | 15862 | Cycle 1(1): loaded http://localhost:45034/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45034/tests/dromaeo/cssquery-mootools.html) 17:51:37 INFO - PROCESS | 15862 | RSS: Main: 189779968 17:51:37 INFO - PROCESS | 15862 | 17:54:39 INFO - PROCESS | 15862 | Cycle 1(1): loaded http://localhost:45034/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45034/tests/dromaeo/cssquery-prototype.html) 17:54:40 INFO - PROCESS | 15862 | RSS: Main: 187502592 17:54:40 INFO - PROCESS | 15862 | 17:57:42 INFO - PROCESS | 15862 | Cycle 1(1): loaded http://localhost:45034/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45034/tests/dromaeo/cssquery-yui.html) 17:57:43 INFO - PROCESS | 15862 | RSS: Main: 189251584 17:57:43 INFO - PROCESS | 15862 | 18:00:45 INFO - PROCESS | 15862 | Cycle 1(1): loaded http://localhost:45034/tests/dromaeo/cssquery-yui.html (next: http://localhost:45034/tests/dromaeo/cssquery-dojo.html) 18:00:46 INFO - PROCESS | 15862 | RSS: Main: 190681088 18:00:46 INFO - PROCESS | 15862 | 18:00:46 INFO - PROCESS | 15862 | __start_tp_report 18:00:46 INFO - PROCESS | 15862 | _x_x_mozilla_page_load 18:00:46 INFO - PROCESS | 15862 | _x_x_mozilla_page_load_details 18:00:46 INFO - PROCESS | 15862 | |i|pagename|runs| 18:00:46 INFO - PROCESS | 15862 | |0;dojo.html;2606.1920804550587;2680.517506848767;2692.6903406108304;2693.757561819437;2697.824641398309;4752.857414277569;4755.667103302771;4801.783919723612;4846.009767536601;4904.068227036861;4685.437747470309;4830.323754674339;4843.467218605951;4866;4880.145974454465;4443.111377724452;4462.397576327203;4588.724676519403;4588.816447342102;4612.238980568202;4262.1688770689725;4551.45382554094;4553.954460455386;4630.467496237925;4648.86053418398;4324.740515569045;4425.181341451842;4445.73325600465;4451;4470.865874023768;4414.3378493225955;4421.823127074913;4495.258282383403;4511.932321015187;4520.50274469808;4467.843625473125;4488.551144885518;4492.84275050375;4501.324801279801;4552.385427967215;4750.904981900343;4838.782254798542;4849.030193961222;4859.635527335464;4876.634252431047;5159.484051594848;5171.095058364771;5178.948210517884;5189.870253243661;5253.290805741252;5152.433232344439;5162.92255616166;5213.2701421800975;5223.555997740196;5225.294585230983;4894.1679914414635;4896.706197628154;4897.4857639948;4908.141075311806;4937.604991600663;5343.332083489564;5350.8662283442445;5352.812651557177;5353;5369.033573956725;4919.975400122977;4967.403911530567;4983.476734942778;4984.077945580079;5124.256982737482;4965.652404331662;5085.796568137233;5093.796248150033;5096.464871188472;5106.821261255913;5090.9236361454605;5139.486051394905;5207.0366982108435;5207.062728708869;5209.270702101709;5001.274815151855;5082.085224659597;5135.871603209875;5194.97402512985;5204.947950520522;4359.455068116486;4370.978145109254;4371.628411584988;4402.273624851928;4411.360352748898;3837.1750073733724;3868.9226215475533;3887.630675085862;3895.824687889052;3939.5272567291536;4368.628666563314;4506.985928166137;4507.549245075532;4556.134334476439;4565.383673204141;5252.947470525322;5284.81503147388;5286.97356513215;5287.524122828964;5295.576353891679;4549.977250113729;4555.567221113989;4560.84037058708;4582.198115329804;4588.701734387254;4460.375547423363;4578.175928332866;4610.239310513728;4625.259958406638;4651.279051746985;4891.584215341736;4893.290472881484;4918.43438004634;4939.481354457874;4959.950400496094;5022.4977502249485;5263.842084737464;5272.314599102092;5280.260763493191;5326.493983071602;4709.929351059805;4711.976440117777;4715.976420117878;4749.026449577759;4765.142274390643;4949.183384741621;4951.851444456672;4951.950480495149;4961.652684312208;5019.247112933089;5011.047900898818;5036.142192296296;5039.571636410946;5081.720505372092;5189.584833213409;4872.634552408655;4966.553010229097;5045.419776725724;5081.212412076134;5176.611754118381;5045.646804723634;5048.1165795984825;5048.495150484922;5056.089903817201;5089.465606111453;4813.422389313305;4902.166631672696;4911.877203069952;4914.287428322945;4922.286268491121;5073.898522029465;5115.79536818538;5156.303898973591;5163.27714120016;5182.144946083854;4998.875028124326;5051.949480505148;5060.3927528696795;5064.924026139684;5107.923381149211 18:00:46 INFO - PROCESS | 15862 | |1;ext.html;546.8189673015735;580.4021857486789;591.1723586978233;592.4223881715326;596.3916804859044;39284.803575982114;40678.389824152626;40704.796476017655;40834.38748418769;44147.558524414744;40908.181836363256;41265.58734412655;41326.38010429838;41399.58600413995;41453.58546414535;7941.483803552779;8030.317423019051;8036.758897233092;8040.879386809173;8045.6379462924015;7940.76918077696;7977;8019.679212831509;8037.437379383446;8059.355251579859;7969.043714754209;8005.319547838411;8006.6797328107095;8007.759767206993;8078.434509584332;7957.960210198969;8021.558814265213;8026.5986700664735;8039.919600803975;8042.517448953023;7863.68545258189;7980.640871160754;7984.121746607869;7985.760427187193;8004.63979120941;39231.21537569233;39493.80253098716;39574.406383904265;39610.60389396098;39713.40429893554;3041.260827195245;3447.844846981892;3576.588692300367;3825.062859599416;3913.882583522499;29958.101256962327;30112.84943575268;30138.54792178119;30421.23946901323;31334.843325783455;3558.6619271169197;3564.198055437532;3584.301061293049;3656.3235801376563;3667;247550;248499;248902;250139.99999999817;251848;31861.681383186336;32552.186195345304;32597.837010814794;44773.776131119135;45031.32453013207;33815.32369352599;33841.15397115042;33902.66097339044;34042.31915361679;34205.657943420745;12781.808272875915;12901.935490322488;12910.548130815376;12929.612111636667;12959.352032398343;10522.053015228666;10542.47287635615;10579.153667706565;10611.098056665116;10614.416207108528;7853.09689385728;7874.881876771853;7884.921150788418;7939.325157361689;7956.124826269222;3059.541068839692;3163.351512939842;3165;3180.475221588458;3183.363327334542;819.209462868323;847.7880529867533;875.0636818604032;888.6134531478828;893.6827426263712;27642.585361219597;27716.72283277182;28368.432631347256;28672.13983580496;28718.569221461694;963.210167662524;975.5512464266375;976.0581039297113;997.2670087485692;1024.9047875416202;14856.851431485547;15023.09861408319;15123.092614443169;15372.38510459569;15436;391387;398296.03407931677;400425;404224;404481;48682.51317486851;48857;49270.26094608584;49422.752886235336;49577.50422495801;1196.3958201108385;1202.624791750645;1224.3082658298033;1225.1240363140398;1228.950841966329;24771.504569908862;25511.617325739757;25536.23391298264;25628.231153065437;26105.73894261033;43030.78484607557;43105;43368;43440.56559434365;43524.34713479237;324056;324128;325541;326346;326559;25432.872835635702;25469;25790.484190316463;25819.870900645376;26230.4753904917;42625.36061959135;42788;42936.78531607322;43289.783551082044;43413.13173736571;36635.81682091679;37104;37221.25557488889;37389.25221495609;38046.61953380431;36290;36453.45319820152;36626.26747465089;38449.23101538009;39382.40926386049;35682.82158589191;38568.61431385762;38850.22299553936;39241.80379098086;40391;38793.418098729104;39554.802225988686;40232.195356093296;40774;40782.59217407788;31071;31550;33061.17347066342;33221.66778332186;33540.49689254712 18:00:46 INFO - PROCESS | 15862 | |2;jquery.html;353.6940546427341;359.75716391435776;362.7478902162997;374.3710566248701;378.2699390176959;15765.763513547292;16726.16369181542;17370.652586948287;17383.82616173836;17411.129443527803;16149.677006459864;16528.42150524729;17194.484165475023;17230.310787568484;17252.82747172528;5024.824131155401;5240.60695447841;5263.184206448007;5277.8416647500635;5279.9208011879855;3755.0800053986677;5210.76551555181;5784.768609255625;6044.335123136451;6117.938820611804;6096.6037207581585;6108.69456527174;6111.602745821508;6122.081687746829;6154.261488621371;5473.562115030788;5834.212381328509;5838.2118414013985;5844.152597873327;5907.911381329283;5158.845234642967;5212.478752124795;5242.056429842627;5249.685018898878;5281.815136470205;11635.534578616845;11746.706332341675;11817.35004574748;18480.244376784183;19640.312589059315;1872.3446793622122;1937.5253062999514;2165.220520612578;2312.606856834342;2398.1486572266767;8880.555972201364;9008.144226298491;9058.77353066172;9160.587773550205;9171.082891710843;1697.6774412861516;1736.5919009032866;1739.652069586088;1753.3600235913927;1764.673535395943;66700;67517.66241168811;68460;68712.3128768716;68896;9863;10140.391576505433;10201.489925503694;10635.46822658864;10833.837492437462;13960;13964.301784910715;14059.523750006101;14068.648283792782;14119.647008824657;6844.5208835381045;6857.074294970115;7007.894881576781;7010.579365238102;7229.89155162673;6352.333005034405;6412.67936603168;6473.77341793035;6484.578502397329;6508.284088750233;4347.195768782785;4403.889902752457;4448.799804008828;4456.955430445654;4493.168763778712;1669.6410271791624;1799.3252530301138;3139.372125574894;3258.185453636591;3265.951010734841;749.3855038868185;818.9508629482131;847.4110493207285;914.7713071732067;972.4505654305436;16423.6715265694;16650.916745416194;16661.91669041647;17329.393471228446;17642.294308227785;821.1993306526209;864.9394542382099;889.9644014239358;905.4567259644292;923.1460898668839;6641.86716265672;9372.5313734313;9572.712818615313;9770.120689138012;9798.922118566952;400284;404083;418965;422670;427936;52289.47710522846;52347.73826130921;66231;67742;79782;409.19184610394234;431.02803178831533;433.38892162051354;435.7821089455272;872.3980453487073;9216.585253663467;9695.951520242354;9713.56288966984;9935.801283974424;9948.35335703177;25542.620656801355;26927.461450771265;33356.666433335355;35834.8208258957;36557.63442365542;45771.08457830758;47188.292175616705;51271.48728512667;51518.48481515287;51778.74110629423;7321.231270716711;7515.661795219119;7609.896564998155;7614.885776713464;7731.613419329124;9313.25493960495;10611.946940265248;11016.889831101907;11211.66365009051;11433.371164586028;9642;10003.449810260505;10003.649872254437;10039.247056470647;10297.485125743833;9867.457289849128;9872.703818885446;10065.69802905914;10100.747481313027;10137.189024877845;9179.954100229455;9585.089416505421;9746.9025309746;9884.11043006133;10221.33561318512;7170.498065135391;7217.566945983258;7464.738734144496;7480.588567628833;7493.737719179802;9530.380525266113;9883.258755593502;9887.901120988698;9937.552810123418;10043.548040338057 18:00:46 INFO - PROCESS | 15862 | |3;mootools.html;1368.4321006782184;1395.7417877692624;1461.7807328900662;1647.7281248593983;1652.7025135475617;7082.043924070249;7698.807529811757;7770.922290777091;8277.130901255365;8301.252887240147;7906.841863162747;8024.558649274288;8109.107998120202;8135.9016532768055;8163.714270000552;2199.7030400895915;2225.5993921094196;2227.2204728345114;2244.7979681828633;2246.7528571857083;2179.08478439056;2216.8780717060554;2236.13908645172;2242.798148166673;2255.9436014099697;2260.2993072147606;2269.035659844568;2269.716285464317;2270.2621647964397;2282.417983414227;2152.2897443843494;2159.1903036361286;2178.2049551913437;2184.6941428200066;2196.8901554922268;2182.639864422368;2182.71624688791;2183.9017244224046;2184.6722991551237;2205.933821985327;8103.230193131702;8142.307903828182;8157.347412207068;8179.836403271901;8246.917530824676;4648.651351148644;4785.569298763093;4804.6876952997945;4811.735354555498;4831.299461578086;2865.6991015943236;3051.893183738581;3113.2839446927105;3126.937461250762;3131.906042818719;906.419891269588;946.3612061858287;949.5299826585815;1715.5968347438343;1763.9206235719423;10770.138388928945;10830.079443247334;10863.565457381774;10903.945480272627;10906.454677266185;4091.8158682859344;4092.9181416371507;4191.7484950903045;4204;4260.467441569804;8417.70538031166;8451.36614753896;8469.703560375357;8478.194571515696;8481.448705834102;4618.97690511552;4638.698484598491;4650.023495066006;4654;4675.22858728306;3809.7142714296538;4178.185253875465;4256.446661933929;4293.012607100384;4344.109457561192;3412.4710669846213;3447;3537.699295559855;3545.1137215696076;3555.520004799319;1029.8414283930579;1051.9737006574744;1058.571278632155;1068.0387651113904;1070.1813112968584;632.7975047984601;788.7673136424769;791.2364568191723;792.8533221354068;801.7514570483169;5390.703511306838;5398.757055932492;5518.503334699896;5567.721613919288;5652.773889044474;411.7611785164597;427.24591096714323;438.2330920888445;440.5154330236714;440.65408654206936;3651.3975194092677;3763.2285381496727;3778.131029863092;3810.8856734298015;3841.9039524011564;9630.711078667651;9942.502874856373;10043.246756493292;10133.391996480235;10145.34055286404;9691.903080969241;9955.004499550132;10002.049805268633;10022.899771002343;10023.548940297704;7488.850222995509;7522.435817313723;7598.0502437195355;7601.239876012354;7602.771916842504;5328.440513746156;5376.569874410116;5491.093969494988;5501.642393244426;5549.139883318092;9012.81974360496;9014.864777028219;9079.773005674911;9388;9452.480113593818;9157.771055723393;9290.349675522919;9363.812723745623;9380.437173769596;9526.52367381642;5770.336411312753;6070.18052562916;6146.631202127886;6184.474319682878;6266.717997690206;7740.961295193713;7748.457607967388;7754.495957762728;7798.220177982156;7798.532088074734;6667.133272674715;6860.416864566568;6867.107276054281;6918.446524278146;6942.028116063856;6566.146400967844;6643.069970204272;6701.430378417889;6750.561213521106;6819.965900170468;6543.16317591783;6552.3447655234095;6576.112224849584;6608.306127856506;6638.933610663831;4509.069105081723;4589.678722489393;4664.277037059262;4679.064187162649;4701.106789710081;4697.248440249544;4751.622029611374;4857.077155340474;4866.343043689057;4874.463808981081 18:00:46 INFO - PROCESS | 15862 | |4;prototype.html;296.6292134831461;299.1653287328353;301.38517424454113;302.9000429858146;305.63934557222495;5062.468440813707;5063.468335824736;5064.012517559077;5078.542931136201;5122.436531981479;4993.400791904976;5003.749812509378;5005.499450054993;5005.799768009275;5042.949570504303;3737.345964456223;3886.8533782534078;3942.8817135485983;3957.821898014582;3979.621935916083;3922.293987082324;3969.7816620085882;3971.7815520146382;3989.7406668566596;3990.1620659661507;3923.4507168996365;3929.1552316252;3930.331843586597;3954.1498577805764;3976.6421022108007;3842.7886466244345;3969.0672691917375;3984.880453586397;3990.221906728189;4035.959640403588;3523.2953409317984;3533.9116522086897;3551.8224088795714;3554.3779838528153;3562.5418461261906;4953.504649535053;4959.578435832958;4967.509747075899;4971.179755340365;4980.726060066695;4366.737995720267;4540.477845047829;4542.251233275179;4570.177368073745;4595.310703394484;5249.291345668362;5277.683338999673;5280.1815718563685;5292.073887069748;5319.281896943901;3846.4229665836874;3852.7671145233535;3859.807009649506;3868.3617203161443;3874.4382064600477;5441.646292990982;5521.282233309684;5534.640248383883;5564.916526252109;5603.887922241533;3909.863154789569;3930.9017274568364;3939.054626889526;3943.72393932422;3945.2898478273614;3983.5618082010956;3989.7007724420782;4007.599240075969;4008.098177909947;4009.8797036088963;4493.7977790999485;4528.43394575678;4537.502624134027;4547.204239258117;4556.544345565483;5131.384233891957;5232.476752324813;5243.528082472596;5249.42256351801;5301.913107812889;1371.149887070023;1372.1012736657306;1383.121717709262;1391.1861560986733;1398.6643205630576;856.4647095565272;866.5320726807579;876.4565969099071;891.6789955615973;901.6483571407157;4437.511873693891;4579.152856721517;4598.425196850394;4620.297126181222;4621.69958952667;5439.864003399946;5456.326400064019;5471.835844924659;5473.808416705476;5487.917681234785;4468.307412351026;4669.299605059268;4675.579197872208;4702.27114797207;4716.551927566876;2885.1488810800865;2905.2446363945105;2915.3877685686243;2937.2069541224178;2973.717496837797;5091.159958606862;5091.236314552847;5108.846734597968;5174.43081261061;5193.221016847503;5432.212329212242;5546.91679624806;5560.277163968658;5586.720663966786;5593.412691667398;5044.243363495505;5072.010957863181;5077.492250774893;5091.974540127276;5104.515071068243;5379.408265090915;5395.730213489388;5402.432744561765;5427.6200665953;5437.782488700408;5056.721880296619;5271.65734227274;5328.25404443386;5335.706536140549;5344.625876188629;5034.370703662043;5076.314697515936;5095.515925987025;5096.311997880239;5112.616553758408;3928.1947200824334;3935.8228879701055;3946.1910308386136;3954.9209015820097;3955.9011024724614;5250.353437208022;5435;5444.564434845282;5452.236686863763;5494.681276493693;5229.614152249581;5238.004779091961;5265.52610265078;5292.7032876945395;5314.441983591822;5232.7645255964335;5257.187404738446;5273.947260527346;5278.2346559749385;5322.680639161508;4883.877903052452;5116.079105760999;5122.692638441706;5139.486051394831;5148.742562871917;5011.699298042129;5177;5303.178007408857;5345.904089661688;5353.437889021597;5216.174338981326;5225;5225.764840582106;5226.294450249167;5240.266362709148 18:00:46 INFO - PROCESS | 15862 | |5;yui.html;614.5329549542347;660.7984564707764;689.3175756001558;698.2912343970868;699.9720011199553;12202.169674548823;12406.751864962695;12443.502259909605;12462.439190236439;12463.065270104757;13326.400311985959;14170.71658566828;14197.787033194485;14206.644833879158;14272.714545709105;631.2929518938772;792.7066985215479;801.9799505012363;803.3813963248296;803.6785285885663;784.1922819495928;789.2778108031144;789.8578255913933;811.4887620798888;811.6185392865344;831.71721614651;834.7787836223406;837.7570504553672;840.861257892447;842.3598065470226;821.1665159862744;821.8561751693429;823.8475881961856;828.9253967142956;831.7380025292014;601.6480358989996;604.7460066771966;606.3693758491164;606.7118118893491;608.5709574749791;13179.60461186166;13219.867801322056;13256.270905100215;13329.533466328729;13374.13068150567;12646.49414023438;12871.356432178354;12895.419706113247;12909.354532273348;12980.935095324463;10428.94785526075;10577.153827693766;10748.838767418494;10870.673879783619;11119.16606254526;3303.653116422765;3310.1062713067336;3346.5816772903386;3384.7122994545493;3424.383610950028;63220.68389658068;63828;64054.359456405306;64759;64980.675096624684;9808.950955245178;9837.311388202757;10055.798884022279;10123.595056197817;10126.392416455037;18941.43175704731;19018.144183511777;19416.22335106608;19462.902685486482;19510.31713890007;6922.861542769117;6945.201301850251;6957.930420695729;7224.169220539705;7475.289847464483;3581.606023337431;3687.9078023049638;3688.981555092207;3738.420544815558;3758.962410375916;2971.539411391238;3054.2364408897774;3071.66211716711;3088.3977624363483;3089.891853785107;529.3515443581582;533.3599680383478;542.6499907559602;544.5697898660014;544.5915563327504;420.70550614569925;498.3670738162586;551.6497024389541;556.6354038105047;560.3411810957035;7294.70821167158;7389.408847292311;7544.585047822313;7574.734884279023;8060.15368386311;483.89596236809257;484.97090174589636;535.9785608575692;544.5453046706045;577.6101131736145;3696.5194524711615;3725.3294407006456;3774.7735135891935;3790.0831280330417;3842.0971071798103;87671;90317.54841225751;90790.54604727066;91026;93972;70035.29964700287;77854;78732;79509.20490795017;79570.68800895919;45123.774381127885;49881.75059124681;70565;72506.274937251;73169;7079.68141433647;7139.143302803697;7219.566825990458;7283.7814865552;7348.338649521569;43245.3513197296;43960;44168.55831441773;45455.54544454646;45819.770901146614;36113.27773444569;37180.62819371772;37307.626923730415;42432.5756742441;61675.691621541606;9282.582283797381;9327.347085703936;9497.335186536877;9521.381110227812;9812.822461304404;11416;11590.42047897585;11780.116491263017;11840.230385024946;12304.569340073054;11523.884761152616;11944.522219111139;12089.637310880687;12277.26336419782;12382.380880956096;11325.660230193107;11594.188406811441;11679.591214307458;11689.181757276909;11958;11244.55021799119;11252.156088293574;11311.943440282746;11635.709107272047;11672.591459298883;8869.423487473294;8878.399976101335;9144.679936202201;9192.264618830344;9514.762130946781;9815.85276220843;10008.299419040888;10113.646022389476;10255.7436064099;10256.487175641338 18:00:46 INFO - PROCESS | 15862 | __end_tp_report 18:00:46 INFO - PROCESS | 15862 | __start_cc_report 18:00:46 INFO - PROCESS | 15862 | _x_x_mozilla_cycle_collect,407 18:00:46 INFO - PROCESS | 15862 | __end_cc_report 18:00:46 INFO - PROCESS | 15862 | __startTimestamp1465866046029__endTimestamp 18:00:46 INFO - PROCESS | 15862 | 18:00:46 INFO - PROCESS | 15862 | ------- Summary: start ------- 18:00:46 INFO - PROCESS | 15862 | Number of tests: 6 18:00:46 INFO - PROCESS | 15862 | 18:00:46 INFO - PROCESS | 15862 | [#0] dojo.html Cycles:165 Average:4785.30 Median:4904.07 stddev:497.69 (10.1%) stddev-sans-first:468.94 18:00:46 INFO - PROCESS | 15862 | Values: 2606.2 2680.5 2692.7 2693.8 2697.8 4752.9 4755.7 4801.8 4846.0 4904.1 4685.4 4830.3 4843.5 4866.0 4880.1 4443.1 4462.4 4588.7 4588.8 4612.2 4262.2 4551.5 4554.0 4630.5 4648.9 4324.7 4425.2 4445.7 4451.0 4470.9 4414.3 4421.8 4495.3 4511.9 4520.5 4467.8 4488.6 4492.8 4501.3 4552.4 4750.9 4838.8 4849.0 4859.6 4876.6 5159.5 5171.1 5178.9 5189.9 5253.3 5152.4 5162.9 5213.3 5223.6 5225.3 4894.2 4896.7 4897.5 4908.1 4937.6 5343.3 5350.9 5352.8 5353.0 5369.0 4920.0 4967.4 4983.5 4984.1 5124.3 4965.7 5085.8 5093.8 5096.5 5106.8 5090.9 5139.5 5207.0 5207.1 5209.3 5001.3 5082.1 5135.9 5195.0 5204.9 4359.5 4371.0 4371.6 4402.3 4411.4 3837.2 3868.9 3887.6 3895.8 3939.5 4368.6 4507.0 4507.5 4556.1 4565.4 5252.9 5284.8 5287.0 5287.5 5295.6 4550.0 4555.6 4560.8 4582.2 4588.7 4460.4 4578.2 4610.2 4625.3 4651.3 4891.6 4893.3 4918.4 4939.5 4960.0 5022.5 5263.8 5272.3 5280.3 5326.5 4709.9 4712.0 4716.0 4749.0 4765.1 4949.2 4951.9 4952.0 4961.7 5019.2 5011.0 5036.1 5039.6 5081.7 5189.6 4872.6 4966.6 5045.4 5081.2 5176.6 5045.6 5048.1 5048.5 5056.1 5089.5 4813.4 4902.2 4911.9 4914.3 4922.3 5073.9 5115.8 5156.3 5163.3 5182.1 4998.9 5051.9 5060.4 5064.9 5107.9 18:00:46 INFO - PROCESS | 15862 | 18:00:46 INFO - PROCESS | 15862 | [#1] ext.html Cycles:180 Average:47204.82 Median:21382.05 stddev:87204.17 (407.8%) stddev-sans-first:87378.44 18:00:46 INFO - PROCESS | 15862 | Values: 546.8 580.4 591.2 592.4 596.4 39284.8 40678.4 40704.8 40834.4 44147.6 40908.2 41265.6 41326.4 41399.6 41453.6 7941.5 8030.3 8036.8 8040.9 8045.6 7940.8 7977.0 8019.7 8037.4 8059.4 7969.0 8005.3 8006.7 8007.8 8078.4 7958.0 8021.6 8026.6 8039.9 8042.5 7863.7 7980.6 7984.1 7985.8 8004.6 39231.2 39493.8 39574.4 39610.6 39713.4 3041.3 3447.8 3576.6 3825.1 3913.9 29958.1 30112.8 30138.5 30421.2 31334.8 3558.7 3564.2 3584.3 3656.3 3667.0 247550.0 248499.0 248902.0 250140.0 251848.0 31861.7 32552.2 32597.8 44773.8 45031.3 33815.3 33841.2 33902.7 34042.3 34205.7 12781.8 12901.9 12910.5 12929.6 12959.4 10522.1 10542.5 10579.2 10611.1 10614.4 7853.1 7874.9 7884.9 7939.3 7956.1 3059.5 3163.4 3165.0 3180.5 3183.4 819.2 847.8 875.1 888.6 893.7 27642.6 27716.7 28368.4 28672.1 28718.6 963.2 975.6 976.1 997.3 1024.9 14856.9 15023.1 15123.1 15372.4 15436.0 391387.0 398296.0 400425.0 404224.0 404481.0 48682.5 48857.0 49270.3 49422.8 49577.5 1196.4 1202.6 1224.3 1225.1 1229.0 24771.5 25511.6 25536.2 25628.2 26105.7 43030.8 43105.0 43368.0 43440.6 43524.3 324056.0 324128.0 325541.0 326346.0 326559.0 25432.9 25469.0 25790.5 25819.9 26230.5 42625.4 42788.0 42936.8 43289.8 43413.1 36635.8 37104.0 37221.3 37389.3 38046.6 36290.0 36453.5 36626.3 38449.2 39382.4 35682.8 38568.6 38850.2 39241.8 40391.0 38793.4 39554.8 40232.2 40774.0 40782.6 31071.0 31550.0 33061.2 33221.7 33540.5 18:00:46 INFO - PROCESS | 15862 | 18:00:46 INFO - PROCESS | 15862 | [#2] jquery.html Cycles:180 Average:24032.94 Median:28750.98 stddev:68135.08 (237.0%) stddev-sans-first:68303.02 18:00:46 INFO - PROCESS | 15862 | Values: 353.7 359.8 362.7 374.4 378.3 15765.8 16726.2 17370.7 17383.8 17411.1 16149.7 16528.4 17194.5 17230.3 17252.8 5024.8 5240.6 5263.2 5277.8 5279.9 3755.1 5210.8 5784.8 6044.3 6117.9 6096.6 6108.7 6111.6 6122.1 6154.3 5473.6 5834.2 5838.2 5844.2 5907.9 5158.8 5212.5 5242.1 5249.7 5281.8 11635.5 11746.7 11817.4 18480.2 19640.3 1872.3 1937.5 2165.2 2312.6 2398.1 8880.6 9008.1 9058.8 9160.6 9171.1 1697.7 1736.6 1739.7 1753.4 1764.7 66700.0 67517.7 68460.0 68712.3 68896.0 9863.0 10140.4 10201.5 10635.5 10833.8 13960.0 13964.3 14059.5 14068.6 14119.6 6844.5 6857.1 7007.9 7010.6 7229.9 6352.3 6412.7 6473.8 6484.6 6508.3 4347.2 4403.9 4448.8 4457.0 4493.2 1669.6 1799.3 3139.4 3258.2 3266.0 749.4 819.0 847.4 914.8 972.5 16423.7 16650.9 16661.9 17329.4 17642.3 821.2 864.9 890.0 905.5 923.1 6641.9 9372.5 9572.7 9770.1 9798.9 400284.0 404083.0 418965.0 422670.0 427936.0 52289.5 52347.7 66231.0 67742.0 79782.0 409.2 431.0 433.4 435.8 872.4 9216.6 9696.0 9713.6 9935.8 9948.4 25542.6 26927.5 33356.7 35834.8 36557.6 45771.1 47188.3 51271.5 51518.5 51778.7 7321.2 7515.7 7609.9 7614.9 7731.6 9313.3 10611.9 11016.9 11211.7 11433.4 9642.0 10003.4 10003.6 10039.2 10297.5 9867.5 9872.7 10065.7 10100.7 10137.2 9180.0 9585.1 9746.9 9884.1 10221.3 7170.5 7217.6 7464.7 7480.6 7493.7 9530.4 9883.3 9887.9 9937.6 10043.5 18:00:46 INFO - PROCESS | 15862 | 18:00:46 INFO - PROCESS | 15862 | [#3] mootools.html Cycles:180 Average:5221.15 Median:4768.60 stddev:2949.42 (61.9%) stddev-sans-first:2943.48 18:00:46 INFO - PROCESS | 15862 | Values: 1368.4 1395.7 1461.8 1647.7 1652.7 7082.0 7698.8 7770.9 8277.1 8301.3 7906.8 8024.6 8109.1 8135.9 8163.7 2199.7 2225.6 2227.2 2244.8 2246.8 2179.1 2216.9 2236.1 2242.8 2255.9 2260.3 2269.0 2269.7 2270.3 2282.4 2152.3 2159.2 2178.2 2184.7 2196.9 2182.6 2182.7 2183.9 2184.7 2205.9 8103.2 8142.3 8157.3 8179.8 8246.9 4648.7 4785.6 4804.7 4811.7 4831.3 2865.7 3051.9 3113.3 3126.9 3131.9 906.4 946.4 949.5 1715.6 1763.9 10770.1 10830.1 10863.6 10903.9 10906.5 4091.8 4092.9 4191.7 4204.0 4260.5 8417.7 8451.4 8469.7 8478.2 8481.4 4619.0 4638.7 4650.0 4654.0 4675.2 3809.7 4178.2 4256.4 4293.0 4344.1 3412.5 3447.0 3537.7 3545.1 3555.5 1029.8 1052.0 1058.6 1068.0 1070.2 632.8 788.8 791.2 792.9 801.8 5390.7 5398.8 5518.5 5567.7 5652.8 411.8 427.2 438.2 440.5 440.7 3651.4 3763.2 3778.1 3810.9 3841.9 9630.7 9942.5 10043.2 10133.4 10145.3 9691.9 9955.0 10002.0 10022.9 10023.5 7488.9 7522.4 7598.1 7601.2 7602.8 5328.4 5376.6 5491.1 5501.6 5549.1 9012.8 9014.9 9079.8 9388.0 9452.5 9157.8 9290.3 9363.8 9380.4 9526.5 5770.3 6070.2 6146.6 6184.5 6266.7 7741.0 7748.5 7754.5 7798.2 7798.5 6667.1 6860.4 6867.1 6918.4 6942.0 6566.1 6643.1 6701.4 6750.6 6820.0 6543.2 6552.3 6576.1 6608.3 6638.9 4509.1 4589.7 4664.3 4679.1 4701.1 4697.2 4751.6 4857.1 4866.3 4874.5 18:00:46 INFO - PROCESS | 15862 | 18:00:46 INFO - PROCESS | 15862 | [#4] prototype.html Cycles:180 Average:4400.17 Median:5023.04 stddev:1263.23 (25.1%) stddev-sans-first:1228.65 18:00:46 INFO - PROCESS | 15862 | Values: 296.6 299.2 301.4 302.9 305.6 5062.5 5063.5 5064.0 5078.5 5122.4 4993.4 5003.7 5005.5 5005.8 5042.9 3737.3 3886.9 3942.9 3957.8 3979.6 3922.3 3969.8 3971.8 3989.7 3990.2 3923.5 3929.2 3930.3 3954.1 3976.6 3842.8 3969.1 3984.9 3990.2 4036.0 3523.3 3533.9 3551.8 3554.4 3562.5 4953.5 4959.6 4967.5 4971.2 4980.7 4366.7 4540.5 4542.3 4570.2 4595.3 5249.3 5277.7 5280.2 5292.1 5319.3 3846.4 3852.8 3859.8 3868.4 3874.4 5441.6 5521.3 5534.6 5564.9 5603.9 3909.9 3930.9 3939.1 3943.7 3945.3 3983.6 3989.7 4007.6 4008.1 4009.9 4493.8 4528.4 4537.5 4547.2 4556.5 5131.4 5232.5 5243.5 5249.4 5301.9 1371.1 1372.1 1383.1 1391.2 1398.7 856.5 866.5 876.5 891.7 901.6 4437.5 4579.2 4598.4 4620.3 4621.7 5439.9 5456.3 5471.8 5473.8 5487.9 4468.3 4669.3 4675.6 4702.3 4716.6 2885.1 2905.2 2915.4 2937.2 2973.7 5091.2 5091.2 5108.8 5174.4 5193.2 5432.2 5546.9 5560.3 5586.7 5593.4 5044.2 5072.0 5077.5 5092.0 5104.5 5379.4 5395.7 5402.4 5427.6 5437.8 5056.7 5271.7 5328.3 5335.7 5344.6 5034.4 5076.3 5095.5 5096.3 5112.6 3928.2 3935.8 3946.2 3954.9 3955.9 5250.4 5435.0 5444.6 5452.2 5494.7 5229.6 5238.0 5265.5 5292.7 5314.4 5232.8 5257.2 5273.9 5278.2 5322.7 4883.9 5116.1 5122.7 5139.5 5148.7 5011.7 5177.0 5303.2 5345.9 5353.4 5216.2 5225.0 5225.8 5226.3 5240.3 18:00:46 INFO - PROCESS | 15862 | 18:00:46 INFO - PROCESS | 15862 | [#5] yui.html Cycles:180 Average:16438.97 Median:25190.06 stddev:22948.96 (91.1%) stddev-sans-first:22982.58 18:00:46 INFO - PROCESS | 15862 | Values: 614.5 660.8 689.3 698.3 700.0 12202.2 12406.8 12443.5 12462.4 12463.1 13326.4 14170.7 14197.8 14206.6 14272.7 631.3 792.7 802.0 803.4 803.7 784.2 789.3 789.9 811.5 811.6 831.7 834.8 837.8 840.9 842.4 821.2 821.9 823.8 828.9 831.7 601.6 604.7 606.4 606.7 608.6 13179.6 13219.9 13256.3 13329.5 13374.1 12646.5 12871.4 12895.4 12909.4 12980.9 10428.9 10577.2 10748.8 10870.7 11119.2 3303.7 3310.1 3346.6 3384.7 3424.4 63220.7 63828.0 64054.4 64759.0 64980.7 9809.0 9837.3 10055.8 10123.6 10126.4 18941.4 19018.1 19416.2 19462.9 19510.3 6922.9 6945.2 6957.9 7224.2 7475.3 3581.6 3687.9 3689.0 3738.4 3759.0 2971.5 3054.2 3071.7 3088.4 3089.9 529.4 533.4 542.6 544.6 544.6 420.7 498.4 551.6 556.6 560.3 7294.7 7389.4 7544.6 7574.7 8060.2 483.9 485.0 536.0 544.5 577.6 3696.5 3725.3 3774.8 3790.1 3842.1 87671.0 90317.5 90790.5 91026.0 93972.0 70035.3 77854.0 78732.0 79509.2 79570.7 45123.8 49881.8 70565.0 72506.3 73169.0 7079.7 7139.1 7219.6 7283.8 7348.3 43245.4 43960.0 44168.6 45455.5 45819.8 36113.3 37180.6 37307.6 42432.6 61675.7 9282.6 9327.3 9497.3 9521.4 9812.8 11416.0 11590.4 11780.1 11840.2 12304.6 11523.9 11944.5 12089.6 12277.3 12382.4 11325.7 11594.2 11679.6 11689.2 11958.0 11244.6 11252.2 11311.9 11635.7 11672.6 8869.4 8878.4 9144.7 9192.3 9514.8 9815.9 10008.3 10113.6 10255.7 10256.5 18:00:46 INFO - PROCESS | 15862 | -------- Summary: end -------- 18:00:46 INFO - PROCESS | 15862 | 18:00:46 INFO - TEST-INFO | 15862: exit 0 18:00:46 INFO - TEST-OK | dromaeo_css | took 1116635ms 18:00:46 INFO - TEST-START | kraken 18:00:46 INFO - operating with platform_type : linux_ 18:00:46 INFO - Initialising browser for kraken test... 18:00:46 INFO - TEST-INFO | started process 16096 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1KRIJH/profile http://localhost:45034/getInfo.html) 18:00:51 INFO - PROCESS | 16096 | __metrics Screen width/height:1600/1200 18:00:51 INFO - PROCESS | 16096 | colorDepth:24 18:00:51 INFO - PROCESS | 16096 | Browser inner width/height: 1024/697 18:00:51 INFO - PROCESS | 16096 | __metrics 18:00:52 ERROR - PROCESS | 16096 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 18:00:53 INFO - TEST-INFO | 16096: exit 0 18:00:53 INFO - Browser initialized. 18:00:53 INFO - Running cycle 1/1 for kraken test... 18:00:53 INFO - TEST-INFO | started process 16214 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1KRIJH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:01:05 INFO - PROCESS | 16214 | RSS: Main: 186351616 18:01:05 INFO - PROCESS | 16214 | 18:01:08 INFO - PROCESS | 16214 | Cycle 1(1): loaded http://localhost:45034/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45034/tests/kraken/driver.html?testName=audio-beat-detection) 18:01:09 INFO - PROCESS | 16214 | RSS: Main: 191279104 18:01:09 INFO - PROCESS | 16214 | 18:01:12 INFO - PROCESS | 16214 | Cycle 1(1): loaded http://localhost:45034/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45034/tests/kraken/driver.html?testName=audio-dft) 18:01:12 INFO - PROCESS | 16214 | RSS: Main: 190795776 18:01:12 INFO - PROCESS | 16214 | 18:01:15 INFO - PROCESS | 16214 | Cycle 1(1): loaded http://localhost:45034/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45034/tests/kraken/driver.html?testName=audio-fft) 18:01:16 INFO - PROCESS | 16214 | RSS: Main: 186146816 18:01:16 INFO - PROCESS | 16214 | 18:01:18 INFO - PROCESS | 16214 | Cycle 1(1): loaded http://localhost:45034/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45034/tests/kraken/driver.html?testName=audio-oscillator) 18:01:19 INFO - PROCESS | 16214 | RSS: Main: 187060224 18:01:19 INFO - PROCESS | 16214 | 18:01:21 INFO - PROCESS | 16214 | Cycle 1(1): loaded http://localhost:45034/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45034/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:01:21 INFO - PROCESS | 16214 | RSS: Main: 186961920 18:01:21 INFO - PROCESS | 16214 | 18:01:25 INFO - PROCESS | 16214 | Cycle 1(1): loaded http://localhost:45034/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45034/tests/kraken/driver.html?testName=imaging-darkroom) 18:01:25 INFO - PROCESS | 16214 | RSS: Main: 187592704 18:01:25 INFO - PROCESS | 16214 | 18:01:29 INFO - PROCESS | 16214 | Cycle 1(1): loaded http://localhost:45034/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45034/tests/kraken/driver.html?testName=imaging-desaturate) 18:01:29 INFO - PROCESS | 16214 | RSS: Main: 184061952 18:01:29 INFO - PROCESS | 16214 | 18:01:32 INFO - PROCESS | 16214 | Cycle 1(1): loaded http://localhost:45034/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45034/tests/kraken/driver.html?testName=json-parse-financial) 18:01:33 INFO - PROCESS | 16214 | RSS: Main: 186032128 18:01:33 INFO - PROCESS | 16214 | 18:01:35 INFO - PROCESS | 16214 | Cycle 1(1): loaded http://localhost:45034/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45034/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:01:35 INFO - PROCESS | 16214 | RSS: Main: 186294272 18:01:35 INFO - PROCESS | 16214 | 18:01:37 INFO - PROCESS | 16214 | Cycle 1(1): loaded http://localhost:45034/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45034/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:01:38 INFO - PROCESS | 16214 | RSS: Main: 186204160 18:01:38 INFO - PROCESS | 16214 | 18:01:40 INFO - PROCESS | 16214 | Cycle 1(1): loaded http://localhost:45034/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45034/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:01:41 INFO - PROCESS | 16214 | RSS: Main: 186634240 18:01:41 INFO - PROCESS | 16214 | 18:01:44 INFO - PROCESS | 16214 | Cycle 1(1): loaded http://localhost:45034/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45034/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:01:44 INFO - PROCESS | 16214 | RSS: Main: 186753024 18:01:44 INFO - PROCESS | 16214 | 18:01:47 INFO - PROCESS | 16214 | Cycle 1(1): loaded http://localhost:45034/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45034/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:01:48 INFO - PROCESS | 16214 | RSS: Main: 186605568 18:01:48 INFO - PROCESS | 16214 | 18:01:50 INFO - PROCESS | 16214 | Cycle 1(1): loaded http://localhost:45034/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45034/tests/kraken/driver.html?testName=ai-astar) 18:01:50 INFO - PROCESS | 16214 | RSS: Main: 187842560 18:01:50 INFO - PROCESS | 16214 | 18:01:50 INFO - PROCESS | 16214 | __start_tp_report 18:01:50 INFO - PROCESS | 16214 | _x_x_mozilla_page_load 18:01:50 INFO - PROCESS | 16214 | _x_x_mozilla_page_load_details 18:01:50 INFO - PROCESS | 16214 | |i|pagename|runs| 18:01:50 INFO - PROCESS | 16214 | |0;ai-astar;117;107;114;115;113;113;112;113;112;113 18:01:50 INFO - PROCESS | 16214 | |1;audio-beat-detection;154;137;160;182;135;152;155;134;199;133 18:01:50 INFO - PROCESS | 16214 | |2;audio-dft;163;170;176;164;162;163;163;164;161;162 18:01:50 INFO - PROCESS | 16214 | |3;audio-fft;76;76;76;163;77;77;77;78;168;77 18:01:50 INFO - PROCESS | 16214 | |4;audio-oscillator;88;87;139;86;86;86;133;87;87;144 18:01:50 INFO - PROCESS | 16214 | |5;imaging-gaussian-blur;117;118;118;117;118;117;118;119;117;118 18:01:50 INFO - PROCESS | 16214 | |6;imaging-darkroom;148;151;147;148;149;148;148;147;148;148 18:01:50 INFO - PROCESS | 16214 | |7;imaging-desaturate;95;96;96;96;96;96;95;96;96;96 18:01:50 INFO - PROCESS | 16214 | |8;json-parse-financial;65;69;69;65;66;66;66;65;64;65 18:01:50 INFO - PROCESS | 16214 | |9;json-stringify-tinderbox;65;65;65;66;66;64;66;64;64;64 18:01:50 INFO - PROCESS | 16214 | |10;stanford-crypto-aes;84;86;86;83;86;85;85;85;108;86 18:01:50 INFO - PROCESS | 16214 | |11;stanford-crypto-ccm;147;138;135;135;141;145;139;144;147;143 18:01:50 INFO - PROCESS | 16214 | |12;stanford-crypto-pbkdf2;169;170;168;168;176;170;167;168;167;166 18:01:50 INFO - PROCESS | 16214 | |13;stanford-crypto-sha256-iterative;69;71;68;67;69;67;78;68;67;66 18:01:50 INFO - PROCESS | 16214 | __end_tp_report 18:01:50 INFO - PROCESS | 16214 | __start_cc_report 18:01:50 INFO - PROCESS | 16214 | _x_x_mozilla_cycle_collect,977 18:01:50 INFO - PROCESS | 16214 | __end_cc_report 18:01:50 INFO - PROCESS | 16214 | __startTimestamp1465866110444__endTimestamp 18:01:50 INFO - PROCESS | 16214 | 18:01:50 INFO - PROCESS | 16214 | ------- Summary: start ------- 18:01:50 INFO - PROCESS | 16214 | Number of tests: 14 18:01:50 INFO - PROCESS | 16214 | 18:01:50 INFO - PROCESS | 16214 | [#0] ai-astar Cycles:10 Average:112.90 Median:113.00 stddev:2.56 (2.3%) stddev-sans-first:2.24 18:01:50 INFO - PROCESS | 16214 | Values: 117.0 107.0 114.0 115.0 113.0 113.0 112.0 113.0 112.0 113.0 18:01:50 INFO - PROCESS | 16214 | 18:01:50 INFO - PROCESS | 16214 | [#1] audio-beat-detection Cycles:10 Average:154.10 Median:154.50 stddev:21.96 (14.2%) stddev-sans-first:23.29 18:01:50 INFO - PROCESS | 16214 | Values: 154.0 137.0 160.0 182.0 135.0 152.0 155.0 134.0 199.0 133.0 18:01:50 INFO - PROCESS | 16214 | 18:01:50 INFO - PROCESS | 16214 | [#2] audio-dft Cycles:10 Average:164.80 Median:163.50 stddev:4.64 (2.8%) stddev-sans-first:4.87 18:01:50 INFO - PROCESS | 16214 | Values: 163.0 170.0 176.0 164.0 162.0 163.0 163.0 164.0 161.0 162.0 18:01:50 INFO - PROCESS | 16214 | 18:01:50 INFO - PROCESS | 16214 | [#3] audio-fft Cycles:10 Average:94.50 Median:77.00 stddev:37.44 (48.6%) stddev-sans-first:39.11 18:01:50 INFO - PROCESS | 16214 | Values: 76.0 76.0 76.0 163.0 77.0 77.0 77.0 78.0 168.0 77.0 18:01:50 INFO - PROCESS | 16214 | 18:01:50 INFO - PROCESS | 16214 | [#4] audio-oscillator Cycles:10 Average:102.30 Median:86.50 stddev:25.24 (29.2%) stddev-sans-first:26.23 18:01:50 INFO - PROCESS | 16214 | Values: 88.0 87.0 139.0 86.0 86.0 86.0 133.0 87.0 87.0 144.0 18:01:50 INFO - PROCESS | 16214 | 18:01:50 INFO - PROCESS | 16214 | [#5] imaging-gaussian-blur Cycles:10 Average:117.70 Median:118.00 stddev:0.67 (0.6%) stddev-sans-first:0.67 18:01:50 INFO - PROCESS | 16214 | Values: 117.0 118.0 118.0 117.0 118.0 117.0 118.0 119.0 117.0 118.0 18:01:50 INFO - PROCESS | 16214 | 18:01:50 INFO - PROCESS | 16214 | [#6] imaging-darkroom Cycles:10 Average:148.20 Median:148.00 stddev:1.14 (0.8%) stddev-sans-first:1.20 18:01:50 INFO - PROCESS | 16214 | Values: 148.0 151.0 147.0 148.0 149.0 148.0 148.0 147.0 148.0 148.0 18:01:50 INFO - PROCESS | 16214 | 18:01:50 INFO - PROCESS | 16214 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 18:01:50 INFO - PROCESS | 16214 | Values: 95.0 96.0 96.0 96.0 96.0 96.0 95.0 96.0 96.0 96.0 18:01:50 INFO - PROCESS | 16214 | 18:01:50 INFO - PROCESS | 16214 | [#8] json-parse-financial Cycles:10 Average:66.00 Median:66.00 stddev:1.70 (2.6%) stddev-sans-first:1.76 18:01:50 INFO - PROCESS | 16214 | Values: 65.0 69.0 69.0 65.0 66.0 66.0 66.0 65.0 64.0 65.0 18:01:50 INFO - PROCESS | 16214 | 18:01:50 INFO - PROCESS | 16214 | [#9] json-stringify-tinderbox Cycles:10 Average:64.90 Median:65.00 stddev:0.88 (1.3%) stddev-sans-first:0.93 18:01:50 INFO - PROCESS | 16214 | Values: 65.0 65.0 65.0 66.0 66.0 64.0 66.0 64.0 64.0 64.0 18:01:50 INFO - PROCESS | 16214 | 18:01:50 INFO - PROCESS | 16214 | [#10] stanford-crypto-aes Cycles:10 Average:87.40 Median:85.50 stddev:7.31 (8.5%) stddev-sans-first:7.64 18:01:50 INFO - PROCESS | 16214 | Values: 84.0 86.0 86.0 83.0 86.0 85.0 85.0 85.0 108.0 86.0 18:01:50 INFO - PROCESS | 16214 | 18:01:50 INFO - PROCESS | 16214 | [#11] stanford-crypto-ccm Cycles:10 Average:141.40 Median:143.50 stddev:4.53 (3.2%) stddev-sans-first:4.32 18:01:50 INFO - PROCESS | 16214 | Values: 147.0 138.0 135.0 135.0 141.0 145.0 139.0 144.0 147.0 143.0 18:01:50 INFO - PROCESS | 16214 | 18:01:50 INFO - PROCESS | 16214 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.90 Median:168.50 stddev:2.81 (1.7%) stddev-sans-first:2.98 18:01:50 INFO - PROCESS | 16214 | Values: 169.0 170.0 168.0 168.0 176.0 170.0 167.0 168.0 167.0 166.0 18:01:50 INFO - PROCESS | 16214 | 18:01:50 INFO - PROCESS | 16214 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.00 Median:68.50 stddev:3.46 (5.1%) stddev-sans-first:3.67 18:01:50 INFO - PROCESS | 16214 | Values: 69.0 71.0 68.0 67.0 69.0 67.0 78.0 68.0 67.0 66.0 18:01:50 INFO - PROCESS | 16214 | -------- Summary: end -------- 18:01:50 INFO - PROCESS | 16214 | 18:01:51 INFO - TEST-INFO | 16214: exit 0 18:01:51 INFO - TEST-OK | kraken | took 64799ms 18:01:51 INFO - SUITE-END | took 1181s 18:01:52 INFO - Completed test suite (00:19:41) 18:01:52 INFO - javascript benchmark 18:01:52 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6357.560077195309, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2606.1920804550587, 2680.517506848767, 2692.6903406108304, 2693.757561819437, 2697.824641398309, 4752.857414277569, 4755.667103302771, 4801.783919723612, 4846.009767536601, 4904.068227036861, 4685.437747470309, 4830.323754674339, 4843.467218605951, 4866.0, 4880.145974454465, 4443.111377724452, 4462.397576327203, 4588.724676519403, 4588.816447342102, 4612.238980568202, 4262.1688770689725, 4551.45382554094, 4553.954460455386, 4630.467496237925, 4648.86053418398, 4324.740515569045, 4425.181341451842, 4445.73325600465, 4451.0, 4470.865874023768, 4414.3378493225955, 4421.823127074913, 4495.258282383403, 4511.932321015187, 4520.50274469808, 4467.843625473125, 4488.551144885518, 4492.84275050375, 4501.324801279801, 4552.385427967215, 4750.904981900343, 4838.782254798542, 4849.030193961222, 4859.635527335464, 4876.634252431047, 5159.484051594848, 5171.095058364771, 5178.948210517884, 5189.870253243661, 5253.290805741252, 5152.433232344439, 5162.92255616166, 5213.2701421800975, 5223.555997740196, 5225.294585230983, 4894.1679914414635, 4896.706197628154, 4897.4857639948, 4908.141075311806, 4937.604991600663, 5343.332083489564, 5350.8662283442445, 5352.812651557177, 5353.0, 5369.033573956725, 4919.975400122977, 4967.403911530567, 4983.476734942778, 4984.077945580079, 5124.256982737482, 4965.652404331662, 5085.796568137233, 5093.796248150033, 5096.464871188472, 5106.821261255913, 5090.9236361454605, 5139.486051394905, 5207.0366982108435, 5207.062728708869, 5209.270702101709, 5001.274815151855, 5082.085224659597, 5135.871603209875, 5194.97402512985, 5204.947950520522, 4359.455068116486, 4370.978145109254, 4371.628411584988, 4402.273624851928, 4411.360352748898, 3837.1750073733724, 3868.9226215475533, 3887.630675085862, 3895.824687889052, 3939.5272567291536, 4368.628666563314, 4506.985928166137, 4507.549245075532, 4556.134334476439, 4565.383673204141, 5252.947470525322, 5284.81503147388, 5286.97356513215, 5287.524122828964, 5295.576353891679, 4549.977250113729, 4555.567221113989, 4560.84037058708, 4582.198115329804, 4588.701734387254, 4460.375547423363, 4578.175928332866, 4610.239310513728, 4625.259958406638, 4651.279051746985, 4891.584215341736, 4893.290472881484, 4918.43438004634, 4939.481354457874, 4959.950400496094, 5022.4977502249485, 5263.842084737464, 5272.314599102092, 5280.260763493191, 5326.493983071602, 4709.929351059805, 4711.976440117777, 4715.976420117878, 4749.026449577759, 4765.142274390643, 4949.183384741621, 4951.851444456672, 4951.950480495149, 4961.652684312208, 5019.247112933089, 5011.047900898818, 5036.142192296296, 5039.571636410946, 5081.720505372092, 5189.584833213409, 4872.634552408655, 4966.553010229097, 5045.419776725724, 5081.212412076134, 5176.611754118381, 5045.646804723634, 5048.1165795984825, 5048.495150484922, 5056.089903817201, 5089.465606111453, 4813.422389313305, 4902.166631672696, 4911.877203069952, 4914.287428322945, 4922.286268491121, 5073.898522029465, 5115.79536818538, 5156.303898973591, 5163.27714120016, 5182.144946083854, 4998.875028124326, 5051.949480505148, 5060.3927528696795, 5064.924026139684, 5107.923381149211], "value": 4753.560263395647, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [546.8189673015735, 580.4021857486789, 591.1723586978233, 592.4223881715326, 596.3916804859044, 39284.803575982114, 40678.389824152626, 40704.796476017655, 40834.38748418769, 44147.558524414744, 40908.181836363256, 41265.58734412655, 41326.38010429838, 41399.58600413995, 41453.58546414535, 7941.483803552779, 8030.317423019051, 8036.758897233092, 8040.879386809173, 8045.6379462924015, 7940.76918077696, 7977.0, 8019.679212831509, 8037.437379383446, 8059.355251579859, 7969.043714754209, 8005.319547838411, 8006.6797328107095, 8007.759767206993, 8078.434509584332, 7957.960210198969, 8021.558814265213, 8026.5986700664735, 8039.919600803975, 8042.517448953023, 7863.68545258189, 7980.640871160754, 7984.121746607869, 7985.760427187193, 8004.63979120941, 39231.21537569233, 39493.80253098716, 39574.406383904265, 39610.60389396098, 39713.40429893554, 3041.260827195245, 3447.844846981892, 3576.588692300367, 3825.062859599416, 3913.882583522499, 29958.101256962327, 30112.84943575268, 30138.54792178119, 30421.23946901323, 31334.843325783455, 3558.6619271169197, 3564.198055437532, 3584.301061293049, 3656.3235801376563, 3667.0, 247550.0, 248499.0, 248902.0, 250139.99999999817, 251848.0, 31861.681383186336, 32552.186195345304, 32597.837010814794, 44773.776131119135, 45031.32453013207, 33815.32369352599, 33841.15397115042, 33902.66097339044, 34042.31915361679, 34205.657943420745, 12781.808272875915, 12901.935490322488, 12910.548130815376, 12929.612111636667, 12959.352032398343, 10522.053015228666, 10542.47287635615, 10579.153667706565, 10611.098056665116, 10614.416207108528, 7853.09689385728, 7874.881876771853, 7884.921150788418, 7939.325157361689, 7956.124826269222, 3059.541068839692, 3163.351512939842, 3165.0, 3180.475221588458, 3183.363327334542, 819.209462868323, 847.7880529867533, 875.0636818604032, 888.6134531478828, 893.6827426263712, 27642.585361219597, 27716.72283277182, 28368.432631347256, 28672.13983580496, 28718.569221461694, 963.210167662524, 975.5512464266375, 976.0581039297113, 997.2670087485692, 1024.9047875416202, 14856.851431485547, 15023.09861408319, 15123.092614443169, 15372.38510459569, 15436.0, 391387.0, 398296.03407931677, 400425.0, 404224.0, 404481.0, 48682.51317486851, 48857.0, 49270.26094608584, 49422.752886235336, 49577.50422495801, 1196.3958201108385, 1202.624791750645, 1224.3082658298033, 1225.1240363140398, 1228.950841966329, 24771.504569908862, 25511.617325739757, 25536.23391298264, 25628.231153065437, 26105.73894261033, 43030.78484607557, 43105.0, 43368.0, 43440.56559434365, 43524.34713479237, 324056.0, 324128.0, 325541.0, 326346.0, 326559.0, 25432.872835635702, 25469.0, 25790.484190316463, 25819.870900645376, 26230.4753904917, 42625.36061959135, 42788.0, 42936.78531607322, 43289.783551082044, 43413.13173736571, 36635.81682091679, 37104.0, 37221.25557488889, 37389.25221495609, 38046.61953380431, 36290.0, 36453.45319820152, 36626.26747465089, 38449.23101538009, 39382.40926386049, 35682.82158589191, 38568.61431385762, 38850.22299553936, 39241.80379098086, 40391.0, 38793.418098729104, 39554.802225988686, 40232.195356093296, 40774.0, 40782.59217407788, 31071.0, 31550.0, 33061.17347066342, 33221.66778332186, 33540.49689254712], "value": 16807.41903438554, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [353.6940546427341, 359.75716391435776, 362.7478902162997, 374.3710566248701, 378.2699390176959, 15765.763513547292, 16726.16369181542, 17370.652586948287, 17383.82616173836, 17411.129443527803, 16149.677006459864, 16528.42150524729, 17194.484165475023, 17230.310787568484, 17252.82747172528, 5024.824131155401, 5240.60695447841, 5263.184206448007, 5277.8416647500635, 5279.9208011879855, 3755.0800053986677, 5210.76551555181, 5784.768609255625, 6044.335123136451, 6117.938820611804, 6096.6037207581585, 6108.69456527174, 6111.602745821508, 6122.081687746829, 6154.261488621371, 5473.562115030788, 5834.212381328509, 5838.2118414013985, 5844.152597873327, 5907.911381329283, 5158.845234642967, 5212.478752124795, 5242.056429842627, 5249.685018898878, 5281.815136470205, 11635.534578616845, 11746.706332341675, 11817.35004574748, 18480.244376784183, 19640.312589059315, 1872.3446793622122, 1937.5253062999514, 2165.220520612578, 2312.606856834342, 2398.1486572266767, 8880.555972201364, 9008.144226298491, 9058.77353066172, 9160.587773550205, 9171.082891710843, 1697.6774412861516, 1736.5919009032866, 1739.652069586088, 1753.3600235913927, 1764.673535395943, 66700.0, 67517.66241168811, 68460.0, 68712.3128768716, 68896.0, 9863.0, 10140.391576505433, 10201.489925503694, 10635.46822658864, 10833.837492437462, 13960.0, 13964.301784910715, 14059.523750006101, 14068.648283792782, 14119.647008824657, 6844.5208835381045, 6857.074294970115, 7007.894881576781, 7010.579365238102, 7229.89155162673, 6352.333005034405, 6412.67936603168, 6473.77341793035, 6484.578502397329, 6508.284088750233, 4347.195768782785, 4403.889902752457, 4448.799804008828, 4456.955430445654, 4493.168763778712, 1669.6410271791624, 1799.3252530301138, 3139.372125574894, 3258.185453636591, 3265.951010734841, 749.3855038868185, 818.9508629482131, 847.4110493207285, 914.7713071732067, 972.4505654305436, 16423.6715265694, 16650.916745416194, 16661.91669041647, 17329.393471228446, 17642.294308227785, 821.1993306526209, 864.9394542382099, 889.9644014239358, 905.4567259644292, 923.1460898668839, 6641.86716265672, 9372.5313734313, 9572.712818615313, 9770.120689138012, 9798.922118566952, 400284.0, 404083.0, 418965.0, 422670.0, 427936.0, 52289.47710522846, 52347.73826130921, 66231.0, 67742.0, 79782.0, 409.19184610394234, 431.02803178831533, 433.38892162051354, 435.7821089455272, 872.3980453487073, 9216.585253663467, 9695.951520242354, 9713.56288966984, 9935.801283974424, 9948.35335703177, 25542.620656801355, 26927.461450771265, 33356.666433335355, 35834.8208258957, 36557.63442365542, 45771.08457830758, 47188.292175616705, 51271.48728512667, 51518.48481515287, 51778.74110629423, 7321.231270716711, 7515.661795219119, 7609.896564998155, 7614.885776713464, 7731.613419329124, 9313.25493960495, 10611.946940265248, 11016.889831101907, 11211.66365009051, 11433.371164586028, 9642.0, 10003.449810260505, 10003.649872254437, 10039.247056470647, 10297.485125743833, 9867.457289849128, 9872.703818885446, 10065.69802905914, 10100.747481313027, 10137.189024877845, 9179.954100229455, 9585.089416505421, 9746.9025309746, 9884.11043006133, 10221.33561318512, 7170.498065135391, 7217.566945983258, 7464.738734144496, 7480.588567628833, 7493.737719179802, 9530.380525266113, 9883.258755593502, 9887.901120988698, 9937.552810123418, 10043.548040338057], "value": 7884.106135800144, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1368.4321006782184, 1395.7417877692624, 1461.7807328900662, 1647.7281248593983, 1652.7025135475617, 7082.043924070249, 7698.807529811757, 7770.922290777091, 8277.130901255365, 8301.252887240147, 7906.841863162747, 8024.558649274288, 8109.107998120202, 8135.9016532768055, 8163.714270000552, 2199.7030400895915, 2225.5993921094196, 2227.2204728345114, 2244.7979681828633, 2246.7528571857083, 2179.08478439056, 2216.8780717060554, 2236.13908645172, 2242.798148166673, 2255.9436014099697, 2260.2993072147606, 2269.035659844568, 2269.716285464317, 2270.2621647964397, 2282.417983414227, 2152.2897443843494, 2159.1903036361286, 2178.2049551913437, 2184.6941428200066, 2196.8901554922268, 2182.639864422368, 2182.71624688791, 2183.9017244224046, 2184.6722991551237, 2205.933821985327, 8103.230193131702, 8142.307903828182, 8157.347412207068, 8179.836403271901, 8246.917530824676, 4648.651351148644, 4785.569298763093, 4804.6876952997945, 4811.735354555498, 4831.299461578086, 2865.6991015943236, 3051.893183738581, 3113.2839446927105, 3126.937461250762, 3131.906042818719, 906.419891269588, 946.3612061858287, 949.5299826585815, 1715.5968347438343, 1763.9206235719423, 10770.138388928945, 10830.079443247334, 10863.565457381774, 10903.945480272627, 10906.454677266185, 4091.8158682859344, 4092.9181416371507, 4191.7484950903045, 4204.0, 4260.467441569804, 8417.70538031166, 8451.36614753896, 8469.703560375357, 8478.194571515696, 8481.448705834102, 4618.97690511552, 4638.698484598491, 4650.023495066006, 4654.0, 4675.22858728306, 3809.7142714296538, 4178.185253875465, 4256.446661933929, 4293.012607100384, 4344.109457561192, 3412.4710669846213, 3447.0, 3537.699295559855, 3545.1137215696076, 3555.520004799319, 1029.8414283930579, 1051.9737006574744, 1058.571278632155, 1068.0387651113904, 1070.1813112968584, 632.7975047984601, 788.7673136424769, 791.2364568191723, 792.8533221354068, 801.7514570483169, 5390.703511306838, 5398.757055932492, 5518.503334699896, 5567.721613919288, 5652.773889044474, 411.7611785164597, 427.24591096714323, 438.2330920888445, 440.5154330236714, 440.65408654206936, 3651.3975194092677, 3763.2285381496727, 3778.131029863092, 3810.8856734298015, 3841.9039524011564, 9630.711078667651, 9942.502874856373, 10043.246756493292, 10133.391996480235, 10145.34055286404, 9691.903080969241, 9955.004499550132, 10002.049805268633, 10022.899771002343, 10023.548940297704, 7488.850222995509, 7522.435817313723, 7598.0502437195355, 7601.239876012354, 7602.771916842504, 5328.440513746156, 5376.569874410116, 5491.093969494988, 5501.642393244426, 5549.139883318092, 9012.81974360496, 9014.864777028219, 9079.773005674911, 9388.0, 9452.480113593818, 9157.771055723393, 9290.349675522919, 9363.812723745623, 9380.437173769596, 9526.52367381642, 5770.336411312753, 6070.18052562916, 6146.631202127886, 6184.474319682878, 6266.717997690206, 7740.961295193713, 7748.457607967388, 7754.495957762728, 7798.220177982156, 7798.532088074734, 6667.133272674715, 6860.416864566568, 6867.107276054281, 6918.446524278146, 6942.028116063856, 6566.146400967844, 6643.069970204272, 6701.430378417889, 6750.561213521106, 6819.965900170468, 6543.16317591783, 6552.3447655234095, 6576.112224849584, 6608.306127856506, 6638.933610663831, 4509.069105081723, 4589.678722489393, 4664.277037059262, 4679.064187162649, 4701.106789710081, 4697.248440249544, 4751.622029611374, 4857.077155340474, 4866.343043689057, 4874.463808981081], "value": 4137.987187922862, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [296.6292134831461, 299.1653287328353, 301.38517424454113, 302.9000429858146, 305.63934557222495, 5062.468440813707, 5063.468335824736, 5064.012517559077, 5078.542931136201, 5122.436531981479, 4993.400791904976, 5003.749812509378, 5005.499450054993, 5005.799768009275, 5042.949570504303, 3737.345964456223, 3886.8533782534078, 3942.8817135485983, 3957.821898014582, 3979.621935916083, 3922.293987082324, 3969.7816620085882, 3971.7815520146382, 3989.7406668566596, 3990.1620659661507, 3923.4507168996365, 3929.1552316252, 3930.331843586597, 3954.1498577805764, 3976.6421022108007, 3842.7886466244345, 3969.0672691917375, 3984.880453586397, 3990.221906728189, 4035.959640403588, 3523.2953409317984, 3533.9116522086897, 3551.8224088795714, 3554.3779838528153, 3562.5418461261906, 4953.504649535053, 4959.578435832958, 4967.509747075899, 4971.179755340365, 4980.726060066695, 4366.737995720267, 4540.477845047829, 4542.251233275179, 4570.177368073745, 4595.310703394484, 5249.291345668362, 5277.683338999673, 5280.1815718563685, 5292.073887069748, 5319.281896943901, 3846.4229665836874, 3852.7671145233535, 3859.807009649506, 3868.3617203161443, 3874.4382064600477, 5441.646292990982, 5521.282233309684, 5534.640248383883, 5564.916526252109, 5603.887922241533, 3909.863154789569, 3930.9017274568364, 3939.054626889526, 3943.72393932422, 3945.2898478273614, 3983.5618082010956, 3989.7007724420782, 4007.599240075969, 4008.098177909947, 4009.8797036088963, 4493.7977790999485, 4528.43394575678, 4537.502624134027, 4547.204239258117, 4556.544345565483, 5131.384233891957, 5232.476752324813, 5243.528082472596, 5249.42256351801, 5301.913107812889, 1371.149887070023, 1372.1012736657306, 1383.121717709262, 1391.1861560986733, 1398.6643205630576, 856.4647095565272, 866.5320726807579, 876.4565969099071, 891.6789955615973, 901.6483571407157, 4437.511873693891, 4579.152856721517, 4598.425196850394, 4620.297126181222, 4621.69958952667, 5439.864003399946, 5456.326400064019, 5471.835844924659, 5473.808416705476, 5487.917681234785, 4468.307412351026, 4669.299605059268, 4675.579197872208, 4702.27114797207, 4716.551927566876, 2885.1488810800865, 2905.2446363945105, 2915.3877685686243, 2937.2069541224178, 2973.717496837797, 5091.159958606862, 5091.236314552847, 5108.846734597968, 5174.43081261061, 5193.221016847503, 5432.212329212242, 5546.91679624806, 5560.277163968658, 5586.720663966786, 5593.412691667398, 5044.243363495505, 5072.010957863181, 5077.492250774893, 5091.974540127276, 5104.515071068243, 5379.408265090915, 5395.730213489388, 5402.432744561765, 5427.6200665953, 5437.782488700408, 5056.721880296619, 5271.65734227274, 5328.25404443386, 5335.706536140549, 5344.625876188629, 5034.370703662043, 5076.314697515936, 5095.515925987025, 5096.311997880239, 5112.616553758408, 3928.1947200824334, 3935.8228879701055, 3946.1910308386136, 3954.9209015820097, 3955.9011024724614, 5250.353437208022, 5435.0, 5444.564434845282, 5452.236686863763, 5494.681276493693, 5229.614152249581, 5238.004779091961, 5265.52610265078, 5292.7032876945395, 5314.441983591822, 5232.7645255964335, 5257.187404738446, 5273.947260527346, 5278.2346559749385, 5322.680639161508, 4883.877903052452, 5116.079105760999, 5122.692638441706, 5139.486051394831, 5148.742562871917, 5011.699298042129, 5177.0, 5303.178007408857, 5345.904089661688, 5353.437889021597, 5216.174338981326, 5225.0, 5225.764840582106, 5226.294450249167, 5240.266362709148], "value": 3993.270169477549, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [614.5329549542347, 660.7984564707764, 689.3175756001558, 698.2912343970868, 699.9720011199553, 12202.169674548823, 12406.751864962695, 12443.502259909605, 12462.439190236439, 12463.065270104757, 13326.400311985959, 14170.71658566828, 14197.787033194485, 14206.644833879158, 14272.714545709105, 631.2929518938772, 792.7066985215479, 801.9799505012363, 803.3813963248296, 803.6785285885663, 784.1922819495928, 789.2778108031144, 789.8578255913933, 811.4887620798888, 811.6185392865344, 831.71721614651, 834.7787836223406, 837.7570504553672, 840.861257892447, 842.3598065470226, 821.1665159862744, 821.8561751693429, 823.8475881961856, 828.9253967142956, 831.7380025292014, 601.6480358989996, 604.7460066771966, 606.3693758491164, 606.7118118893491, 608.5709574749791, 13179.60461186166, 13219.867801322056, 13256.270905100215, 13329.533466328729, 13374.13068150567, 12646.49414023438, 12871.356432178354, 12895.419706113247, 12909.354532273348, 12980.935095324463, 10428.94785526075, 10577.153827693766, 10748.838767418494, 10870.673879783619, 11119.16606254526, 3303.653116422765, 3310.1062713067336, 3346.5816772903386, 3384.7122994545493, 3424.383610950028, 63220.68389658068, 63828.0, 64054.359456405306, 64759.0, 64980.675096624684, 9808.950955245178, 9837.311388202757, 10055.798884022279, 10123.595056197817, 10126.392416455037, 18941.43175704731, 19018.144183511777, 19416.22335106608, 19462.902685486482, 19510.31713890007, 6922.861542769117, 6945.201301850251, 6957.930420695729, 7224.169220539705, 7475.289847464483, 3581.606023337431, 3687.9078023049638, 3688.981555092207, 3738.420544815558, 3758.962410375916, 2971.539411391238, 3054.2364408897774, 3071.66211716711, 3088.3977624363483, 3089.891853785107, 529.3515443581582, 533.3599680383478, 542.6499907559602, 544.5697898660014, 544.5915563327504, 420.70550614569925, 498.3670738162586, 551.6497024389541, 556.6354038105047, 560.3411810957035, 7294.70821167158, 7389.408847292311, 7544.585047822313, 7574.734884279023, 8060.15368386311, 483.89596236809257, 484.97090174589636, 535.9785608575692, 544.5453046706045, 577.6101131736145, 3696.5194524711615, 3725.3294407006456, 3774.7735135891935, 3790.0831280330417, 3842.0971071798103, 87671.0, 90317.54841225751, 90790.54604727066, 91026.0, 93972.0, 70035.29964700287, 77854.0, 78732.0, 79509.20490795017, 79570.68800895919, 45123.774381127885, 49881.75059124681, 70565.0, 72506.274937251, 73169.0, 7079.68141433647, 7139.143302803697, 7219.566825990458, 7283.7814865552, 7348.338649521569, 43245.3513197296, 43960.0, 44168.55831441773, 45455.54544454646, 45819.770901146614, 36113.27773444569, 37180.62819371772, 37307.626923730415, 42432.5756742441, 61675.691621541606, 9282.582283797381, 9327.347085703936, 9497.335186536877, 9521.381110227812, 9812.822461304404, 11416.0, 11590.42047897585, 11780.116491263017, 11840.230385024946, 12304.569340073054, 11523.884761152616, 11944.522219111139, 12089.637310880687, 12277.26336419782, 12382.380880956096, 11325.660230193107, 11594.188406811441, 11679.591214307458, 11689.181757276909, 11958.0, 11244.55021799119, 11252.156088293574, 11311.943440282746, 11635.709107272047, 11672.591459298883, 8869.423487473294, 8878.399976101335, 9144.679936202201, 9192.264618830344, 9514.762130946781, 9815.85276220843, 10008.299419040888, 10113.646022389476, 10255.7436064099, 10256.487175641338], "value": 6343.193030391771, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1587.9000000000003, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 107.0, 114.0, 115.0, 113.0, 113.0, 112.0, 113.0, 112.0, 113.0], "value": 112.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 137.0, 160.0, 182.0, 135.0, 152.0, 155.0, 134.0, 199.0, 133.0], "value": 154.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 170.0, 176.0, 164.0, 162.0, 163.0, 163.0, 164.0, 161.0, 162.0], "value": 164.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 76.0, 163.0, 77.0, 77.0, 77.0, 78.0, 168.0, 77.0], "value": 94.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 87.0, 139.0, 86.0, 86.0, 86.0, 133.0, 87.0, 87.0, 144.0], "value": 102.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 118.0, 117.0, 118.0, 117.0, 118.0, 119.0, 117.0, 118.0], "value": 117.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 151.0, 147.0, 148.0, 149.0, 148.0, 148.0, 147.0, 148.0, 148.0], "value": 148.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 96.0, 96.0, 96.0, 96.0, 95.0, 96.0, 96.0, 96.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 69.0, 69.0, 65.0, 66.0, 66.0, 66.0, 65.0, 64.0, 65.0], "value": 66.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 66.0, 66.0, 64.0, 66.0, 64.0, 64.0, 64.0], "value": 64.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 86.0, 86.0, 83.0, 86.0, 85.0, 85.0, 85.0, 108.0, 86.0], "value": 87.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 138.0, 135.0, 135.0, 141.0, 145.0, 139.0, 144.0, 147.0, 143.0], "value": 141.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 170.0, 168.0, 168.0, 176.0, 170.0, 167.0, 168.0, 167.0, 166.0], "value": 168.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 71.0, 68.0, 67.0, 69.0, 67.0, 78.0, 68.0, 67.0, 66.0], "value": 69.0, "unit": "score"}]}]} 18:01:52 INFO - Return code: 0 18:01:52 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:01:52 ERROR - # TBPL SUCCESS # 18:01:52 INFO - Running post-action listener: _resource_record_post_action 18:01:52 INFO - ##### 18:01:52 INFO - ##### Finished run-tests step (success) 18:01:52 INFO - ##### 18:01:52 INFO - Running post-run listener: _resource_record_post_run 18:01:52 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 4096; Write bytes: 543567872; Read time: 4; Write time: 530056 18:01:52 INFO - TinderboxPrint: CPU usage
13.4% 18:01:52 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 4 18:01:52 INFO - TinderboxPrint: I/O write bytes / time
543,567,872 / 530,056 18:01:52 INFO - TinderboxPrint: CPU idle
8,278.0 (86.5%) 18:01:52 INFO - TinderboxPrint: CPU user
1,231.8 (12.9%) 18:01:52 INFO - TinderboxPrint: Swap in / out
0 / 0 18:01:52 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 244838400; Read time: 0; Write time: 281384 18:01:52 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 4096; Write bytes: 298729472; Read time: 4; Write time: 248672 18:01:52 INFO - Running post-run listener: _upload_blobber_files 18:01:52 INFO - Blob upload gear active. 18:01:52 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:01:52 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 18:01:52 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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 18:01:52 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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 18:01:53 INFO - (blobuploader) - INFO - Open directory for files ... 18:01:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 18:01:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:01:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:01:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 18:01:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:01:54 INFO - (blobuploader) - INFO - Done attempting. 18:01:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:01:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:01:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:01:57 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:01:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:01:57 INFO - (blobuploader) - INFO - Done attempting. 18:01:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 18:01:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:01:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:01:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 18:01:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:01:58 INFO - (blobuploader) - INFO - Done attempting. 18:01:58 INFO - (blobuploader) - INFO - Iteration through files over. 18:01:58 INFO - Return code: 0 18:01:58 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:01:58 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:01:58 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/452830709eb0a6764f242f7e3ceb07643b5b3ffe51f0958d9c40271ae3348936d16aaab1c949a08eb5bae67227ecd2b16b2d3ede04421a7ac353fd7fd951d0a9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e06d10a33c7e5fc4203f2fdcc66ba7a26291a95a43b9fb52364cd8449b9042b1ec623d877ff7ad3a4227a400241ade10a5acc9b98976e1501cea062a439711b4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2c2ce367666e68a1579ed59815c4efa5717ca7591d90b6a0cccdef2ed82c58757de7ac9081bc746e4a71eb9a6217ea9092e958337316b5ac16fdd847701c8de0"} 18:01:58 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:01:58 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:01:58 INFO - Contents: 18:01:58 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/452830709eb0a6764f242f7e3ceb07643b5b3ffe51f0958d9c40271ae3348936d16aaab1c949a08eb5bae67227ecd2b16b2d3ede04421a7ac353fd7fd951d0a9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e06d10a33c7e5fc4203f2fdcc66ba7a26291a95a43b9fb52364cd8449b9042b1ec623d877ff7ad3a4227a400241ade10a5acc9b98976e1501cea062a439711b4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2c2ce367666e68a1579ed59815c4efa5717ca7591d90b6a0cccdef2ed82c58757de7ac9081bc746e4a71eb9a6217ea9092e958337316b5ac16fdd847701c8de0"} 18:01:58 INFO - Running post-run listener: copy_logs_to_upload_dir 18:01:58 INFO - Copying logs to upload dir... 18:01:58 INFO - mkdir: /builds/slave/test/build/upload/logs 18:01:58 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1251.676107 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2016-06-13 18:01:58.175896) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-13 18:01:58.179686) ========= 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=db0483c52d987ecb441a263b000001ad-1465859452.452570-1278319449 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-Non-PGO/sha512/452830709eb0a6764f242f7e3ceb07643b5b3ffe51f0958d9c40271ae3348936d16aaab1c949a08eb5bae67227ecd2b16b2d3ede04421a7ac353fd7fd951d0a9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e06d10a33c7e5fc4203f2fdcc66ba7a26291a95a43b9fb52364cd8449b9042b1ec623d877ff7ad3a4227a400241ade10a5acc9b98976e1501cea062a439711b4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2c2ce367666e68a1579ed59815c4efa5717ca7591d90b6a0cccdef2ed82c58757de7ac9081bc746e4a71eb9a6217ea9092e958337316b5ac16fdd847701c8de0"} build_url:https://queue.taskcluster.net/v1/task/KZq_MUjzSQ2g6TfSIOyq1w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011399 build_url: 'https://queue.taskcluster.net/v1/task/KZq_MUjzSQ2g6TfSIOyq1w/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-Non-PGO/sha512/452830709eb0a6764f242f7e3ceb07643b5b3ffe51f0958d9c40271ae3348936d16aaab1c949a08eb5bae67227ecd2b16b2d3ede04421a7ac353fd7fd951d0a9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e06d10a33c7e5fc4203f2fdcc66ba7a26291a95a43b9fb52364cd8449b9042b1ec623d877ff7ad3a4227a400241ade10a5acc9b98976e1501cea062a439711b4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2c2ce367666e68a1579ed59815c4efa5717ca7591d90b6a0cccdef2ed82c58757de7ac9081bc746e4a71eb9a6217ea9092e958337316b5ac16fdd847701c8de0"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-13 18:01:58.206794) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-13 18:01:58.207209) ========= 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=db0483c52d987ecb441a263b000001ad-1465859452.452570-1278319449 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004455 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-13 18:01:58.289799) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-13 18:01:58.290161) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-13 18:01:58.290553) ========= ========= Total master_lag: 0.25 =========