builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-048 starttime: 1466772024.74 results: success (0) buildid: 20160624023004 builduid: 4cde38562f2748f18a7049080cbb6ee8 revision: 9f27664669366144c1756f0b416277c16ac96ac2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-24 05:40:24.743268) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-24 05:40:24.744151) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-24 05:40:24.744791) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-24 05:40:24.762305) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 05:40:24.762836) ========= 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=fa44defc139c4ba8574fe040000001db-1466772025.399715-407914977 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-24 05:40:26-- 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% 89.6M=0s 2016-06-24 05:40:26 (89.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.153749 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 05:40:24.935556) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 05:40:24.936208) ========= 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=fa44defc139c4ba8574fe040000001db-1466772025.399715-407914977 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015256 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 05:40:24.990558) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 05:40:24.991240) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 9f27664669366144c1756f0b416277c16ac96ac2 --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 9f27664669366144c1756f0b416277c16ac96ac2 --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=fa44defc139c4ba8574fe040000001db-1466772025.399715-407914977 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-24 05:40:26,531 truncating revision to first 12 chars 2016-06-24 05:40:26,531 Setting DEBUG logging. 2016-06-24 05:40:26,531 attempt 1/10 2016-06-24 05:40:26,531 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/9f2766466936?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-24 05:40:26,877 unpacking tar archive at: fx-team-9f2766466936/testing/mozharness/ program finished with exit code 0 elapsedTime=0.818372 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 05:40:25.828664) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-24 05:40:25.829536) ========= script_repo_revision: 9f27664669366144c1756f0b416277c16ac96ac2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-24 05:40:25.830288) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-24 05:40:25.830595) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-24 05:40:25.841969) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-06-24 05:40:25.842497) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=fa44defc139c4ba8574fe040000001db-1466772025.399715-407914977 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:40:27 INFO - MultiFileLogger online at 20160624 05:40:27 in /builds/slave/test 05:40:27 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 05:40:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:40:27 INFO - {'append_to_log': False, 05:40:27 INFO - 'base_work_dir': '/builds/slave/test', 05:40:27 INFO - 'blob_upload_branch': 'Fx-Team', 05:40:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:40:27 INFO - 'branch': 'Fx-Team', 05:40:27 INFO - 'buildbot_json_path': 'buildprops.json', 05:40:27 INFO - 'config_files': ('talos/linux_config.py',), 05:40:27 INFO - 'default_actions': ('clobber', 05:40:27 INFO - 'read-buildbot-config', 05:40:27 INFO - 'download-and-extract', 05:40:27 INFO - 'populate-webroot', 05:40:27 INFO - 'create-virtualenv', 05:40:27 INFO - 'install', 05:40:27 INFO - 'run-tests'), 05:40:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:40:27 INFO - 'download_minidump_stackwalk': True, 05:40:27 INFO - 'download_symbols': 'ondemand', 05:40:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:40:27 INFO - 'tooltool.py': '/tools/tooltool.py', 05:40:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:40:27 INFO - '/tools/misc-python/virtualenv.py')}, 05:40:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:40:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:40:27 INFO - 'installer_path': 'installer.exe', 05:40:27 INFO - 'log_level': 'info', 05:40:27 INFO - 'log_name': 'talos', 05:40:27 INFO - 'log_to_console': True, 05:40:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:40:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:40:27 INFO - 'opt_config_files': (), 05:40:27 INFO - 'pip_index': False, 05:40:27 INFO - 'sps_profile': False, 05:40:27 INFO - 'sps_profile_interval': 0, 05:40:27 INFO - 'suite': 'dromaeojs-e10s', 05:40:27 INFO - 'system_bits': '32', 05:40:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:40:27 INFO - 'title': 'talos-linux64-ix-048', 05:40:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:40:27 INFO - 'use_talos_json': True, 05:40:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:40:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:40:27 INFO - 'work_dir': 'build'} 05:40:27 INFO - ##### 05:40:27 INFO - ##### Running clobber step. 05:40:27 INFO - ##### 05:40:27 INFO - Running pre-action listener: _resource_record_pre_action 05:40:27 INFO - Running main action method: clobber 05:40:27 INFO - rmtree: /builds/slave/test/build 05:40:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:40:28 INFO - Running post-action listener: _resource_record_post_action 05:40:28 INFO - ##### 05:40:28 INFO - ##### Finished clobber step (success) 05:40:28 INFO - ##### 05:40:28 INFO - ##### 05:40:28 INFO - ##### Running read-buildbot-config step. 05:40:28 INFO - ##### 05:40:28 INFO - Running pre-action listener: _resource_record_pre_action 05:40:28 INFO - Running main action method: read_buildbot_config 05:40:28 INFO - Using buildbot properties: 05:40:28 INFO - { 05:40:28 INFO - "project": "", 05:40:28 INFO - "product": "firefox", 05:40:28 INFO - "script_repo_revision": "production", 05:40:28 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 05:40:28 INFO - "repository": "", 05:40:28 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 05:40:28 INFO - "buildid": "20160624023004", 05:40:28 INFO - "pgo_build": "True", 05:40:28 INFO - "basedir": "/builds/slave/test", 05:40:28 INFO - "buildnumber": 862, 05:40:28 INFO - "slavename": "talos-linux64-ix-048", 05:40:28 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 05:40:28 INFO - "platform": "ubuntu64_hw", 05:40:28 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 05:40:28 INFO - "branch": "fx-team", 05:40:28 INFO - "repo_path": "integration/fx-team", 05:40:28 INFO - "revision": "9f27664669366144c1756f0b416277c16ac96ac2", 05:40:28 INFO - "stage_platform": "linux64-pgo", 05:40:28 INFO - "builduid": "4cde38562f2748f18a7049080cbb6ee8", 05:40:28 INFO - "slavebuilddir": "test" 05:40:28 INFO - } 05:40:28 INFO - Found installer url https://queue.taskcluster.net/v1/task/H5xSstgaRQ6-mUGxW0l7yQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 05:40:28 INFO - Running post-action listener: _resource_record_post_action 05:40:28 INFO - ##### 05:40:28 INFO - ##### Finished read-buildbot-config step (success) 05:40:28 INFO - ##### 05:40:28 INFO - ##### 05:40:28 INFO - ##### Running download-and-extract step. 05:40:28 INFO - ##### 05:40:28 INFO - Running pre-action listener: _resource_record_pre_action 05:40:28 INFO - Running main action method: download_and_extract 05:40:28 INFO - mkdir: /builds/slave/test/build/tests 05:40:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 05:40:28 INFO - https://queue.taskcluster.net/v1/task/H5xSstgaRQ6-mUGxW0l7yQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:40:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H5xSstgaRQ6-mUGxW0l7yQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:40:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H5xSstgaRQ6-mUGxW0l7yQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:40:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H5xSstgaRQ6-mUGxW0l7yQ/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 05:40:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H5xSstgaRQ6-mUGxW0l7yQ/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 05:40:29 INFO - Downloaded 1361 bytes. 05:40:29 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:40:29 INFO - Using the following test package requirements: 05:40:29 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 05:40:29 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:40:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:40:29 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:40:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:40:29 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:40:29 INFO - u'jsshell-linux-x86_64.zip'], 05:40:29 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:40:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:40:29 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 05:40:29 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:40:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:40:29 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:40:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:40:29 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:40:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:40:29 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:40:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:40:29 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:40:29 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')]} 05:40:29 INFO - https://queue.taskcluster.net/v1/task/H5xSstgaRQ6-mUGxW0l7yQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:40:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H5xSstgaRQ6-mUGxW0l7yQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:40:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H5xSstgaRQ6-mUGxW0l7yQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:40:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H5xSstgaRQ6-mUGxW0l7yQ/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 05:40:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H5xSstgaRQ6-mUGxW0l7yQ/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 05:40:30 INFO - Downloaded 24277318 bytes. 05:40:30 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'] 05:40:30 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 05:40:31 INFO - Return code: 0 05:40:31 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 05:40: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')]} 05:40:31 INFO - https://queue.taskcluster.net/v1/task/H5xSstgaRQ6-mUGxW0l7yQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:40:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H5xSstgaRQ6-mUGxW0l7yQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:40:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H5xSstgaRQ6-mUGxW0l7yQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:40:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H5xSstgaRQ6-mUGxW0l7yQ/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 05:40:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H5xSstgaRQ6-mUGxW0l7yQ/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 05:40:32 INFO - Downloaded 24277318 bytes. 05:40:32 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'] 05:40:32 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 05:40:34 INFO - Return code: 0 05:40: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')]} 05:40:34 INFO - https://queue.taskcluster.net/v1/task/H5xSstgaRQ6-mUGxW0l7yQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:40:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H5xSstgaRQ6-mUGxW0l7yQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:40:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H5xSstgaRQ6-mUGxW0l7yQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:40:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H5xSstgaRQ6-mUGxW0l7yQ/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 05:40:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H5xSstgaRQ6-mUGxW0l7yQ/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 05:40:35 INFO - Downloaded 14405518 bytes. 05:40:35 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'] 05:40:35 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 05:40:35 INFO - Return code: 0 05:40:35 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')]} 05:40:35 INFO - https://queue.taskcluster.net/v1/task/H5xSstgaRQ6-mUGxW0l7yQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:40:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H5xSstgaRQ6-mUGxW0l7yQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:40:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H5xSstgaRQ6-mUGxW0l7yQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:40:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H5xSstgaRQ6-mUGxW0l7yQ/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 05:40:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H5xSstgaRQ6-mUGxW0l7yQ/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 05:40:37 INFO - Downloaded 60165888 bytes. 05:40:37 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/H5xSstgaRQ6-mUGxW0l7yQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:40:37 INFO - mkdir: /builds/slave/test/properties 05:40:37 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:40:37 INFO - Writing to file /builds/slave/test/properties/build_url 05:40:37 INFO - Contents: 05:40:37 INFO - build_url:https://queue.taskcluster.net/v1/task/H5xSstgaRQ6-mUGxW0l7yQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:40:38 INFO - Running post-action listener: _resource_record_post_action 05:40:38 INFO - Running post-action listener: set_extra_try_arguments 05:40:38 INFO - ##### 05:40:38 INFO - ##### Finished download-and-extract step (success) 05:40:38 INFO - ##### 05:40:38 INFO - ##### 05:40:38 INFO - ##### Running populate-webroot step. 05:40:38 INFO - ##### 05:40:38 INFO - Running pre-action listener: _resource_record_pre_action 05:40:38 INFO - Running main action method: populate_webroot 05:40:38 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:40:38 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:40:38 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:40:38 INFO - '--tppagecycles', 05:40:38 INFO - '7'], 05:40:38 INFO - 'tests': ['tsvgm']}}, 05:40:38 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:40:38 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:40:38 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:40:38 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:40:38 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:40:38 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:40:38 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:40:38 INFO - 'talos_options': ['--disable-e10s'], 05:40:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:40:38 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:40:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:40:38 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:40:38 INFO - 'talos_options': ['--disable-e10s'], 05:40:38 INFO - 'tests': ['damp', 'tps']}, 05:40:38 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:40:38 INFO - 'tests': ['damp', 'tps']}, 05:40:38 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:40:38 INFO - 'tests': ['dromaeo_dom']}, 05:40:38 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:40:38 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:40:38 INFO - 'tests': ['basic_compositor_video']}, 05:40:38 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:40:38 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:40:38 INFO - 'tests': ['a11yr', 05:40:38 INFO - 'ts_paint', 05:40:38 INFO - 'tpaint', 05:40:38 INFO - 'sessionrestore', 05:40:38 INFO - 'sessionrestore_no_auto_restore', 05:40:38 INFO - 'tabpaint']}, 05:40:38 INFO - 'other-e10s': {'tests': ['a11yr', 05:40:38 INFO - 'ts_paint', 05:40:38 INFO - 'tpaint', 05:40:38 INFO - 'sessionrestore', 05:40:38 INFO - 'sessionrestore_no_auto_restore', 05:40:38 INFO - 'tabpaint']}, 05:40:38 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:40:38 INFO - 'ts_paint', 05:40:38 INFO - 'tpaint', 05:40:38 INFO - 'sessionrestore', 05:40:38 INFO - 'sessionrestore_no_auto_restore', 05:40:38 INFO - 'tabpaint']}, 05:40:38 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:40:38 INFO - 'ts_paint', 05:40:38 INFO - 'tpaint', 05:40:38 INFO - 'sessionrestore', 05:40:38 INFO - 'sessionrestore_no_auto_restore', 05:40:38 INFO - 'tabpaint']}, 05:40:38 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:40:38 INFO - 'tests': ['a11yr', 05:40:38 INFO - 'ts_paint', 05:40:38 INFO - 'tpaint', 05:40:38 INFO - 'sessionrestore', 05:40:38 INFO - 'sessionrestore_no_auto_restore', 05:40:38 INFO - 'tabpaint']}, 05:40:38 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:40:38 INFO - 'tests': ['a11yr', 05:40:38 INFO - 'ts_paint', 05:40:38 INFO - 'tpaint', 05:40:38 INFO - 'sessionrestore', 05:40:38 INFO - 'sessionrestore_no_auto_restore', 05:40:38 INFO - 'tabpaint']}, 05:40:38 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:40:38 INFO - 'tests': ['tsvgx', 05:40:38 INFO - 'tsvgr_opacity', 05:40:38 INFO - 'tart', 05:40:38 INFO - 'tscrollx', 05:40:38 INFO - 'cart']}, 05:40:38 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:40:38 INFO - 'tsvgr_opacity', 05:40:38 INFO - 'tart', 05:40:38 INFO - 'tscrollx', 05:40:38 INFO - 'cart']}, 05:40:38 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:40:38 INFO - 'talos_options': ['--disable-e10s'], 05:40:38 INFO - 'tests': ['tp5o']}, 05:40:38 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:40:38 INFO - 'tests': ['tp5o']}, 05:40:38 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:40:38 INFO - 'talos_options': ['--disable-e10s', 05:40:38 INFO - '--xperf_path', 05:40:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:40:38 INFO - 'tests': ['tp5n']}, 05:40:38 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:40:38 INFO - 'talos_options': ['--xperf_path', 05:40:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:40:38 INFO - 'tests': ['tp5n']}}, 05:40:38 INFO - 'talos.zip': {'path': '', 05:40:38 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:40:38 INFO - Running post-action listener: _resource_record_post_action 05:40:38 INFO - ##### 05:40:38 INFO - ##### Finished populate-webroot step (success) 05:40:38 INFO - ##### 05:40:38 INFO - ##### 05:40:38 INFO - ##### Running create-virtualenv step. 05:40:38 INFO - ##### 05:40:38 INFO - Running pre-action listener: _resource_record_pre_action 05:40:38 INFO - Running main action method: create_virtualenv 05:40:38 INFO - Creating virtualenv /builds/slave/test/build/venv 05:40:38 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 05:40:38 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:40:38 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:40:38 INFO - Using real prefix '/usr' 05:40:38 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:40:39 INFO - Installing distribute.............................................................................................................................................................................................done. 05:40:41 INFO - Installing pip.................done. 05:40:41 INFO - Return code: 0 05:40:41 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:40:41 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')]} 05:40:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:40:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:41 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')]} 05:40:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:40:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:41 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 0x7f0b1dad6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a458a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b10350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b9f1c0>, '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 0x2ba00c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ba0550>, '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': 'fa44defc139c4ba8574fe040000001db-1466772025.399715-407914977', '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 05:40:41 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 05:40:41 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 05:40:41 INFO - Using env: {'DISPLAY': ':0', 05:40:41 INFO - 'HOME': '/home/cltbld', 05:40:41 INFO - 'LANG': 'en_US.UTF-8', 05:40:41 INFO - 'LANGUAGE': 'en_US:en', 05:40:41 INFO - 'LOGNAME': 'cltbld', 05:40:41 INFO - 'MAIL': '/var/mail/cltbld', 05:40:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:40:41 INFO - 'MOZ_NO_REMOTE': '1', 05:40:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:40:41 INFO - 'NO_EM_RESTART': '1', 05:40:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:40:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:40:41 INFO - 'PWD': '/builds/slave/test', 05:40:41 INFO - 'SHELL': '/bin/bash', 05:40:41 INFO - 'SHLVL': '1', 05:40:41 INFO - 'TERM': 'linux', 05:40:41 INFO - 'TMOUT': '86400', 05:40:41 INFO - 'USER': 'cltbld', 05:40:41 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1466772025.399715-407914977', 05:40:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:40:41 INFO - '_': '/tools/buildbot/bin/python'} 05:40:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:40:41 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 05:40:41 INFO - Cleaning up... 05:40:41 INFO - Return code: 0 05:40:41 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:40:41 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')]} 05:40:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:40:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:41 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')]} 05:40:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:40:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:41 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 0x7f0b1dad6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a458a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b10350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b9f1c0>, '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 0x2ba00c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ba0550>, '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': 'fa44defc139c4ba8574fe040000001db-1466772025.399715-407914977', '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 05:40:41 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 05:40:41 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 05:40:41 INFO - Using env: {'DISPLAY': ':0', 05:40:41 INFO - 'HOME': '/home/cltbld', 05:40:41 INFO - 'LANG': 'en_US.UTF-8', 05:40:41 INFO - 'LANGUAGE': 'en_US:en', 05:40:41 INFO - 'LOGNAME': 'cltbld', 05:40:41 INFO - 'MAIL': '/var/mail/cltbld', 05:40:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:40:41 INFO - 'MOZ_NO_REMOTE': '1', 05:40:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:40:41 INFO - 'NO_EM_RESTART': '1', 05:40:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:40:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:40:41 INFO - 'PWD': '/builds/slave/test', 05:40:41 INFO - 'SHELL': '/bin/bash', 05:40:41 INFO - 'SHLVL': '1', 05:40:41 INFO - 'TERM': 'linux', 05:40:41 INFO - 'TMOUT': '86400', 05:40:41 INFO - 'USER': 'cltbld', 05:40:41 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1466772025.399715-407914977', 05:40:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:40:41 INFO - '_': '/tools/buildbot/bin/python'} 05:40:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:40:41 INFO - Downloading/unpacking psutil>=3.1.1 05:40: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 05:40: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 05:40: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 05:40: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 05:40: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 05:40: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 05:40:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:40:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:40:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:40:43 INFO - Installing collected packages: psutil 05:40:43 INFO - Running setup.py install for psutil 05:40:43 INFO - building 'psutil._psutil_linux' extension 05:40:43 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 05:40:43 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 05:40:43 INFO - building 'psutil._psutil_posix' extension 05:40:43 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 05:40:43 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 05:40:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:40:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:40:44 INFO - Successfully installed psutil 05:40:44 INFO - Cleaning up... 05:40:44 INFO - Return code: 0 05:40:44 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:40:44 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')]} 05:40:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:40:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:44 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')]} 05:40:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:40:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:44 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 0x7f0b1dad6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a458a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b10350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b9f1c0>, '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 0x2ba00c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ba0550>, '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': 'fa44defc139c4ba8574fe040000001db-1466772025.399715-407914977', '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 05:40:44 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 05:40:44 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 05:40:44 INFO - Using env: {'DISPLAY': ':0', 05:40:44 INFO - 'HOME': '/home/cltbld', 05:40:44 INFO - 'LANG': 'en_US.UTF-8', 05:40:44 INFO - 'LANGUAGE': 'en_US:en', 05:40:44 INFO - 'LOGNAME': 'cltbld', 05:40:44 INFO - 'MAIL': '/var/mail/cltbld', 05:40:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:40:44 INFO - 'MOZ_NO_REMOTE': '1', 05:40:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:40:44 INFO - 'NO_EM_RESTART': '1', 05:40:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:40:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:40:44 INFO - 'PWD': '/builds/slave/test', 05:40:44 INFO - 'SHELL': '/bin/bash', 05:40:44 INFO - 'SHLVL': '1', 05:40:44 INFO - 'TERM': 'linux', 05:40:44 INFO - 'TMOUT': '86400', 05:40:44 INFO - 'USER': 'cltbld', 05:40:44 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1466772025.399715-407914977', 05:40:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:40:44 INFO - '_': '/tools/buildbot/bin/python'} 05:40:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:40:44 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:40:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:40:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:40:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:40:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:40:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:40:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:40:46 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:40:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:40:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:40:46 INFO - Installing collected packages: mozsystemmonitor 05:40:46 INFO - Running setup.py install for mozsystemmonitor 05:40:46 INFO - Successfully installed mozsystemmonitor 05:40:46 INFO - Cleaning up... 05:40:46 INFO - Return code: 0 05:40:46 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:40:46 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')]} 05:40:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:40:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:46 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')]} 05:40:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:40:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:46 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 0x7f0b1dad6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a458a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b10350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b9f1c0>, '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 0x2ba00c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ba0550>, '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': 'fa44defc139c4ba8574fe040000001db-1466772025.399715-407914977', '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 05:40:46 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 05:40:46 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 05:40:46 INFO - Using env: {'DISPLAY': ':0', 05:40:46 INFO - 'HOME': '/home/cltbld', 05:40:46 INFO - 'LANG': 'en_US.UTF-8', 05:40:46 INFO - 'LANGUAGE': 'en_US:en', 05:40:46 INFO - 'LOGNAME': 'cltbld', 05:40:46 INFO - 'MAIL': '/var/mail/cltbld', 05:40:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:40:46 INFO - 'MOZ_NO_REMOTE': '1', 05:40:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:40:46 INFO - 'NO_EM_RESTART': '1', 05:40:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:40:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:40:46 INFO - 'PWD': '/builds/slave/test', 05:40:46 INFO - 'SHELL': '/bin/bash', 05:40:46 INFO - 'SHLVL': '1', 05:40:46 INFO - 'TERM': 'linux', 05:40:46 INFO - 'TMOUT': '86400', 05:40:46 INFO - 'USER': 'cltbld', 05:40:46 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1466772025.399715-407914977', 05:40:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:40:46 INFO - '_': '/tools/buildbot/bin/python'} 05:40:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:40:46 INFO - Downloading/unpacking jsonschema==2.5.1 05:40:46 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 05:40:46 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 05:40:46 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 05:40:46 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 05:40:46 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 05:40:46 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 05:40:48 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:40:48 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:40:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:40:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:40:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:40:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:40:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:40:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:40:48 INFO - Downloading functools32-3.2.3-2.tar.gz 05:40:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:40:48 INFO - warning: no files found matching '*.txt' 05:40:48 INFO - no previously-included directories found matching 'build' 05:40:48 INFO - no previously-included directories found matching 'dist' 05:40:48 INFO - no previously-included directories found matching '.git*' 05:40:48 INFO - Installing collected packages: jsonschema, functools32 05:40:48 INFO - Running setup.py install for functools32 05:40:48 INFO - warning: no files found matching '*.txt' 05:40:48 INFO - no previously-included directories found matching 'build' 05:40:48 INFO - no previously-included directories found matching 'dist' 05:40:48 INFO - no previously-included directories found matching '.git*' 05:40:48 INFO - Successfully installed jsonschema functools32 05:40:48 INFO - Cleaning up... 05:40:49 INFO - Return code: 0 05:40:49 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:40: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')]} 05:40:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:40:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40: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')]} 05:40:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:40:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40: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', '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 0x7f0b1dad6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a458a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b10350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b9f1c0>, '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 0x2ba00c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ba0550>, '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': 'fa44defc139c4ba8574fe040000001db-1466772025.399715-407914977', '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 05:40: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:40: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 blobuploader==1.2.4 05:40:49 INFO - Using env: {'DISPLAY': ':0', 05:40:49 INFO - 'HOME': '/home/cltbld', 05:40:49 INFO - 'LANG': 'en_US.UTF-8', 05:40:49 INFO - 'LANGUAGE': 'en_US:en', 05:40:49 INFO - 'LOGNAME': 'cltbld', 05:40:49 INFO - 'MAIL': '/var/mail/cltbld', 05:40:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:40:49 INFO - 'MOZ_NO_REMOTE': '1', 05:40:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:40:49 INFO - 'NO_EM_RESTART': '1', 05:40:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:40:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:40:49 INFO - 'PWD': '/builds/slave/test', 05:40:49 INFO - 'SHELL': '/bin/bash', 05:40:49 INFO - 'SHLVL': '1', 05:40:49 INFO - 'TERM': 'linux', 05:40:49 INFO - 'TMOUT': '86400', 05:40:49 INFO - 'USER': 'cltbld', 05:40:49 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1466772025.399715-407914977', 05:40:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:40:49 INFO - '_': '/tools/buildbot/bin/python'} 05:40:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:40:49 INFO - Downloading/unpacking blobuploader==1.2.4 05:40: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 05:40: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 05:40: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 05:40: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 05:40: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 05:40: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 05:40:51 INFO - Downloading blobuploader-1.2.4.tar.gz 05:40:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:40:51 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:40: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 05:40: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 05:40: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 05:40: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 05:40: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 05:40: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 05:40:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:40:51 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:40: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 05:40: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 05:40: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 05:40: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 05:40: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 05:40: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 05:40:51 INFO - Downloading docopt-0.6.1.tar.gz 05:40:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:40:52 INFO - Installing collected packages: blobuploader, requests, docopt 05:40:52 INFO - Running setup.py install for blobuploader 05:40:52 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:40:52 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:40:52 INFO - Running setup.py install for requests 05:40:52 INFO - Running setup.py install for docopt 05:40:52 INFO - Successfully installed blobuploader requests docopt 05:40:52 INFO - Cleaning up... 05:40:52 INFO - Return code: 0 05:40:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:40:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 05:40:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:40:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 05:40:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:40:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:52 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 0x7f0b1dad6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a458a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b10350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b9f1c0>, '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 0x2ba00c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ba0550>, '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': 'fa44defc139c4ba8574fe040000001db-1466772025.399715-407914977', '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 05:40:52 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 05:40:52 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 05:40:52 INFO - Using env: {'DISPLAY': ':0', 05:40:52 INFO - 'HOME': '/home/cltbld', 05:40:52 INFO - 'LANG': 'en_US.UTF-8', 05:40:52 INFO - 'LANGUAGE': 'en_US:en', 05:40:52 INFO - 'LOGNAME': 'cltbld', 05:40:52 INFO - 'MAIL': '/var/mail/cltbld', 05:40:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:40:52 INFO - 'MOZ_NO_REMOTE': '1', 05:40:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:40:52 INFO - 'NO_EM_RESTART': '1', 05:40:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:40:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:40:52 INFO - 'PWD': '/builds/slave/test', 05:40:52 INFO - 'SHELL': '/bin/bash', 05:40:52 INFO - 'SHLVL': '1', 05:40:52 INFO - 'TERM': 'linux', 05:40:52 INFO - 'TMOUT': '86400', 05:40:52 INFO - 'USER': 'cltbld', 05:40:52 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1466772025.399715-407914977', 05:40:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:40:52 INFO - '_': '/tools/buildbot/bin/python'} 05:40:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:40:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:40:52 INFO - Running setup.py (path:/tmp/pip-qJHVOC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:40:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:40:52 INFO - Running setup.py (path:/tmp/pip-ajljtM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:40:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:40:52 INFO - Running setup.py (path:/tmp/pip-HZFBCZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:40:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:40:53 INFO - Running setup.py (path:/tmp/pip-HI03zc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:40:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:40:53 INFO - Running setup.py (path:/tmp/pip-UioTT5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:40:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:40:53 INFO - Running setup.py (path:/tmp/pip-NqMAIa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:40:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:40:53 INFO - Running setup.py (path:/tmp/pip-CXPChe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:40:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:40:53 INFO - Running setup.py (path:/tmp/pip-c5ggE_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:40:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:40:53 INFO - Running setup.py (path:/tmp/pip-cqT16g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:40:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:40:53 INFO - Running setup.py (path:/tmp/pip-Nze8hh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:40:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:40:53 INFO - Running setup.py (path:/tmp/pip-mY8ywl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:40:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:40:53 INFO - Running setup.py (path:/tmp/pip-eXFmMk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:40:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:40:53 INFO - Running setup.py (path:/tmp/pip-zkvNrD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:40:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:40:53 INFO - Running setup.py (path:/tmp/pip-j0DcpL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:40:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:40:53 INFO - Running setup.py (path:/tmp/pip-X1URT5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:40:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:40:53 INFO - Running setup.py (path:/tmp/pip-F9tMnE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:40:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:40:54 INFO - Running setup.py (path:/tmp/pip-E5hsrK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:40:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:40:54 INFO - Running setup.py install for manifestparser 05:40:54 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:40:54 INFO - Running setup.py install for mozcrash 05:40:54 INFO - Running setup.py install for mozdebug 05:40:54 INFO - Running setup.py install for mozdevice 05:40:54 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:40:54 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:40:54 INFO - Running setup.py install for mozfile 05:40:54 INFO - Running setup.py install for mozhttpd 05:40:54 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:40:54 INFO - Running setup.py install for mozinfo 05:40:54 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:40:54 INFO - Running setup.py install for mozInstall 05:40:54 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:40:54 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:40:54 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:40:54 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:40:54 INFO - Running setup.py install for mozleak 05:40:55 INFO - Running setup.py install for mozlog 05:40:55 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:40:55 INFO - Running setup.py install for moznetwork 05:40:55 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:40:55 INFO - Running setup.py install for mozprocess 05:40:55 INFO - Running setup.py install for mozprofile 05:40:55 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:40:55 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:40:55 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:40:55 INFO - Running setup.py install for mozrunner 05:40:55 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:40:55 INFO - Running setup.py install for mozscreenshot 05:40:55 INFO - Running setup.py install for moztest 05:40:55 INFO - Running setup.py install for mozversion 05:40:55 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:40:55 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:40:55 INFO - Cleaning up... 05:40:55 INFO - Return code: 0 05:40:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:40:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:40:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:40:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:40:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:40:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:55 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 0x7f0b1dad6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a458a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b10350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b9f1c0>, '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 0x2ba00c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ba0550>, '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': 'fa44defc139c4ba8574fe040000001db-1466772025.399715-407914977', '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 05:40:55 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 05:40:55 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 05:40:55 INFO - Using env: {'DISPLAY': ':0', 05:40:55 INFO - 'HOME': '/home/cltbld', 05:40:55 INFO - 'LANG': 'en_US.UTF-8', 05:40:55 INFO - 'LANGUAGE': 'en_US:en', 05:40:55 INFO - 'LOGNAME': 'cltbld', 05:40:55 INFO - 'MAIL': '/var/mail/cltbld', 05:40:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:40:55 INFO - 'MOZ_NO_REMOTE': '1', 05:40:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:40:55 INFO - 'NO_EM_RESTART': '1', 05:40:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:40:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:40:55 INFO - 'PWD': '/builds/slave/test', 05:40:55 INFO - 'SHELL': '/bin/bash', 05:40:55 INFO - 'SHLVL': '1', 05:40:55 INFO - 'TERM': 'linux', 05:40:55 INFO - 'TMOUT': '86400', 05:40:55 INFO - 'USER': 'cltbld', 05:40:55 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1466772025.399715-407914977', 05:40:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:40:55 INFO - '_': '/tools/buildbot/bin/python'} 05:40:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:40:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:40:56 INFO - Running setup.py (path:/tmp/pip-9keBCi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:40:56 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)) 05:40:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:40:56 INFO - Running setup.py (path:/tmp/pip-L6IJfm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:40:56 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)) 05:40:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:40:56 INFO - Running setup.py (path:/tmp/pip-Ne5Sd5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:40:56 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)) 05:40:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:40:56 INFO - Running setup.py (path:/tmp/pip-XQv2tM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:40:56 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)) 05:40:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:40:56 INFO - Running setup.py (path:/tmp/pip-LpKacB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:40:56 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)) 05:40:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:40:56 INFO - Running setup.py (path:/tmp/pip-Hc0alE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:40:56 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)) 05:40:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:40:56 INFO - Running setup.py (path:/tmp/pip-N21d_q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:40:56 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)) 05:40:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:40:56 INFO - Running setup.py (path:/tmp/pip-pUrlPO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:40:56 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)) 05:40:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:40:56 INFO - Running setup.py (path:/tmp/pip-EHqOSL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:40:56 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)) 05:40:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:40:56 INFO - Running setup.py (path:/tmp/pip-Ylbon1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:40:56 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)) 05:40:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:40:56 INFO - Running setup.py (path:/tmp/pip-eJVxML-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:40:56 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)) 05:40:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:40:56 INFO - Running setup.py (path:/tmp/pip-YKxHr7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:40:57 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)) 05:40:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:40:57 INFO - Running setup.py (path:/tmp/pip-rPMnk_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:40:57 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)) 05:40:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:40:57 INFO - Running setup.py (path:/tmp/pip-JfnGcL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:40:57 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)) 05:40:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:40:57 INFO - Running setup.py (path:/tmp/pip-9orrwZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:40:57 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)) 05:40:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:40:57 INFO - Running setup.py (path:/tmp/pip-GmYAI3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:40:57 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)) 05:40:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:40:57 INFO - Running setup.py (path:/tmp/pip-waw9dQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:40:57 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)) 05:40:57 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)) 05:40:57 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)) 05:40:57 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)) 05:40:57 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)) 05:40:57 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)) 05:40:57 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:40:57 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 05:40:57 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 05:40:57 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 05:40:57 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 05:40:57 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 05:40:57 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 05:40:59 INFO - Downloading blessings-1.6.tar.gz 05:40:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:40:59 INFO - Installing collected packages: blessings 05:40:59 INFO - Running setup.py install for blessings 05:40:59 INFO - Successfully installed blessings 05:40:59 INFO - Cleaning up... 05:40:59 INFO - Return code: 0 05:40:59 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:40:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:40:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:40:59 INFO - Reading from file tmpfile_stdout 05:40:59 INFO - Current package versions: 05:40:59 INFO - argparse == 1.2.1 05:40:59 INFO - blessings == 1.6 05:40:59 INFO - blobuploader == 1.2.4 05:40:59 INFO - docopt == 0.6.1 05:40:59 INFO - functools32 == 3.2.3-2 05:40:59 INFO - jsonschema == 2.5.1 05:40:59 INFO - manifestparser == 1.1 05:40:59 INFO - mozInstall == 1.12 05:40:59 INFO - mozcrash == 0.17 05:40:59 INFO - mozdebug == 0.1 05:40:59 INFO - mozdevice == 0.48 05:40:59 INFO - mozfile == 1.2 05:40:59 INFO - mozhttpd == 0.7 05:40:59 INFO - mozinfo == 0.9 05:40:59 INFO - mozleak == 0.1 05:40:59 INFO - mozlog == 3.2 05:40:59 INFO - moznetwork == 0.27 05:40:59 INFO - mozprocess == 0.22 05:40:59 INFO - mozprofile == 0.28 05:40:59 INFO - mozrunner == 6.11 05:40:59 INFO - mozscreenshot == 0.1 05:40:59 INFO - mozsystemmonitor == 0.3 05:40:59 INFO - moztest == 0.7 05:40:59 INFO - mozversion == 1.4 05:40:59 INFO - psutil == 3.1.1 05:40:59 INFO - requests == 1.2.3 05:40:59 INFO - wsgiref == 0.1.2 05:40:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:40:59 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')]} 05:40:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:40:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:59 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')]} 05:40:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:40:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:59 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 0x7f0b1dad6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a458a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b10350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b9f1c0>, '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 0x2ba00c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ba0550>, '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': 'fa44defc139c4ba8574fe040000001db-1466772025.399715-407914977', '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 05:40:59 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 05:40:59 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 05:40:59 INFO - Using env: {'DISPLAY': ':0', 05:40:59 INFO - 'HOME': '/home/cltbld', 05:40:59 INFO - 'LANG': 'en_US.UTF-8', 05:40:59 INFO - 'LANGUAGE': 'en_US:en', 05:40:59 INFO - 'LOGNAME': 'cltbld', 05:40:59 INFO - 'MAIL': '/var/mail/cltbld', 05:40:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:40:59 INFO - 'MOZ_NO_REMOTE': '1', 05:40:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:40:59 INFO - 'NO_EM_RESTART': '1', 05:40:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:40:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:40:59 INFO - 'PWD': '/builds/slave/test', 05:40:59 INFO - 'SHELL': '/bin/bash', 05:40:59 INFO - 'SHLVL': '1', 05:40:59 INFO - 'TERM': 'linux', 05:40:59 INFO - 'TMOUT': '86400', 05:40:59 INFO - 'USER': 'cltbld', 05:40:59 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1466772025.399715-407914977', 05:40:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:40:59 INFO - '_': '/tools/buildbot/bin/python'} 05:40:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:40:59 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)) 05:40:59 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)) 05:40:59 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)) 05:40:59 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)) 05:40:59 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)) 05:40:59 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)) 05:40:59 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)) 05:40:59 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)) 05:40:59 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)) 05:40:59 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)) 05:40:59 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)) 05:40:59 INFO - Cleaning up... 05:40:59 INFO - Return code: 0 05:40:59 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:40:59 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')]} 05:40:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:40:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:59 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')]} 05:40:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:40:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:59 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 0x7f0b1dad6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a458a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b10350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b9f1c0>, '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 0x2ba00c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ba0550>, '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': 'fa44defc139c4ba8574fe040000001db-1466772025.399715-407914977', '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 05:40:59 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 05:40:59 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 05:40:59 INFO - Using env: {'DISPLAY': ':0', 05:40:59 INFO - 'HOME': '/home/cltbld', 05:40:59 INFO - 'LANG': 'en_US.UTF-8', 05:40:59 INFO - 'LANGUAGE': 'en_US:en', 05:40:59 INFO - 'LOGNAME': 'cltbld', 05:40:59 INFO - 'MAIL': '/var/mail/cltbld', 05:40:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:40:59 INFO - 'MOZ_NO_REMOTE': '1', 05:40:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:40:59 INFO - 'NO_EM_RESTART': '1', 05:40:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:40:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:40:59 INFO - 'PWD': '/builds/slave/test', 05:40:59 INFO - 'SHELL': '/bin/bash', 05:40:59 INFO - 'SHLVL': '1', 05:40:59 INFO - 'TERM': 'linux', 05:40:59 INFO - 'TMOUT': '86400', 05:40:59 INFO - 'USER': 'cltbld', 05:40:59 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1466772025.399715-407914977', 05:40:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:40:59 INFO - '_': '/tools/buildbot/bin/python'} 05:41:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:41:00 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:41:00 INFO - Cleaning up... 05:41:00 INFO - Return code: 0 05:41:00 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:41:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:41:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:41:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:41:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:41:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:41:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:41:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0b1dad6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a458a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b10350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b9f1c0>, '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 0x2ba00c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ba0550>, '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': 'fa44defc139c4ba8574fe040000001db-1466772025.399715-407914977', '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 05:41:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 05:41:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 05:41:00 INFO - Using env: {'DISPLAY': ':0', 05:41:00 INFO - 'HOME': '/home/cltbld', 05:41:00 INFO - 'LANG': 'en_US.UTF-8', 05:41:00 INFO - 'LANGUAGE': 'en_US:en', 05:41:00 INFO - 'LOGNAME': 'cltbld', 05:41:00 INFO - 'MAIL': '/var/mail/cltbld', 05:41:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:41:00 INFO - 'MOZ_NO_REMOTE': '1', 05:41:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:41:00 INFO - 'NO_EM_RESTART': '1', 05:41:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:41:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:41:00 INFO - 'PWD': '/builds/slave/test', 05:41:00 INFO - 'SHELL': '/bin/bash', 05:41:00 INFO - 'SHLVL': '1', 05:41:00 INFO - 'TERM': 'linux', 05:41:00 INFO - 'TMOUT': '86400', 05:41:00 INFO - 'USER': 'cltbld', 05:41:00 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1466772025.399715-407914977', 05:41:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:41:00 INFO - '_': '/tools/buildbot/bin/python'} 05:41:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:41:00 INFO - Downloading/unpacking flake8 05:41:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:41:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:41:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:41:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:41:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:41:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:41:02 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:41:02 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:41:02 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 05:41:02 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 05:41:02 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 05:41:02 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 05:41:02 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 05:41:02 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 05:41:02 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:41:02 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:41:02 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 05:41:02 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 05:41:02 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 05:41:02 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 05:41:02 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 05:41:02 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 05:41:02 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:41:02 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 05:41:02 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 05:41:02 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 05:41:02 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 05:41:02 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 05:41:02 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 05:41:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:41:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:41:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:41:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:41:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:41:03 INFO - no previously-included directories found matching 'docs/_build' 05:41:03 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:41:03 INFO - Running setup.py install for pep8 05:41:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:41:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:41:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:41:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:41:03 INFO - no previously-included directories found matching 'docs/_build' 05:41:03 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:41:03 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:41:03 INFO - Cleaning up... 05:41:03 INFO - Return code: 0 05:41:03 INFO - Running post-action listener: _resource_record_post_action 05:41:03 INFO - Running post-action listener: _start_resource_monitoring 05:41:03 INFO - Starting resource monitoring. 05:41:03 INFO - ##### 05:41:03 INFO - ##### Finished create-virtualenv step (success) 05:41:03 INFO - ##### 05:41:03 INFO - ##### 05:41:03 INFO - ##### Running install step. 05:41:03 INFO - ##### 05:41:03 INFO - Running pre-action listener: _resource_record_pre_action 05:41:03 INFO - Running main action method: install 05:41:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:41:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:41:03 INFO - Reading from file tmpfile_stdout 05:41:03 INFO - Detecting whether we're running mozinstall >=1.0... 05:41:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:41:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:41:03 INFO - Reading from file tmpfile_stdout 05:41:03 INFO - Output received: 05:41:03 INFO - Usage: mozinstall [options] installer 05:41:03 INFO - Options: 05:41:03 INFO - -h, --help show this help message and exit 05:41:03 INFO - -d DEST, --destination=DEST 05:41:03 INFO - Directory to install application into. [default: 05:41:03 INFO - "/builds/slave/test"] 05:41:03 INFO - --app=APP Application being installed. [default: firefox] 05:41:03 INFO - mkdir: /builds/slave/test/build/application 05:41:03 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'] 05:41:03 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 05:41:20 INFO - Reading from file tmpfile_stdout 05:41:20 INFO - Output received: 05:41:20 INFO - /builds/slave/test/build/application/firefox/firefox 05:41:20 INFO - Running post-action listener: _resource_record_post_action 05:41:20 INFO - ##### 05:41:20 INFO - ##### Finished install step (success) 05:41:20 INFO - ##### 05:41:20 INFO - ##### 05:41:20 INFO - ##### Running run-tests step. 05:41:20 INFO - ##### 05:41:20 INFO - Running pre-action listener: _resource_record_pre_action 05:41:20 INFO - Running main action method: run_tests 05:41:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:41:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:41:20 INFO - Python 2.7.3 05:41:20 INFO - Return code: 0 05:41:20 INFO - grabbing minidump binary from tooltool 05:41:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 05:41:20 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 0x2b9f1c0>, '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 0x2ba00c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ba0550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:41:20 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 05:41:20 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 05:41:20 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 05:41:20 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:41:20 INFO - Return code: 0 05:41:20 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:41:20 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:41:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:41:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:41:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:41:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:41:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:41:21 INFO - Return code: 0 05:41:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/H5xSstgaRQ6-mUGxW0l7yQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--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 05:41:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/H5xSstgaRQ6-mUGxW0l7yQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-048 --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 05:41:21 INFO - Using env: {'DISPLAY': ':0', 05:41:21 INFO - 'HOME': '/home/cltbld', 05:41:21 INFO - 'LANG': 'en_US.UTF-8', 05:41:21 INFO - 'LANGUAGE': 'en_US:en', 05:41:21 INFO - 'LOGNAME': 'cltbld', 05:41:21 INFO - 'MAIL': '/var/mail/cltbld', 05:41:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:41:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:41:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:41:21 INFO - 'MOZ_NO_REMOTE': '1', 05:41:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:41:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:41:21 INFO - 'NO_EM_RESTART': '1', 05:41:21 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:41:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:41:21 INFO - 'PWD': '/builds/slave/test', 05:41:21 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:41:21 INFO - 'SHELL': '/bin/bash', 05:41:21 INFO - 'SHLVL': '1', 05:41:21 INFO - 'TERM': 'linux', 05:41:21 INFO - 'TMOUT': '86400', 05:41:21 INFO - 'USER': 'cltbld', 05:41:21 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1466772025.399715-407914977', 05:41:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:41:21 INFO - '_': '/tools/buildbot/bin/python'} 05:41:21 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/H5xSstgaRQ6-mUGxW0l7yQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--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 05:41:21 INFO - mozversion application_buildid: 20160624023004 05:41:21 INFO - mozversion application_changeset: 9f27664669366144c1756f0b416277c16ac96ac2 05:41:21 INFO - mozversion application_display_name: Nightly 05:41:21 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:41:21 INFO - mozversion application_name: Firefox 05:41:21 INFO - mozversion application_remotingname: firefox 05:41:21 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:41:21 INFO - mozversion application_vendor: Mozilla 05:41:21 INFO - mozversion application_version: 50.0a1 05:41:21 INFO - mozversion platform_buildid: 20160624023004 05:41:21 INFO - mozversion platform_changeset: 9f27664669366144c1756f0b416277c16ac96ac2 05:41:21 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:41:21 INFO - mozversion platform_version: 50.0a1 05:41:21 INFO - using testdate: 1466772081 05:41:21 INFO - actual date: 1466772081 05:41:21 INFO - starting webserver on 'localhost:36625' 05:41:21 INFO - SUITE-START | Running 2 tests 05:41:21 INFO - TEST-START | dromaeo_css 05:41:21 INFO - operating with platform_type : linux_ 05:41:21 INFO - Initialising browser for dromaeo_css test... 05:41:21 INFO - TEST-INFO | started process 27253 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUSdDFM/profile http://localhost:36625/getInfo.html) 05:41:26 INFO - PROCESS | 27253 | __metrics Screen width/height:1600/1200 05:41:26 INFO - PROCESS | 27253 | colorDepth:24 05:41:26 INFO - PROCESS | 27253 | Browser inner width/height: 1024/697 05:41:26 INFO - PROCESS | 27253 | __metrics 05:41:27 ERROR - PROCESS | 27253 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 05:41:28 INFO - TEST-INFO | 27253: exit 0 05:41:28 INFO - Browser initialized. 05:41:28 INFO - Running cycle 1/1 for dromaeo_css test... 05:41:28 INFO - TEST-INFO | started process 27371 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUSdDFM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:41:40 INFO - PROCESS | 27371 | RSS: Main: 184643584 05:41:40 INFO - PROCESS | 27371 | 05:42:30 INFO - PROCESS | 27371 | 1466772150031 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] 05:44:38 INFO - PROCESS | 27371 | Cycle 1(1): loaded http://localhost:36625/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36625/tests/dromaeo/cssquery-ext.html) 05:44:39 INFO - PROCESS | 27371 | RSS: Main: 188461056 05:44:39 INFO - PROCESS | 27371 | 05:47:41 INFO - PROCESS | 27371 | Cycle 1(1): loaded http://localhost:36625/tests/dromaeo/cssquery-ext.html (next: http://localhost:36625/tests/dromaeo/cssquery-jquery.html) 05:47:42 INFO - PROCESS | 27371 | RSS: Main: 187133952 05:47:42 INFO - PROCESS | 27371 | 05:50:44 INFO - PROCESS | 27371 | Cycle 1(1): loaded http://localhost:36625/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36625/tests/dromaeo/cssquery-mootools.html) 05:50:44 INFO - PROCESS | 27371 | RSS: Main: 189870080 05:50:44 INFO - PROCESS | 27371 | 05:53:46 INFO - PROCESS | 27371 | Cycle 1(1): loaded http://localhost:36625/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36625/tests/dromaeo/cssquery-prototype.html) 05:53:47 INFO - PROCESS | 27371 | RSS: Main: 186540032 05:53:47 INFO - PROCESS | 27371 | 05:56:49 INFO - PROCESS | 27371 | Cycle 1(1): loaded http://localhost:36625/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36625/tests/dromaeo/cssquery-yui.html) 05:56:50 INFO - PROCESS | 27371 | RSS: Main: 188305408 05:56:50 INFO - PROCESS | 27371 | 05:59:52 INFO - PROCESS | 27371 | Cycle 1(1): loaded http://localhost:36625/tests/dromaeo/cssquery-yui.html (next: http://localhost:36625/tests/dromaeo/cssquery-dojo.html) 05:59:52 INFO - PROCESS | 27371 | RSS: Main: 189566976 05:59:52 INFO - PROCESS | 27371 | 05:59:52 INFO - PROCESS | 27371 | __start_tp_report 05:59:52 INFO - PROCESS | 27371 | _x_x_mozilla_page_load 05:59:52 INFO - PROCESS | 27371 | _x_x_mozilla_page_load_details 05:59:52 INFO - PROCESS | 27371 | |i|pagename|runs| 05:59:52 INFO - PROCESS | 27371 | |0;dojo.html;3109.8600562974666;3172.9524057139147;3176.6188057433096;3210.566573512578;3222.645508994012;5526.723663816808;5546.278983732119;5572.888542229153;5616.382197958226;5622.381538030813;5367.913449766381;5569.415211402805;5631.915521267174;5634.4365563443735;5712.285964254468;5004.799808007684;5021.397432308128;5064.063148317573;5149.845504634848;5162.22566615007;5034.697918124906;5237.397699264595;5261.736913154346;5267.604929630274;5277.366715994086;5049.242613607951;5063.54428101469;5139.331886854722;5168.793248270064;5242;5084;5092.719900405476;5100.872478188038;5117.769700363493;5136.332276804029;5058.190689489664;5077.136886729265;5094.6433749637545;5101.081805275049;5129.153689641204;5419.512243898068;5424.0779067558215;5438.619296649236;5503.532199762985;5627.831165065014;5901.0558310670085;5909.438603332676;5909.6158749681135;5921;5935.673537955411;5994.97002514989;5995.430434108753;5999.250093738283;6006.069059295816;6006.159137720722;5449.5640348772;5501.559875209973;5533.08704063829;5555.555555555546;5573.136163894603;6041.909371359346;6049.879002419927;6057.757689692451;6059.697015149225;6076.939230607637;5706.058500347396;5805.506531944748;5806.854828629318;5812.447817457335;5825.446582574648;5843.03589907669;5927.407259274124;5956.791512297049;5971.164037034819;5973.850653733692;5672.234248376499;5856.355800861902;5905.940940590625;5938.970305148447;5949.791757288474;5906.49794767441;5953.613015154001;5957.6127551709;5973;6014.879702406015;4407.713498622579;4489.393931819228;4562.908741825211;4588.128255631419;4601.28680054592;4058.127502586958;4058.7564746114735;4072.4095006223934;4108.342665173558;4114.300568903293;5575.972120139373;5713.228714123623;5734.856628584319;5740.885182296331;5760.251167348301;5963.135345374896;6020.307664618625;6020.488258497989;6053.152558641794;6053.3946605339115;5722.54219662426;5740.368559458456;5746.683932383676;5750.338711048283;5766.538676905838;5016.122178618727;5106.029854327666;5162.53537181648;5167.793288268427;5172.8965420691375;6145.5698101133385;6202.5658203925295;6216.502679785606;6233.594816336924;6235.781747638902;5936.981426315074;6035.36628653985;6040.184575082483;6049.243844519435;6056.727447264796;5955.91066134017;6120.081455037999;6131.049687298476;6183.103449999815;6197.876042479035;5848.093545500455;5851.093080572518;5852.4147585241135;5862.824115276549;5871.089981052944;5953.493953013869;5963.850903727442;5976.910346344721;6000.369961154016;6017.879642407215;5556.138798486241;5704.2014118024335;5757;5779.393163717918;5823.475887170175;5572.582056345709;5653.745581448927;5680;5705.971470142623;5746.367899531132;5677.3754886963225;5694.259746232963;5706.942930570807;5708.914366284426;5720.74256658443;5518.19986102021;5800.1299805029585;5812.041013232938;5823.912641310469;5845.736941837713;5690.77236910519;5709.9714501427225;5710.685912274865;5733.770649173986;5735.713214339183 05:59:52 INFO - PROCESS | 27371 | |1;ext.html;567.2738894215403;620.7454943473174;624.0639041437843;636.6053047110792;652.7650045983448;38581.421278680806;40703.79648101763;41062;41427.964300892454;41478.792606036965;42170.36744448836;42845.357319640156;42983;42985.570144298545;43027.35458968118;8594.398392112571;8722.258608018326;8725.301975841918;8726.258268047191;8745.300375969939;8661;8687.435316704426;8744.693935712252;8807.427517211361;8815.823683526325;8801.427907186044;8847.159519845636;8879.245264152554;8882.555872206363;8887.68893088742;8790.472571645721;8811.471311721318;8827.205551500363;8829.95585022074;8871.689490867788;8753.737387878375;8767.693130740394;8782.780430489289;8792.516411597424;8833.33749968755;40316.39525407092;40713.79643101795;40753.59246407557;40810;40834.59165408338;3703;3740.476333313311;3822.57951625321;3840.692744580455;4287.892802679927;29780;30608.54087188694;30626.693733062606;30810.22974425635;31235.375292494024;4384;4394.8901277468;4451;4537.77311134442;4596.3794887690065;324826;325109;327411;328212;328371.3581432101;34217.31565368679;57781;58492;58492.415075848694;58762.41237587655;34741;36336.818315908255;36562;36674.63325366766;36725.26549468996;14781.113133212042;15024.849751502563;15029.398824047134;15033.924830375998;15054.172020538976;12233.877661223452;12309.876901231051;12430.813537796941;12436.502539898303;12500.374981250901;8385.496870187808;8408.663653453916;8414.443327984343;8414.49513029208;8494.405391622528;3213.4376484115655;3240.09277402323;3251.7236034937296;3288.9342213156083;3307.5038744188564;982.886967998675;1028.1106842581114;1040.557762950758;1116.3748300951493;1156.4969238381163;31148.221294467367;31627.841860790548;32094.67905320917;32217.194570135933;32468.350632987207;1068.4566957281463;1110.272771334777;1111.3387534417009;1130.7964566377966;1222.49877550204;16500.33998640065;16874.91562542204;17184.914075429544;17279.827201728072;17447.82552174462;526675;527098;532841;534990;536066;39710.999999999425;39739.403908941385;39890;39948.60051399507;40077.19845603072;1308.5943357558997;1327.5353626230935;1342.275171407429;1355.1868878672717;1364.8498665146826;30089.548656770603;30275.545866811575;31111.84444077765;31443;31903.361932760752;50404;50501.49498504968;50846.23730644117;50936;50974.235386469976;417311;420291;422620;422799;423483;27955.440891181657;28638.856805715837;28896;29007.419851602426;29272.26819329534;47066;47870.76064619655;48108.27837582369;48263.27605085856;48706.75646621744;40287;40700.796496017334;40939.18121637491;41469.37795933003;41927;39573;39627;40160;40448.39327410032;40845;39500.80249598734;41602;42526.362104569074;42569.36145957875;44392.33411498766;32716.182095447803;35381.115472112375;36074.819625901706;37601.811990939874;37676.623233768405;26085.478290433704;26440.206793796217;27056.32359191036;27115.457690845677;27278.527069190317 05:59:52 INFO - PROCESS | 27371 | |2;jquery.html;380.57755890961045;380.69354169893245;397.1322659987926;399.1537939568115;413.68146527174076;13907.513237036706;18143.36498222559;18265.36071237507;19340.129694163763;19445.70831437528;18287.54281142972;18391.448256552292;18775.53061173468;19053.237870485198;19190.424287271406;5436.646617969839;5732.111522713986;5749.453801888814;5820.825375238728;5864.413558644144;5512.118061110224;5635.943640563603;5656.151577263402;5676.545876329905;5676.858078548028;5577.274954255941;5632.464915832989;5649.604527683064;5659.490645841874;5663.348714897798;5553.805616803413;5661.348944871352;5686.687232202227;5694.316681998145;5715.657060576337;5020.347354843847;5098.362704661918;5100.183970564692;5111.744412779383;5125.871853203663;22479;22887.77112228873;22946;23029.078836846507;23405.765942340528;2413.686220791286;2423.6243382275597;2440.475297810979;2616.1105224223666;2834.3480999370054;14512.637184070378;14861.256937153099;14964.625884352869;15002.62493437662;15023.624409389744;1861.1345724238295;1929.1897403090595;1960.9117589708496;1999.6900480425556;2035.9592808143902;76507.61746191289;77778;78292;78829.60585197038;78889;10266.589336426608;10408.5836566538;10705.732356690989;10725.946370268099;10918.344899306067;14441.205733684537;14673.486427975184;14702.338394772261;14763.261836908112;14779.704405912036;7891.802704932423;8148.674053037812;8192.098869124391;8255.339572834158;8295.4653389122;7724.922750772533;7905.288524032865;7946.006749156356;7999.280064794197;8129.796755081052;6371.745130194833;6609.372109649576;6630.336966303331;6697.330266973264;6756.459483241329;1846.4737549798513;1851.278001579385;1868.4962150718104;1890.2722451856134;1902.8097190281137;895.7133717210561;967.3615413826841;976.1702552830179;978.4422878958925;1036.3937096798306;19317.130729117223;19601.80398196028;19618.803811961698;19738.60522789565;20045.799542004686;970.6360114956891;1021.5147804792664;1050.0916707048348;1056.498163372392;1082.5453309609982;10628.893711062945;11086.16853735973;11176.776464470666;11250.887491124984;11349.489272982735;472509;477614;478558;484850;501068;42122.36816447756;69847;71780.64109679418;77450;81153;975.9414435133915;1017.898210178991;1023.2428003277521;1025.7179275699243;1032.2052019944601;14562;17417.216225270146;17540.947543147453;17771.289148433916;17936.551586210448;36986.26027479489;39532;42463.787681061396;43194.568054319054;43263.56736432721;53284.73357633187;53479;55104.72447637736;57857;61514.384856150864;8581.2705919995;8845.51349675774;8850.291976641982;8906.332025098014;8928.419652722552;13254.469821207043;14157;14188.290585470479;14226.502072427415;14282.42870285177;12287.93856030714;12336.75326493483;12507;12601.306928118674;12714.173578717353;11749.647510574696;11758.58844940423;11903.583374581847;11919.284842909454;12118.697032574257;12018.278903265833;12174.57388991381;12215.816762748744;12393;12409.93795031019;7501.88747168782;7814.804629884298;8848.292136629183;8859.867101993346;8935.687250946186;11389.088872890314;11519.30884146954;12369.93815030919;12381.442835072623;12437.315947622968 05:59:52 INFO - PROCESS | 27371 | |3;mootools.html;1390.3534856291826;1446.016708638126;1540.6379500817307;1735.5053809664241;1742.5295170304025;7926.128125906146;8495.745127646165;8521.659133634656;9146.817063658722;9150.130737579928;8935.06181850906;8951.194392504673;9025.458472491639;9062.275017998561;9072.63709451621;2310.5378924215183;2328.3247858121126;2341.6652508070406;2344.2146880794953;2351.9176828810996;2295.3687735872686;2349.906003759856;2414.396400899775;2421.0678888627917;2421.1041914491575;2350.576896158691;2362.29131260622;2366;2399.3881560202126;2408.2534414331612;2294.506681063571;2299.908003679851;2305.953880922389;2306.1006207579057;2352.1649814316015;2285.725712914444;2294.0365046680436;2295.3802473332275;2301;2301.3096071178747;9023.368364214508;9072.77318067047;9097.863532047024;9103.317251206186;9129.132732390479;5294.814681486129;5300.628955973083;5375.489328513785;5410.810621628263;5433.891322173574;3402.4726167444087;3413.9146521336916;3428.4857271409237;3498.4402495600834;3535.575730912307;1117.8602674665667;1131.1685910855515;1164.4643464006567;1177.0818761366147;1186.2645160000768;12757.74484510314;12786.488540458371;12789.552365667158;12809.871901280962;12827.102102852805;4797.088553174885;4820.975895120502;4918.508149185053;4936;4952.331435256267;10756.515956781963;10771.407572583583;10801.945990269998;10806.405647689295;10844.078253348554;5296.788128474895;5316.149416093406;5319.335083114611;5321.840344789585;5329.067413202674;4322.8703138905885;4872.683275587146;4997.400311962515;5009.223570346602;5030.245463180479;4084.8978775530254;4097.7746223957965;4126.681369335021;4154.937675934863;4196.979015104905;1273.6433798536425;1305.6083175047447;1307.7972914198315;1313.7897936330141;1320.4322141479256;889.7508697564692;925.6442354208556;946.1342871272708;973.2749101919115;991.2218908157206;5651.886962260732;5672.489475947102;5696.11710184922;5794.985877471426;6029.155918171459;430.46622188486054;437.5318409302016;438.6052552702593;455.06938311153107;457.14970155510724;4092.038370982876;4115.135821477464;4129.938050929239;4139;4150.688698347636;10924.726881828017;11418.486168122454;11494.252873563191;11500.94249528747;11520.193586448868;11280.097592192606;11328.546858125583;11372.715682108013;11380.089592832554;11385.373804440835;8333.16668333174;8355.080941096474;8485.40602157843;8547.95726021366;8574.614142363609;5541.3904470507405;5562.471565201299;5714.514266287412;5749.022666146849;5919.91120133207;10298.330608510423;10334.5349459273;10415.583376665152;10469.476526173508;10537.315074520131;10277.331973421704;10483.737906552093;10541.367517948947;10771.138308935424;10805.945970270099;7226.819329516804;7814.452988290993;8096.7166149184495;8132.959335203286;8232.876506852283;8944.463332200088;8975.371723979259;8981.14679105484;9019.323550733852;9055.456672599665;7805.102413222552;7870.409719270963;7932.444728868923;7966.203379661987;8017.238362355567;7768.873513340647;7800.765977020698;7822.491538050009;7887.881681774663;7898.407619428681;7152.749653762094;7227.168875579166;7236.240194779472;7237.819054523679;7248.927510724825;5313.070212712837;5333.386660533933;5369.436209197978;5399.082156033405;5414.539764120094;4960.553550180501;5370.194470829407;5425.755840987086;5437.211604317431;5445.346558413015 05:59:52 INFO - PROCESS | 27371 | |4;prototype.html;323.6536905511103;328.6434218872523;329.9884504042359;332.2772968792876;336.1445122164091;5666.461686139815;5724.456176663216;5727.599068065237;5732.2261494698205;5748.223989761381;5629.521490673287;5640.943590564093;5655.943440565593;5683.5169010634045;5698.886022279552;4162.771047592389;4210.179015092058;4314.633256173229;4319.805608747614;4321.178975994551;4293.785310734466;4309.965608254012;4340.761258130801;4342.5874541918465;4343.196508645895;4278.229918614648;4311.956880431203;4326.113146804897;4337.219300525904;4341.435613370258;4194.706370554078;4233.609308570144;4344.848615116996;4347.891302717426;4351.303791393362;3769.9057523561855;3781.8865434037025;3790.2040571480024;3793.791341476218;3796.468494410785;5450.373207081197;5455.618106732531;5469.535089517396;5497.972510137463;5503.229547863302;4882.731449770261;4901.387326584177;4971.353724015891;4990.326305948687;5015.197568389077;5802.419758024206;5818.5345172386105;5862.50168735658;5897.911531327033;5913.467787899067;4168.24971505129;4169.145325208325;4194.475690538683;4198.1393814268;4203.285441474926;5714.399988001283;6078.817635470943;6082.8783424331705;6088.269407671063;6119.60222585526;4237.766922819213;4239.957600424018;4244.87265382039;4282.186384586918;4286.507051689034;4282.550332215073;4295.5060168080445;4319.719218250803;4329.155814616182;4338.82644694215;4765.594924431392;4978.655762943985;4990;4993.875153121201;5008.974955125201;5828.737706803204;5893.852653683693;5910.852228694231;5934.940650593525;5944.651862514369;1441.0561082490985;1465.6335916020994;1466.3767898643248;1467.992660036693;1471.4702707025463;936.3819878879907;936.5738588942015;998.4159266828841;1011.610529945976;1013.4020927652721;5605.7197140142825;5623.803166889221;5624.91562626561;5716.456936591017;5770.278715160605;6029.8191054268445;6123;6132.724027418777;6162.5378096642935;6164.5684802064325;5569.359523654751;5603.795184035452;5655.406182350876;5692.48767610917;5755.568332375088;3191.2714628991876;3193.792403493812;3211.7912335698106;3230.935381292361;3231.4506533889294;6012.39876012404;6137.263528376534;6164.845878853064;6182.1345011698395;6189.597676151036;6093.664848433379;6097.237845269341;6113.57204995655;6116.113163591343;6118.388161183846;5812;6142.907856382158;6173.8456538586;6177.505799536027;6183.567150299526;5830.2129212555765;5971.566823962305;5977.910331344946;5998.400159983967;6015.1278064681255;5895.20414744004;5896.8820623586425;5920.555958303231;5929.517620594851;5957.3744756799915;5995.700214989146;6105.14527966094;6156.661383623944;6169.2288463942;6177.660228687465;4161.334186530141;4191.958080419156;4210.705250632549;4214.915701686011;4242.469691288589;5839.649621022752;5894.941050589439;5934.970325148347;5986.521078313812;6091.299500557316;5830.4461076197695;5883.646981181143;5902.1441890926435;5912.49743771767;5947.31605865331;5694.259746232963;5863.648181109147;5891.882162356815;5899.876044624018;5972.880542389041;5755.942440575541;5805.680687562056;5810.331811841692;5812.111063904333;5816.76732930678;5903.793367232126;5911.3201981772645;5923.763049477972;5925.377835327401;5967.8209653710455;5588.658721906794;5719.455746948218;5727.713614319351;5744.540436765133;5759.971200143972 05:59:52 INFO - PROCESS | 27371 | |5;yui.html;716.5843810589855;734.313416955147;754.5208792416813;792.2671528835826;815.1155995744618;14533.200673962929;14838;14937;14945.551633451001;15308.387664493435;15083.622909427242;15316;15338.616534586641;15365.385384584602;15367.69264614707;667.5727534378002;782.5539442517738;797.8444203380343;809.3767798794925;811.7158994351988;799.2646764976236;807.1847434091551;807.5195258821021;810.509641666789;810.9918900810975;834.8288600836844;844.3456321350941;845.8266055458647;847.0470720439506;847.902491213509;833.2708879730236;833.7998880268722;833.8332333533317;834.1616675241404;834.3033566971586;614.1034090228228;614.4070971512512;614.5544480251826;616.2820314333841;617.043582447205;14449.49426770058;14454.132752034806;14457.060291081047;14490.85509144916;14554.636134096627;14249.572512824529;15046.924765376103;15228.923855380763;15599.532014039596;15615.765763513557;12394;12555.560555380609;12581.056420768478;12622.55821046259;12673.93663031679;3907.9448548891924;3937.0944682722848;3972.423998520227;4021.77880216588;4081.7142800004012;72369;72921.63539182323;75274.24725752672;75503.62248188778;76416.23583764146;11644.825327620092;11739.295642261492;11799.52801887915;11825.881741182478;11872.881271187178;22322.441938951655;22492.100315987176;22971;22977.7702222979;23011.194608188634;8535.487870727777;8624.482531048157;8643.781094527363;8696.478211307342;8799.12008799115;4492.258777301774;4661.463931647836;4727.598154156935;4758.666893317434;4858.854234372974;3453.240287136826;3524.1894364296354;3587.210813620999;3595.6404359563835;3600;587.5945597537685;592.8103007037793;602.3013304566682;614.1494030767419;626.2516293029786;728.8724473217165;729.390958549617;732.3299181249204;749.7600767754375;760.9201033891472;9116.225120864668;9206.90793092074;9744.951275243578;9781.755456113655;9789.951050244703;715.742332760206;727.788941207044;736.2379936765423;745.7725393754957;754.7018927523598;4494.797734101973;4558.49856515783;4596.149712303235;4596.563326483979;4655.604273636711;66293;94875;109879.45060274648;113938;117820;58503.4149658498;75292;107814.46092769486;107843;107891.46054269679;77006.61496692481;77615.22384776192;87844.12155878487;94546.5272673646;95984;9622.326437149331;9820.65627703027;9848.901510984799;9939.751506212402;10159.796804064024;49729.75135124446;50203.49796501988;51210.48789512057;53018.73490632676;54450;54498;68574.65712671605;69898.30101698918;70373.64813175901;71308.64345678239;12520.373981301082;12869.485220591072;13024;13024.934875325564;13196.736065278832;13683.384247709077;13697.520586779416;13756.65608359759;14014;14453.205073721047;13789.379477923718;13807.723845523235;14004.43982240699;14473.92763036178;14613.123212607277;12687.746245075232;12843.35783210817;13078.476860925457;13110.147840390344;13363.799543007057;13109.541166059142;13297.667558310734;13769.931150344184;13867.65330866696;13932.233727145105;11553.653390398302;11680.415979200836;11792.823107653221;11935.880641193824;12059.457324420247;11713.941430292794;11825.731290237907;11942.16404851652;11990.460429280878;11992.700182495508 05:59:52 INFO - PROCESS | 27371 | __end_tp_report 05:59:52 INFO - PROCESS | 27371 | __start_cc_report 05:59:52 INFO - PROCESS | 27371 | _x_x_mozilla_cycle_collect,345 05:59:52 INFO - PROCESS | 27371 | __end_cc_report 05:59:52 INFO - PROCESS | 27371 | __startTimestamp1466773192808__endTimestamp 05:59:52 INFO - PROCESS | 27371 | 05:59:52 INFO - PROCESS | 27371 | ------- Summary: start ------- 05:59:52 INFO - PROCESS | 27371 | Number of tests: 6 05:59:52 INFO - PROCESS | 27371 | 05:59:52 INFO - PROCESS | 27371 | [#0] dojo.html Cycles:165 Average:5529.29 Median:5713.23 stddev:623.95 (10.9%) stddev-sans-first:596.29 05:59:52 INFO - PROCESS | 27371 | Values: 3109.9 3173.0 3176.6 3210.6 3222.6 5526.7 5546.3 5572.9 5616.4 5622.4 5367.9 5569.4 5631.9 5634.4 5712.3 5004.8 5021.4 5064.1 5149.8 5162.2 5034.7 5237.4 5261.7 5267.6 5277.4 5049.2 5063.5 5139.3 5168.8 5242.0 5084.0 5092.7 5100.9 5117.8 5136.3 5058.2 5077.1 5094.6 5101.1 5129.2 5419.5 5424.1 5438.6 5503.5 5627.8 5901.1 5909.4 5909.6 5921.0 5935.7 5995.0 5995.4 5999.3 6006.1 6006.2 5449.6 5501.6 5533.1 5555.6 5573.1 6041.9 6049.9 6057.8 6059.7 6076.9 5706.1 5805.5 5806.9 5812.4 5825.4 5843.0 5927.4 5956.8 5971.2 5973.9 5672.2 5856.4 5905.9 5939.0 5949.8 5906.5 5953.6 5957.6 5973.0 6014.9 4407.7 4489.4 4562.9 4588.1 4601.3 4058.1 4058.8 4072.4 4108.3 4114.3 5576.0 5713.2 5734.9 5740.9 5760.3 5963.1 6020.3 6020.5 6053.2 6053.4 5722.5 5740.4 5746.7 5750.3 5766.5 5016.1 5106.0 5162.5 5167.8 5172.9 6145.6 6202.6 6216.5 6233.6 6235.8 5937.0 6035.4 6040.2 6049.2 6056.7 5955.9 6120.1 6131.0 6183.1 6197.9 5848.1 5851.1 5852.4 5862.8 5871.1 5953.5 5963.9 5976.9 6000.4 6017.9 5556.1 5704.2 5757.0 5779.4 5823.5 5572.6 5653.7 5680.0 5706.0 5746.4 5677.4 5694.3 5706.9 5708.9 5720.7 5518.2 5800.1 5812.0 5823.9 5845.7 5690.8 5710.0 5710.7 5733.8 5735.7 05:59:52 INFO - PROCESS | 27371 | 05:59:52 INFO - PROCESS | 27371 | [#1] ext.html Cycles:180 Average:57024.93 Median:40382.39 stddev:115508.59 (286.0%) stddev-sans-first:115754.85 05:59:52 INFO - PROCESS | 27371 | Values: 567.3 620.7 624.1 636.6 652.8 38581.4 40703.8 41062.0 41428.0 41478.8 42170.4 42845.4 42983.0 42985.6 43027.4 8594.4 8722.3 8725.3 8726.3 8745.3 8661.0 8687.4 8744.7 8807.4 8815.8 8801.4 8847.2 8879.2 8882.6 8887.7 8790.5 8811.5 8827.2 8830.0 8871.7 8753.7 8767.7 8782.8 8792.5 8833.3 40316.4 40713.8 40753.6 40810.0 40834.6 3703.0 3740.5 3822.6 3840.7 4287.9 29780.0 30608.5 30626.7 30810.2 31235.4 4384.0 4394.9 4451.0 4537.8 4596.4 324826.0 325109.0 327411.0 328212.0 328371.4 34217.3 57781.0 58492.0 58492.4 58762.4 34741.0 36336.8 36562.0 36674.6 36725.3 14781.1 15024.8 15029.4 15033.9 15054.2 12233.9 12309.9 12430.8 12436.5 12500.4 8385.5 8408.7 8414.4 8414.5 8494.4 3213.4 3240.1 3251.7 3288.9 3307.5 982.9 1028.1 1040.6 1116.4 1156.5 31148.2 31627.8 32094.7 32217.2 32468.4 1068.5 1110.3 1111.3 1130.8 1222.5 16500.3 16874.9 17184.9 17279.8 17447.8 526675.0 527098.0 532841.0 534990.0 536066.0 39711.0 39739.4 39890.0 39948.6 40077.2 1308.6 1327.5 1342.3 1355.2 1364.8 30089.5 30275.5 31111.8 31443.0 31903.4 50404.0 50501.5 50846.2 50936.0 50974.2 417311.0 420291.0 422620.0 422799.0 423483.0 27955.4 28638.9 28896.0 29007.4 29272.3 47066.0 47870.8 48108.3 48263.3 48706.8 40287.0 40700.8 40939.2 41469.4 41927.0 39573.0 39627.0 40160.0 40448.4 40845.0 39500.8 41602.0 42526.4 42569.4 44392.3 32716.2 35381.1 36074.8 37601.8 37676.6 26085.5 26440.2 27056.3 27115.5 27278.5 05:59:52 INFO - PROCESS | 27371 | 05:59:52 INFO - PROCESS | 27371 | [#2] jquery.html Cycles:180 Average:28177.09 Median:2432.05 stddev:79171.64 (3255.3%) stddev-sans-first:79366.23 05:59:52 INFO - PROCESS | 27371 | Values: 380.6 380.7 397.1 399.2 413.7 13907.5 18143.4 18265.4 19340.1 19445.7 18287.5 18391.4 18775.5 19053.2 19190.4 5436.6 5732.1 5749.5 5820.8 5864.4 5512.1 5635.9 5656.2 5676.5 5676.9 5577.3 5632.5 5649.6 5659.5 5663.3 5553.8 5661.3 5686.7 5694.3 5715.7 5020.3 5098.4 5100.2 5111.7 5125.9 22479.0 22887.8 22946.0 23029.1 23405.8 2413.7 2423.6 2440.5 2616.1 2834.3 14512.6 14861.3 14964.6 15002.6 15023.6 1861.1 1929.2 1960.9 1999.7 2036.0 76507.6 77778.0 78292.0 78829.6 78889.0 10266.6 10408.6 10705.7 10725.9 10918.3 14441.2 14673.5 14702.3 14763.3 14779.7 7891.8 8148.7 8192.1 8255.3 8295.5 7724.9 7905.3 7946.0 7999.3 8129.8 6371.7 6609.4 6630.3 6697.3 6756.5 1846.5 1851.3 1868.5 1890.3 1902.8 895.7 967.4 976.2 978.4 1036.4 19317.1 19601.8 19618.8 19738.6 20045.8 970.6 1021.5 1050.1 1056.5 1082.5 10628.9 11086.2 11176.8 11250.9 11349.5 472509.0 477614.0 478558.0 484850.0 501068.0 42122.4 69847.0 71780.6 77450.0 81153.0 975.9 1017.9 1023.2 1025.7 1032.2 14562.0 17417.2 17540.9 17771.3 17936.6 36986.3 39532.0 42463.8 43194.6 43263.6 53284.7 53479.0 55104.7 57857.0 61514.4 8581.3 8845.5 8850.3 8906.3 8928.4 13254.5 14157.0 14188.3 14226.5 14282.4 12287.9 12336.8 12507.0 12601.3 12714.2 11749.6 11758.6 11903.6 11919.3 12118.7 12018.3 12174.6 12215.8 12393.0 12409.9 7501.9 7814.8 8848.3 8859.9 8935.7 11389.1 11519.3 12369.9 12381.4 12437.3 05:59:52 INFO - PROCESS | 27371 | 05:59:52 INFO - PROCESS | 27371 | [#3] mootools.html Cycles:180 Average:5938.20 Median:2627.12 stddev:3452.67 (131.4%) stddev-sans-first:3445.44 05:59:52 INFO - PROCESS | 27371 | Values: 1390.4 1446.0 1540.6 1735.5 1742.5 7926.1 8495.7 8521.7 9146.8 9150.1 8935.1 8951.2 9025.5 9062.3 9072.6 2310.5 2328.3 2341.7 2344.2 2351.9 2295.4 2349.9 2414.4 2421.1 2421.1 2350.6 2362.3 2366.0 2399.4 2408.3 2294.5 2299.9 2306.0 2306.1 2352.2 2285.7 2294.0 2295.4 2301.0 2301.3 9023.4 9072.8 9097.9 9103.3 9129.1 5294.8 5300.6 5375.5 5410.8 5433.9 3402.5 3413.9 3428.5 3498.4 3535.6 1117.9 1131.2 1164.5 1177.1 1186.3 12757.7 12786.5 12789.6 12809.9 12827.1 4797.1 4821.0 4918.5 4936.0 4952.3 10756.5 10771.4 10801.9 10806.4 10844.1 5296.8 5316.1 5319.3 5321.8 5329.1 4322.9 4872.7 4997.4 5009.2 5030.2 4084.9 4097.8 4126.7 4154.9 4197.0 1273.6 1305.6 1307.8 1313.8 1320.4 889.8 925.6 946.1 973.3 991.2 5651.9 5672.5 5696.1 5795.0 6029.2 430.5 437.5 438.6 455.1 457.1 4092.0 4115.1 4129.9 4139.0 4150.7 10924.7 11418.5 11494.3 11500.9 11520.2 11280.1 11328.5 11372.7 11380.1 11385.4 8333.2 8355.1 8485.4 8548.0 8574.6 5541.4 5562.5 5714.5 5749.0 5919.9 10298.3 10334.5 10415.6 10469.5 10537.3 10277.3 10483.7 10541.4 10771.1 10805.9 7226.8 7814.5 8096.7 8133.0 8232.9 8944.5 8975.4 8981.1 9019.3 9055.5 7805.1 7870.4 7932.4 7966.2 8017.2 7768.9 7800.8 7822.5 7887.9 7898.4 7152.7 7227.2 7236.2 7237.8 7248.9 5313.1 5333.4 5369.4 5399.1 5414.5 4960.6 5370.2 5425.8 5437.2 5445.3 05:59:52 INFO - PROCESS | 27371 | 05:59:52 INFO - PROCESS | 27371 | [#4] prototype.html Cycles:180 Average:4927.92 Median:5696.57 stddev:1461.52 (25.7%) stddev-sans-first:1424.17 05:59:52 INFO - PROCESS | 27371 | Values: 323.7 328.6 330.0 332.3 336.1 5666.5 5724.5 5727.6 5732.2 5748.2 5629.5 5640.9 5655.9 5683.5 5698.9 4162.8 4210.2 4314.6 4319.8 4321.2 4293.8 4310.0 4340.8 4342.6 4343.2 4278.2 4312.0 4326.1 4337.2 4341.4 4194.7 4233.6 4344.8 4347.9 4351.3 3769.9 3781.9 3790.2 3793.8 3796.5 5450.4 5455.6 5469.5 5498.0 5503.2 4882.7 4901.4 4971.4 4990.3 5015.2 5802.4 5818.5 5862.5 5897.9 5913.5 4168.2 4169.1 4194.5 4198.1 4203.3 5714.4 6078.8 6082.9 6088.3 6119.6 4237.8 4240.0 4244.9 4282.2 4286.5 4282.6 4295.5 4319.7 4329.2 4338.8 4765.6 4978.7 4990.0 4993.9 5009.0 5828.7 5893.9 5910.9 5934.9 5944.7 1441.1 1465.6 1466.4 1468.0 1471.5 936.4 936.6 998.4 1011.6 1013.4 5605.7 5623.8 5624.9 5716.5 5770.3 6029.8 6123.0 6132.7 6162.5 6164.6 5569.4 5603.8 5655.4 5692.5 5755.6 3191.3 3193.8 3211.8 3230.9 3231.5 6012.4 6137.3 6164.8 6182.1 6189.6 6093.7 6097.2 6113.6 6116.1 6118.4 5812.0 6142.9 6173.8 6177.5 6183.6 5830.2 5971.6 5977.9 5998.4 6015.1 5895.2 5896.9 5920.6 5929.5 5957.4 5995.7 6105.1 6156.7 6169.2 6177.7 4161.3 4192.0 4210.7 4214.9 4242.5 5839.6 5894.9 5935.0 5986.5 6091.3 5830.4 5883.6 5902.1 5912.5 5947.3 5694.3 5863.6 5891.9 5899.9 5972.9 5755.9 5805.7 5810.3 5812.1 5816.8 5903.8 5911.3 5923.8 5925.4 5967.8 5588.7 5719.5 5727.7 5744.5 5760.0 05:59:52 INFO - PROCESS | 27371 | 05:59:52 INFO - PROCESS | 27371 | [#5] yui.html Cycles:180 Average:20044.65 Median:4596.36 stddev:28145.88 (612.4%) stddev-sans-first:28187.42 05:59:52 INFO - PROCESS | 27371 | Values: 716.6 734.3 754.5 792.3 815.1 14533.2 14838.0 14937.0 14945.6 15308.4 15083.6 15316.0 15338.6 15365.4 15367.7 667.6 782.6 797.8 809.4 811.7 799.3 807.2 807.5 810.5 811.0 834.8 844.3 845.8 847.0 847.9 833.3 833.8 833.8 834.2 834.3 614.1 614.4 614.6 616.3 617.0 14449.5 14454.1 14457.1 14490.9 14554.6 14249.6 15046.9 15228.9 15599.5 15615.8 12394.0 12555.6 12581.1 12622.6 12673.9 3907.9 3937.1 3972.4 4021.8 4081.7 72369.0 72921.6 75274.2 75503.6 76416.2 11644.8 11739.3 11799.5 11825.9 11872.9 22322.4 22492.1 22971.0 22977.8 23011.2 8535.5 8624.5 8643.8 8696.5 8799.1 4492.3 4661.5 4727.6 4758.7 4858.9 3453.2 3524.2 3587.2 3595.6 3600.0 587.6 592.8 602.3 614.1 626.3 728.9 729.4 732.3 749.8 760.9 9116.2 9206.9 9745.0 9781.8 9790.0 715.7 727.8 736.2 745.8 754.7 4494.8 4558.5 4596.1 4596.6 4655.6 66293.0 94875.0 109879.5 113938.0 117820.0 58503.4 75292.0 107814.5 107843.0 107891.5 77006.6 77615.2 87844.1 94546.5 95984.0 9622.3 9820.7 9848.9 9939.8 10159.8 49729.8 50203.5 51210.5 53018.7 54450.0 54498.0 68574.7 69898.3 70373.6 71308.6 12520.4 12869.5 13024.0 13024.9 13196.7 13683.4 13697.5 13756.7 14014.0 14453.2 13789.4 13807.7 14004.4 14473.9 14613.1 12687.7 12843.4 13078.5 13110.1 13363.8 13109.5 13297.7 13769.9 13867.7 13932.2 11553.7 11680.4 11792.8 11935.9 12059.5 11713.9 11825.7 11942.2 11990.5 11992.7 05:59:52 INFO - PROCESS | 27371 | -------- Summary: end -------- 05:59:52 INFO - PROCESS | 27371 | 05:59:53 INFO - TEST-INFO | 27371: exit 0 05:59:53 INFO - TEST-OK | dromaeo_css | took 1111687ms 05:59:53 INFO - TEST-START | kraken 05:59:53 INFO - operating with platform_type : linux_ 05:59:53 INFO - Initialising browser for kraken test... 05:59:53 INFO - TEST-INFO | started process 27605 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjx8SUD/profile http://localhost:36625/getInfo.html) 05:59:58 INFO - PROCESS | 27605 | __metrics Screen width/height:1600/1200 05:59:58 INFO - PROCESS | 27605 | colorDepth:24 05:59:58 INFO - PROCESS | 27605 | Browser inner width/height: 1024/697 05:59:58 INFO - PROCESS | 27605 | __metrics 05:59:58 ERROR - PROCESS | 27605 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 05:59:59 INFO - TEST-INFO | 27605: exit 0 05:59:59 INFO - Browser initialized. 05:59:59 INFO - Running cycle 1/1 for kraken test... 05:59:59 INFO - TEST-INFO | started process 27725 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjx8SUD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:00:11 INFO - PROCESS | 27725 | RSS: Main: 184635392 06:00:11 INFO - PROCESS | 27725 | 06:00:14 INFO - PROCESS | 27725 | Cycle 1(1): loaded http://localhost:36625/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36625/tests/kraken/driver.html?testName=audio-beat-detection) 06:00:15 INFO - PROCESS | 27725 | RSS: Main: 190377984 06:00:15 INFO - PROCESS | 27725 | 06:00:17 INFO - PROCESS | 27725 | Cycle 1(1): loaded http://localhost:36625/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36625/tests/kraken/driver.html?testName=audio-dft) 06:00:18 INFO - PROCESS | 27725 | RSS: Main: 189521920 06:00:18 INFO - PROCESS | 27725 | 06:00:21 INFO - PROCESS | 27725 | Cycle 1(1): loaded http://localhost:36625/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36625/tests/kraken/driver.html?testName=audio-fft) 06:00:21 INFO - PROCESS | 27725 | RSS: Main: 183914496 06:00:21 INFO - PROCESS | 27725 | 06:00:24 INFO - PROCESS | 27725 | Cycle 1(1): loaded http://localhost:36625/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36625/tests/kraken/driver.html?testName=audio-oscillator) 06:00:24 INFO - PROCESS | 27725 | RSS: Main: 184754176 06:00:24 INFO - PROCESS | 27725 | 06:00:26 INFO - PROCESS | 27725 | Cycle 1(1): loaded http://localhost:36625/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36625/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:00:27 INFO - PROCESS | 27725 | RSS: Main: 185683968 06:00:27 INFO - PROCESS | 27725 | 06:00:30 INFO - PROCESS | 27725 | Cycle 1(1): loaded http://localhost:36625/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36625/tests/kraken/driver.html?testName=imaging-darkroom) 06:00:31 INFO - PROCESS | 27725 | RSS: Main: 185765888 06:00:31 INFO - PROCESS | 27725 | 06:00:34 INFO - PROCESS | 27725 | Cycle 1(1): loaded http://localhost:36625/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36625/tests/kraken/driver.html?testName=imaging-desaturate) 06:00:35 INFO - PROCESS | 27725 | RSS: Main: 183451648 06:00:35 INFO - PROCESS | 27725 | 06:00:38 INFO - PROCESS | 27725 | Cycle 1(1): loaded http://localhost:36625/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36625/tests/kraken/driver.html?testName=json-parse-financial) 06:00:38 INFO - PROCESS | 27725 | RSS: Main: 185012224 06:00:38 INFO - PROCESS | 27725 | 06:00:40 INFO - PROCESS | 27725 | Cycle 1(1): loaded http://localhost:36625/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36625/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:00:40 INFO - PROCESS | 27725 | RSS: Main: 185020416 06:00:40 INFO - PROCESS | 27725 | 06:00:42 INFO - PROCESS | 27725 | Cycle 1(1): loaded http://localhost:36625/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36625/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:00:43 INFO - PROCESS | 27725 | RSS: Main: 185024512 06:00:43 INFO - PROCESS | 27725 | 06:00:45 INFO - PROCESS | 27725 | Cycle 1(1): loaded http://localhost:36625/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36625/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:00:46 INFO - PROCESS | 27725 | RSS: Main: 186277888 06:00:46 INFO - PROCESS | 27725 | 06:00:48 INFO - PROCESS | 27725 | Cycle 1(1): loaded http://localhost:36625/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36625/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:00:49 INFO - PROCESS | 27725 | RSS: Main: 185954304 06:00:49 INFO - PROCESS | 27725 | 06:00:52 INFO - PROCESS | 27725 | Cycle 1(1): loaded http://localhost:36625/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36625/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:00:52 INFO - PROCESS | 27725 | RSS: Main: 185958400 06:00:52 INFO - PROCESS | 27725 | 06:00:54 INFO - PROCESS | 27725 | Cycle 1(1): loaded http://localhost:36625/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36625/tests/kraken/driver.html?testName=ai-astar) 06:00:54 INFO - PROCESS | 27725 | RSS: Main: 187355136 06:00:54 INFO - PROCESS | 27725 | 06:00:54 INFO - PROCESS | 27725 | __start_tp_report 06:00:54 INFO - PROCESS | 27725 | _x_x_mozilla_page_load 06:00:54 INFO - PROCESS | 27725 | _x_x_mozilla_page_load_details 06:00:54 INFO - PROCESS | 27725 | |i|pagename|runs| 06:00:54 INFO - PROCESS | 27725 | |0;ai-astar;104;114;106;111;113;112;115;113;113;111 06:00:54 INFO - PROCESS | 27725 | |1;audio-beat-detection;157;127;158;186;127;154;150;130;184;126 06:00:54 INFO - PROCESS | 27725 | |2;audio-dft;162;165;163;164;166;175;162;163;163;161 06:00:54 INFO - PROCESS | 27725 | |3;audio-fft;76;75;75;149;76;76;77;76;161;77 06:00:54 INFO - PROCESS | 27725 | |4;audio-oscillator;85;86;149;87;86;85;142;85;85;144 06:00:54 INFO - PROCESS | 27725 | |5;imaging-gaussian-blur;117;117;117;118;119;117;118;117;117;118 06:00:54 INFO - PROCESS | 27725 | |6;imaging-darkroom;147;146;148;147;149;147;147;147;147;147 06:00:54 INFO - PROCESS | 27725 | |7;imaging-desaturate;95;98;96;95;97;96;96;96;96;96 06:00:54 INFO - PROCESS | 27725 | |8;json-parse-financial;54;57;57;55;54;56;54;55;54;54 06:00:54 INFO - PROCESS | 27725 | |9;json-stringify-tinderbox;64;63;62;63;62;62;61;62;62;62 06:00:54 INFO - PROCESS | 27725 | |10;stanford-crypto-aes;80;81;79;80;80;81;86;79;93;81 06:00:54 INFO - PROCESS | 27725 | |11;stanford-crypto-ccm;138;120;137;120;128;131;123;138;128;134 06:00:54 INFO - PROCESS | 27725 | |12;stanford-crypto-pbkdf2;162;163;163;159;167;159;162;164;173;165 06:00:54 INFO - PROCESS | 27725 | |13;stanford-crypto-sha256-iterative;64;71;67;62;63;63;63;63;67;64 06:00:54 INFO - PROCESS | 27725 | __end_tp_report 06:00:54 INFO - PROCESS | 27725 | __start_cc_report 06:00:54 INFO - PROCESS | 27725 | _x_x_mozilla_cycle_collect,895 06:00:54 INFO - PROCESS | 27725 | __end_cc_report 06:00:54 INFO - PROCESS | 27725 | __startTimestamp1466773254628__endTimestamp 06:00:54 INFO - PROCESS | 27725 | 06:00:54 INFO - PROCESS | 27725 | ------- Summary: start ------- 06:00:54 INFO - PROCESS | 27725 | Number of tests: 14 06:00:54 INFO - PROCESS | 27725 | 06:00:54 INFO - PROCESS | 27725 | [#0] ai-astar Cycles:10 Average:111.20 Median:113.00 stddev:3.52 (3.1%) stddev-sans-first:2.60 06:00:54 INFO - PROCESS | 27725 | Values: 104.0 114.0 106.0 111.0 113.0 112.0 115.0 113.0 113.0 111.0 06:00:54 INFO - PROCESS | 27725 | 06:00:54 INFO - PROCESS | 27725 | [#1] audio-beat-detection Cycles:10 Average:149.90 Median:155.50 stddev:22.64 (14.6%) stddev-sans-first:23.87 06:00:54 INFO - PROCESS | 27725 | Values: 157.0 127.0 158.0 186.0 127.0 154.0 150.0 130.0 184.0 126.0 06:00:54 INFO - PROCESS | 27725 | 06:00:54 INFO - PROCESS | 27725 | [#2] audio-dft Cycles:10 Average:164.40 Median:163.50 stddev:4.01 (2.4%) stddev-sans-first:4.15 06:00:54 INFO - PROCESS | 27725 | Values: 162.0 165.0 163.0 164.0 166.0 175.0 162.0 163.0 163.0 161.0 06:00:54 INFO - PROCESS | 27725 | 06:00:54 INFO - PROCESS | 27725 | [#3] audio-fft Cycles:10 Average:91.80 Median:76.00 stddev:33.44 (44.0%) stddev-sans-first:34.97 06:00:54 INFO - PROCESS | 27725 | Values: 76.0 75.0 75.0 149.0 76.0 76.0 77.0 76.0 161.0 77.0 06:00:54 INFO - PROCESS | 27725 | 06:00:54 INFO - PROCESS | 27725 | [#4] audio-oscillator Cycles:10 Average:103.40 Median:85.00 stddev:28.76 (33.8%) stddev-sans-first:29.73 06:00:54 INFO - PROCESS | 27725 | Values: 85.0 86.0 149.0 87.0 86.0 85.0 142.0 85.0 85.0 144.0 06:00:54 INFO - PROCESS | 27725 | 06:00:54 INFO - PROCESS | 27725 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:117.50 stddev:0.71 (0.6%) stddev-sans-first:0.73 06:00:54 INFO - PROCESS | 27725 | Values: 117.0 117.0 117.0 118.0 119.0 117.0 118.0 117.0 117.0 118.0 06:00:54 INFO - PROCESS | 27725 | 06:00:54 INFO - PROCESS | 27725 | [#6] imaging-darkroom Cycles:10 Average:147.20 Median:147.00 stddev:0.79 (0.5%) stddev-sans-first:0.83 06:00:54 INFO - PROCESS | 27725 | Values: 147.0 146.0 148.0 147.0 149.0 147.0 147.0 147.0 147.0 147.0 06:00:54 INFO - PROCESS | 27725 | 06:00:54 INFO - PROCESS | 27725 | [#7] imaging-desaturate Cycles:10 Average:96.10 Median:96.00 stddev:0.88 (0.9%) stddev-sans-first:0.83 06:00:54 INFO - PROCESS | 27725 | Values: 95.0 98.0 96.0 95.0 97.0 96.0 96.0 96.0 96.0 96.0 06:00:54 INFO - PROCESS | 27725 | 06:00:54 INFO - PROCESS | 27725 | [#8] json-parse-financial Cycles:10 Average:55.00 Median:55.00 stddev:1.25 (2.3%) stddev-sans-first:1.27 06:00:54 INFO - PROCESS | 27725 | Values: 54.0 57.0 57.0 55.0 54.0 56.0 54.0 55.0 54.0 54.0 06:00:54 INFO - PROCESS | 27725 | 06:00:54 INFO - PROCESS | 27725 | [#9] json-stringify-tinderbox Cycles:10 Average:62.30 Median:62.00 stddev:0.82 (1.3%) stddev-sans-first:0.60 06:00:54 INFO - PROCESS | 27725 | Values: 64.0 63.0 62.0 63.0 62.0 62.0 61.0 62.0 62.0 62.0 06:00:54 INFO - PROCESS | 27725 | 06:00:54 INFO - PROCESS | 27725 | [#10] stanford-crypto-aes Cycles:10 Average:82.00 Median:81.00 stddev:4.35 (5.4%) stddev-sans-first:4.55 06:00:54 INFO - PROCESS | 27725 | Values: 80.0 81.0 79.0 80.0 80.0 81.0 86.0 79.0 93.0 81.0 06:00:54 INFO - PROCESS | 27725 | 06:00:54 INFO - PROCESS | 27725 | [#11] stanford-crypto-ccm Cycles:10 Average:129.70 Median:132.50 stddev:7.07 (5.3%) stddev-sans-first:6.83 06:00:54 INFO - PROCESS | 27725 | Values: 138.0 120.0 137.0 120.0 128.0 131.0 123.0 138.0 128.0 134.0 06:00:54 INFO - PROCESS | 27725 | 06:00:54 INFO - PROCESS | 27725 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.70 Median:163.50 stddev:4.08 (2.5%) stddev-sans-first:4.28 06:00:54 INFO - PROCESS | 27725 | Values: 162.0 163.0 163.0 159.0 167.0 159.0 162.0 164.0 173.0 165.0 06:00:54 INFO - PROCESS | 27725 | 06:00:54 INFO - PROCESS | 27725 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.70 Median:64.00 stddev:2.79 (4.4%) stddev-sans-first:2.95 06:00:54 INFO - PROCESS | 27725 | Values: 64.0 71.0 67.0 62.0 63.0 63.0 63.0 63.0 67.0 64.0 06:00:54 INFO - PROCESS | 27725 | -------- Summary: end -------- 06:00:54 INFO - PROCESS | 27725 | 06:00:55 INFO - TEST-INFO | 27725: exit 0 06:00:55 INFO - TEST-OK | kraken | took 62074ms 06:00:55 INFO - SUITE-END | took 1173s 06:00:55 INFO - Completed test suite (00:19:33) 06:00:55 INFO - javascript benchmark 06:00:55 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7267.715786139869, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3109.8600562974666, 3172.9524057139147, 3176.6188057433096, 3210.566573512578, 3222.645508994012, 5526.723663816808, 5546.278983732119, 5572.888542229153, 5616.382197958226, 5622.381538030813, 5367.913449766381, 5569.415211402805, 5631.915521267174, 5634.4365563443735, 5712.285964254468, 5004.799808007684, 5021.397432308128, 5064.063148317573, 5149.845504634848, 5162.22566615007, 5034.697918124906, 5237.397699264595, 5261.736913154346, 5267.604929630274, 5277.366715994086, 5049.242613607951, 5063.54428101469, 5139.331886854722, 5168.793248270064, 5242.0, 5084.0, 5092.719900405476, 5100.872478188038, 5117.769700363493, 5136.332276804029, 5058.190689489664, 5077.136886729265, 5094.6433749637545, 5101.081805275049, 5129.153689641204, 5419.512243898068, 5424.0779067558215, 5438.619296649236, 5503.532199762985, 5627.831165065014, 5901.0558310670085, 5909.438603332676, 5909.6158749681135, 5921.0, 5935.673537955411, 5994.97002514989, 5995.430434108753, 5999.250093738283, 6006.069059295816, 6006.159137720722, 5449.5640348772, 5501.559875209973, 5533.08704063829, 5555.555555555546, 5573.136163894603, 6041.909371359346, 6049.879002419927, 6057.757689692451, 6059.697015149225, 6076.939230607637, 5706.058500347396, 5805.506531944748, 5806.854828629318, 5812.447817457335, 5825.446582574648, 5843.03589907669, 5927.407259274124, 5956.791512297049, 5971.164037034819, 5973.850653733692, 5672.234248376499, 5856.355800861902, 5905.940940590625, 5938.970305148447, 5949.791757288474, 5906.49794767441, 5953.613015154001, 5957.6127551709, 5973.0, 6014.879702406015, 4407.713498622579, 4489.393931819228, 4562.908741825211, 4588.128255631419, 4601.28680054592, 4058.127502586958, 4058.7564746114735, 4072.4095006223934, 4108.342665173558, 4114.300568903293, 5575.972120139373, 5713.228714123623, 5734.856628584319, 5740.885182296331, 5760.251167348301, 5963.135345374896, 6020.307664618625, 6020.488258497989, 6053.152558641794, 6053.3946605339115, 5722.54219662426, 5740.368559458456, 5746.683932383676, 5750.338711048283, 5766.538676905838, 5016.122178618727, 5106.029854327666, 5162.53537181648, 5167.793288268427, 5172.8965420691375, 6145.5698101133385, 6202.5658203925295, 6216.502679785606, 6233.594816336924, 6235.781747638902, 5936.981426315074, 6035.36628653985, 6040.184575082483, 6049.243844519435, 6056.727447264796, 5955.91066134017, 6120.081455037999, 6131.049687298476, 6183.103449999815, 6197.876042479035, 5848.093545500455, 5851.093080572518, 5852.4147585241135, 5862.824115276549, 5871.089981052944, 5953.493953013869, 5963.850903727442, 5976.910346344721, 6000.369961154016, 6017.879642407215, 5556.138798486241, 5704.2014118024335, 5757.0, 5779.393163717918, 5823.475887170175, 5572.582056345709, 5653.745581448927, 5680.0, 5705.971470142623, 5746.367899531132, 5677.3754886963225, 5694.259746232963, 5706.942930570807, 5708.914366284426, 5720.74256658443, 5518.19986102021, 5800.1299805029585, 5812.041013232938, 5823.912641310469, 5845.736941837713, 5690.77236910519, 5709.9714501427225, 5710.685912274865, 5733.770649173986, 5735.713214339183], "value": 5487.067669269365, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [567.2738894215403, 620.7454943473174, 624.0639041437843, 636.6053047110792, 652.7650045983448, 38581.421278680806, 40703.79648101763, 41062.0, 41427.964300892454, 41478.792606036965, 42170.36744448836, 42845.357319640156, 42983.0, 42985.570144298545, 43027.35458968118, 8594.398392112571, 8722.258608018326, 8725.301975841918, 8726.258268047191, 8745.300375969939, 8661.0, 8687.435316704426, 8744.693935712252, 8807.427517211361, 8815.823683526325, 8801.427907186044, 8847.159519845636, 8879.245264152554, 8882.555872206363, 8887.68893088742, 8790.472571645721, 8811.471311721318, 8827.205551500363, 8829.95585022074, 8871.689490867788, 8753.737387878375, 8767.693130740394, 8782.780430489289, 8792.516411597424, 8833.33749968755, 40316.39525407092, 40713.79643101795, 40753.59246407557, 40810.0, 40834.59165408338, 3703.0, 3740.476333313311, 3822.57951625321, 3840.692744580455, 4287.892802679927, 29780.0, 30608.54087188694, 30626.693733062606, 30810.22974425635, 31235.375292494024, 4384.0, 4394.8901277468, 4451.0, 4537.77311134442, 4596.3794887690065, 324826.0, 325109.0, 327411.0, 328212.0, 328371.3581432101, 34217.31565368679, 57781.0, 58492.0, 58492.415075848694, 58762.41237587655, 34741.0, 36336.818315908255, 36562.0, 36674.63325366766, 36725.26549468996, 14781.113133212042, 15024.849751502563, 15029.398824047134, 15033.924830375998, 15054.172020538976, 12233.877661223452, 12309.876901231051, 12430.813537796941, 12436.502539898303, 12500.374981250901, 8385.496870187808, 8408.663653453916, 8414.443327984343, 8414.49513029208, 8494.405391622528, 3213.4376484115655, 3240.09277402323, 3251.7236034937296, 3288.9342213156083, 3307.5038744188564, 982.886967998675, 1028.1106842581114, 1040.557762950758, 1116.3748300951493, 1156.4969238381163, 31148.221294467367, 31627.841860790548, 32094.67905320917, 32217.194570135933, 32468.350632987207, 1068.4566957281463, 1110.272771334777, 1111.3387534417009, 1130.7964566377966, 1222.49877550204, 16500.33998640065, 16874.91562542204, 17184.914075429544, 17279.827201728072, 17447.82552174462, 526675.0, 527098.0, 532841.0, 534990.0, 536066.0, 39710.999999999425, 39739.403908941385, 39890.0, 39948.60051399507, 40077.19845603072, 1308.5943357558997, 1327.5353626230935, 1342.275171407429, 1355.1868878672717, 1364.8498665146826, 30089.548656770603, 30275.545866811575, 31111.84444077765, 31443.0, 31903.361932760752, 50404.0, 50501.49498504968, 50846.23730644117, 50936.0, 50974.235386469976, 417311.0, 420291.0, 422620.0, 422799.0, 423483.0, 27955.440891181657, 28638.856805715837, 28896.0, 29007.419851602426, 29272.26819329534, 47066.0, 47870.76064619655, 48108.27837582369, 48263.27605085856, 48706.75646621744, 40287.0, 40700.796496017334, 40939.18121637491, 41469.37795933003, 41927.0, 39573.0, 39627.0, 40160.0, 40448.39327410032, 40845.0, 39500.80249598734, 41602.0, 42526.362104569074, 42569.36145957875, 44392.33411498766, 32716.182095447803, 35381.115472112375, 36074.819625901706, 37601.811990939874, 37676.623233768405, 26085.478290433704, 26440.206793796217, 27056.32359191036, 27115.457690845677, 27278.527069190317], "value": 18538.98863656909, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [380.57755890961045, 380.69354169893245, 397.1322659987926, 399.1537939568115, 413.68146527174076, 13907.513237036706, 18143.36498222559, 18265.36071237507, 19340.129694163763, 19445.70831437528, 18287.54281142972, 18391.448256552292, 18775.53061173468, 19053.237870485198, 19190.424287271406, 5436.646617969839, 5732.111522713986, 5749.453801888814, 5820.825375238728, 5864.413558644144, 5512.118061110224, 5635.943640563603, 5656.151577263402, 5676.545876329905, 5676.858078548028, 5577.274954255941, 5632.464915832989, 5649.604527683064, 5659.490645841874, 5663.348714897798, 5553.805616803413, 5661.348944871352, 5686.687232202227, 5694.316681998145, 5715.657060576337, 5020.347354843847, 5098.362704661918, 5100.183970564692, 5111.744412779383, 5125.871853203663, 22479.0, 22887.77112228873, 22946.0, 23029.078836846507, 23405.765942340528, 2413.686220791286, 2423.6243382275597, 2440.475297810979, 2616.1105224223666, 2834.3480999370054, 14512.637184070378, 14861.256937153099, 14964.625884352869, 15002.62493437662, 15023.624409389744, 1861.1345724238295, 1929.1897403090595, 1960.9117589708496, 1999.6900480425556, 2035.9592808143902, 76507.61746191289, 77778.0, 78292.0, 78829.60585197038, 78889.0, 10266.589336426608, 10408.5836566538, 10705.732356690989, 10725.946370268099, 10918.344899306067, 14441.205733684537, 14673.486427975184, 14702.338394772261, 14763.261836908112, 14779.704405912036, 7891.802704932423, 8148.674053037812, 8192.098869124391, 8255.339572834158, 8295.4653389122, 7724.922750772533, 7905.288524032865, 7946.006749156356, 7999.280064794197, 8129.796755081052, 6371.745130194833, 6609.372109649576, 6630.336966303331, 6697.330266973264, 6756.459483241329, 1846.4737549798513, 1851.278001579385, 1868.4962150718104, 1890.2722451856134, 1902.8097190281137, 895.7133717210561, 967.3615413826841, 976.1702552830179, 978.4422878958925, 1036.3937096798306, 19317.130729117223, 19601.80398196028, 19618.803811961698, 19738.60522789565, 20045.799542004686, 970.6360114956891, 1021.5147804792664, 1050.0916707048348, 1056.498163372392, 1082.5453309609982, 10628.893711062945, 11086.16853735973, 11176.776464470666, 11250.887491124984, 11349.489272982735, 472509.0, 477614.0, 478558.0, 484850.0, 501068.0, 42122.36816447756, 69847.0, 71780.64109679418, 77450.0, 81153.0, 975.9414435133915, 1017.898210178991, 1023.2428003277521, 1025.7179275699243, 1032.2052019944601, 14562.0, 17417.216225270146, 17540.947543147453, 17771.289148433916, 17936.551586210448, 36986.26027479489, 39532.0, 42463.787681061396, 43194.568054319054, 43263.56736432721, 53284.73357633187, 53479.0, 55104.72447637736, 57857.0, 61514.384856150864, 8581.2705919995, 8845.51349675774, 8850.291976641982, 8906.332025098014, 8928.419652722552, 13254.469821207043, 14157.0, 14188.290585470479, 14226.502072427415, 14282.42870285177, 12287.93856030714, 12336.75326493483, 12507.0, 12601.306928118674, 12714.173578717353, 11749.647510574696, 11758.58844940423, 11903.583374581847, 11919.284842909454, 12118.697032574257, 12018.278903265833, 12174.57388991381, 12215.816762748744, 12393.0, 12409.93795031019, 7501.88747168782, 7814.804629884298, 8848.292136629183, 8859.867101993346, 8935.687250946186, 11389.088872890314, 11519.30884146954, 12369.93815030919, 12381.442835072623, 12437.315947622968], "value": 9307.810582473976, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1390.3534856291826, 1446.016708638126, 1540.6379500817307, 1735.5053809664241, 1742.5295170304025, 7926.128125906146, 8495.745127646165, 8521.659133634656, 9146.817063658722, 9150.130737579928, 8935.06181850906, 8951.194392504673, 9025.458472491639, 9062.275017998561, 9072.63709451621, 2310.5378924215183, 2328.3247858121126, 2341.6652508070406, 2344.2146880794953, 2351.9176828810996, 2295.3687735872686, 2349.906003759856, 2414.396400899775, 2421.0678888627917, 2421.1041914491575, 2350.576896158691, 2362.29131260622, 2366.0, 2399.3881560202126, 2408.2534414331612, 2294.506681063571, 2299.908003679851, 2305.953880922389, 2306.1006207579057, 2352.1649814316015, 2285.725712914444, 2294.0365046680436, 2295.3802473332275, 2301.0, 2301.3096071178747, 9023.368364214508, 9072.77318067047, 9097.863532047024, 9103.317251206186, 9129.132732390479, 5294.814681486129, 5300.628955973083, 5375.489328513785, 5410.810621628263, 5433.891322173574, 3402.4726167444087, 3413.9146521336916, 3428.4857271409237, 3498.4402495600834, 3535.575730912307, 1117.8602674665667, 1131.1685910855515, 1164.4643464006567, 1177.0818761366147, 1186.2645160000768, 12757.74484510314, 12786.488540458371, 12789.552365667158, 12809.871901280962, 12827.102102852805, 4797.088553174885, 4820.975895120502, 4918.508149185053, 4936.0, 4952.331435256267, 10756.515956781963, 10771.407572583583, 10801.945990269998, 10806.405647689295, 10844.078253348554, 5296.788128474895, 5316.149416093406, 5319.335083114611, 5321.840344789585, 5329.067413202674, 4322.8703138905885, 4872.683275587146, 4997.400311962515, 5009.223570346602, 5030.245463180479, 4084.8978775530254, 4097.7746223957965, 4126.681369335021, 4154.937675934863, 4196.979015104905, 1273.6433798536425, 1305.6083175047447, 1307.7972914198315, 1313.7897936330141, 1320.4322141479256, 889.7508697564692, 925.6442354208556, 946.1342871272708, 973.2749101919115, 991.2218908157206, 5651.886962260732, 5672.489475947102, 5696.11710184922, 5794.985877471426, 6029.155918171459, 430.46622188486054, 437.5318409302016, 438.6052552702593, 455.06938311153107, 457.14970155510724, 4092.038370982876, 4115.135821477464, 4129.938050929239, 4139.0, 4150.688698347636, 10924.726881828017, 11418.486168122454, 11494.252873563191, 11500.94249528747, 11520.193586448868, 11280.097592192606, 11328.546858125583, 11372.715682108013, 11380.089592832554, 11385.373804440835, 8333.16668333174, 8355.080941096474, 8485.40602157843, 8547.95726021366, 8574.614142363609, 5541.3904470507405, 5562.471565201299, 5714.514266287412, 5749.022666146849, 5919.91120133207, 10298.330608510423, 10334.5349459273, 10415.583376665152, 10469.476526173508, 10537.315074520131, 10277.331973421704, 10483.737906552093, 10541.367517948947, 10771.138308935424, 10805.945970270099, 7226.819329516804, 7814.452988290993, 8096.7166149184495, 8132.959335203286, 8232.876506852283, 8944.463332200088, 8975.371723979259, 8981.14679105484, 9019.323550733852, 9055.456672599665, 7805.102413222552, 7870.409719270963, 7932.444728868923, 7966.203379661987, 8017.238362355567, 7768.873513340647, 7800.765977020698, 7822.491538050009, 7887.881681774663, 7898.407619428681, 7152.749653762094, 7227.168875579166, 7236.240194779472, 7237.819054523679, 7248.927510724825, 5313.070212712837, 5333.386660533933, 5369.436209197978, 5399.082156033405, 5414.539764120094, 4960.553550180501, 5370.194470829407, 5425.755840987086, 5437.211604317431, 5445.346558413015], "value": 4638.6623989517275, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [323.6536905511103, 328.6434218872523, 329.9884504042359, 332.2772968792876, 336.1445122164091, 5666.461686139815, 5724.456176663216, 5727.599068065237, 5732.2261494698205, 5748.223989761381, 5629.521490673287, 5640.943590564093, 5655.943440565593, 5683.5169010634045, 5698.886022279552, 4162.771047592389, 4210.179015092058, 4314.633256173229, 4319.805608747614, 4321.178975994551, 4293.785310734466, 4309.965608254012, 4340.761258130801, 4342.5874541918465, 4343.196508645895, 4278.229918614648, 4311.956880431203, 4326.113146804897, 4337.219300525904, 4341.435613370258, 4194.706370554078, 4233.609308570144, 4344.848615116996, 4347.891302717426, 4351.303791393362, 3769.9057523561855, 3781.8865434037025, 3790.2040571480024, 3793.791341476218, 3796.468494410785, 5450.373207081197, 5455.618106732531, 5469.535089517396, 5497.972510137463, 5503.229547863302, 4882.731449770261, 4901.387326584177, 4971.353724015891, 4990.326305948687, 5015.197568389077, 5802.419758024206, 5818.5345172386105, 5862.50168735658, 5897.911531327033, 5913.467787899067, 4168.24971505129, 4169.145325208325, 4194.475690538683, 4198.1393814268, 4203.285441474926, 5714.399988001283, 6078.817635470943, 6082.8783424331705, 6088.269407671063, 6119.60222585526, 4237.766922819213, 4239.957600424018, 4244.87265382039, 4282.186384586918, 4286.507051689034, 4282.550332215073, 4295.5060168080445, 4319.719218250803, 4329.155814616182, 4338.82644694215, 4765.594924431392, 4978.655762943985, 4990.0, 4993.875153121201, 5008.974955125201, 5828.737706803204, 5893.852653683693, 5910.852228694231, 5934.940650593525, 5944.651862514369, 1441.0561082490985, 1465.6335916020994, 1466.3767898643248, 1467.992660036693, 1471.4702707025463, 936.3819878879907, 936.5738588942015, 998.4159266828841, 1011.610529945976, 1013.4020927652721, 5605.7197140142825, 5623.803166889221, 5624.91562626561, 5716.456936591017, 5770.278715160605, 6029.8191054268445, 6123.0, 6132.724027418777, 6162.5378096642935, 6164.5684802064325, 5569.359523654751, 5603.795184035452, 5655.406182350876, 5692.48767610917, 5755.568332375088, 3191.2714628991876, 3193.792403493812, 3211.7912335698106, 3230.935381292361, 3231.4506533889294, 6012.39876012404, 6137.263528376534, 6164.845878853064, 6182.1345011698395, 6189.597676151036, 6093.664848433379, 6097.237845269341, 6113.57204995655, 6116.113163591343, 6118.388161183846, 5812.0, 6142.907856382158, 6173.8456538586, 6177.505799536027, 6183.567150299526, 5830.2129212555765, 5971.566823962305, 5977.910331344946, 5998.400159983967, 6015.1278064681255, 5895.20414744004, 5896.8820623586425, 5920.555958303231, 5929.517620594851, 5957.3744756799915, 5995.700214989146, 6105.14527966094, 6156.661383623944, 6169.2288463942, 6177.660228687465, 4161.334186530141, 4191.958080419156, 4210.705250632549, 4214.915701686011, 4242.469691288589, 5839.649621022752, 5894.941050589439, 5934.970325148347, 5986.521078313812, 6091.299500557316, 5830.4461076197695, 5883.646981181143, 5902.1441890926435, 5912.49743771767, 5947.31605865331, 5694.259746232963, 5863.648181109147, 5891.882162356815, 5899.876044624018, 5972.880542389041, 5755.942440575541, 5805.680687562056, 5810.331811841692, 5812.111063904333, 5816.76732930678, 5903.793367232126, 5911.3201981772645, 5923.763049477972, 5925.377835327401, 5967.8209653710455, 5588.658721906794, 5719.455746948218, 5727.713614319351, 5744.540436765133, 5759.971200143972], "value": 4453.491644067873, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [716.5843810589855, 734.313416955147, 754.5208792416813, 792.2671528835826, 815.1155995744618, 14533.200673962929, 14838.0, 14937.0, 14945.551633451001, 15308.387664493435, 15083.622909427242, 15316.0, 15338.616534586641, 15365.385384584602, 15367.69264614707, 667.5727534378002, 782.5539442517738, 797.8444203380343, 809.3767798794925, 811.7158994351988, 799.2646764976236, 807.1847434091551, 807.5195258821021, 810.509641666789, 810.9918900810975, 834.8288600836844, 844.3456321350941, 845.8266055458647, 847.0470720439506, 847.902491213509, 833.2708879730236, 833.7998880268722, 833.8332333533317, 834.1616675241404, 834.3033566971586, 614.1034090228228, 614.4070971512512, 614.5544480251826, 616.2820314333841, 617.043582447205, 14449.49426770058, 14454.132752034806, 14457.060291081047, 14490.85509144916, 14554.636134096627, 14249.572512824529, 15046.924765376103, 15228.923855380763, 15599.532014039596, 15615.765763513557, 12394.0, 12555.560555380609, 12581.056420768478, 12622.55821046259, 12673.93663031679, 3907.9448548891924, 3937.0944682722848, 3972.423998520227, 4021.77880216588, 4081.7142800004012, 72369.0, 72921.63539182323, 75274.24725752672, 75503.62248188778, 76416.23583764146, 11644.825327620092, 11739.295642261492, 11799.52801887915, 11825.881741182478, 11872.881271187178, 22322.441938951655, 22492.100315987176, 22971.0, 22977.7702222979, 23011.194608188634, 8535.487870727777, 8624.482531048157, 8643.781094527363, 8696.478211307342, 8799.12008799115, 4492.258777301774, 4661.463931647836, 4727.598154156935, 4758.666893317434, 4858.854234372974, 3453.240287136826, 3524.1894364296354, 3587.210813620999, 3595.6404359563835, 3600.0, 587.5945597537685, 592.8103007037793, 602.3013304566682, 614.1494030767419, 626.2516293029786, 728.8724473217165, 729.390958549617, 732.3299181249204, 749.7600767754375, 760.9201033891472, 9116.225120864668, 9206.90793092074, 9744.951275243578, 9781.755456113655, 9789.951050244703, 715.742332760206, 727.788941207044, 736.2379936765423, 745.7725393754957, 754.7018927523598, 4494.797734101973, 4558.49856515783, 4596.149712303235, 4596.563326483979, 4655.604273636711, 66293.0, 94875.0, 109879.45060274648, 113938.0, 117820.0, 58503.4149658498, 75292.0, 107814.46092769486, 107843.0, 107891.46054269679, 77006.61496692481, 77615.22384776192, 87844.12155878487, 94546.5272673646, 95984.0, 9622.326437149331, 9820.65627703027, 9848.901510984799, 9939.751506212402, 10159.796804064024, 49729.75135124446, 50203.49796501988, 51210.48789512057, 53018.73490632676, 54450.0, 54498.0, 68574.65712671605, 69898.30101698918, 70373.64813175901, 71308.64345678239, 12520.373981301082, 12869.485220591072, 13024.0, 13024.934875325564, 13196.736065278832, 13683.384247709077, 13697.520586779416, 13756.65608359759, 14014.0, 14453.205073721047, 13789.379477923718, 13807.723845523235, 14004.43982240699, 14473.92763036178, 14613.123212607277, 12687.746245075232, 12843.35783210817, 13078.476860925457, 13110.147840390344, 13363.799543007057, 13109.541166059142, 13297.667558310734, 13769.931150344184, 13867.65330866696, 13932.233727145105, 11553.653390398302, 11680.415979200836, 11792.823107653221, 11935.880641193824, 12059.457324420247, 11713.941430292794, 11825.731290237907, 11942.16404851652, 11990.460429280878, 11992.700182495508], "value": 7533.2232228649045, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1538.9, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 114.0, 106.0, 111.0, 113.0, 112.0, 115.0, 113.0, 113.0, 111.0], "value": 111.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 127.0, 158.0, 186.0, 127.0, 154.0, 150.0, 130.0, 184.0, 126.0], "value": 149.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 165.0, 163.0, 164.0, 166.0, 175.0, 162.0, 163.0, 163.0, 161.0], "value": 164.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 75.0, 149.0, 76.0, 76.0, 77.0, 76.0, 161.0, 77.0], "value": 91.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 149.0, 87.0, 86.0, 85.0, 142.0, 85.0, 85.0, 144.0], "value": 103.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 118.0, 119.0, 117.0, 118.0, 117.0, 117.0, 118.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 148.0, 147.0, 149.0, 147.0, 147.0, 147.0, 147.0, 147.0], "value": 147.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 98.0, 96.0, 95.0, 97.0, 96.0, 96.0, 96.0, 96.0, 96.0], "value": 96.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 57.0, 57.0, 55.0, 54.0, 56.0, 54.0, 55.0, 54.0, 54.0], "value": 55.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 62.0, 63.0, 62.0, 62.0, 61.0, 62.0, 62.0, 62.0], "value": 62.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 81.0, 79.0, 80.0, 80.0, 81.0, 86.0, 79.0, 93.0, 81.0], "value": 82.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 120.0, 137.0, 120.0, 128.0, 131.0, 123.0, 138.0, 128.0, 134.0], "value": 129.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 163.0, 159.0, 167.0, 159.0, 162.0, 164.0, 173.0, 165.0], "value": 163.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 71.0, 67.0, 62.0, 63.0, 63.0, 63.0, 63.0, 67.0, 64.0], "value": 64.7, "unit": "score"}]}]} 06:00:55 INFO - Return code: 0 06:00:55 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:00:55 ERROR - # TBPL SUCCESS # 06:00:55 INFO - Running post-action listener: _resource_record_post_action 06:00:55 INFO - ##### 06:00:55 INFO - ##### Finished run-tests step (success) 06:00:55 INFO - ##### 06:00:55 INFO - Running post-run listener: _resource_record_post_run 06:00:56 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 4096; Write bytes: 550907904; Read time: 8; Write time: 615772 06:00:56 INFO - TinderboxPrint: CPU usage
13.4% 06:00:56 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 06:00:56 INFO - TinderboxPrint: I/O write bytes / time
550,907,904 / 615,772 06:00:56 INFO - TinderboxPrint: CPU idle
8,229.7 (86.6%) 06:00:56 INFO - TinderboxPrint: CPU user
1,217.7 (12.8%) 06:00:56 INFO - TinderboxPrint: Swap in / out
0 / 0 06:00:56 INFO - install - Wall time: 17s; CPU: 15.0%; Read bytes: 0; Write bytes: 256327680; Read time: 0; Write time: 331520 06:00:56 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 4096; Write bytes: 294580224; Read time: 8; Write time: 284252 06:00:56 INFO - Running post-run listener: _upload_blobber_files 06:00:56 INFO - Blob upload gear active. 06:00:56 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:00:56 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 06:00:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:00:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:00:56 INFO - (blobuploader) - INFO - Open directory for files ... 06:00:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 06:00:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:00:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:00:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 06:00:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:00:57 INFO - (blobuploader) - INFO - Done attempting. 06:00:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 06:00:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:00:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:00:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 06:00:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:00:58 INFO - (blobuploader) - INFO - Done attempting. 06:00:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:00:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:00:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:01:02 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:01:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:01:02 INFO - (blobuploader) - INFO - Done attempting. 06:01:02 INFO - (blobuploader) - INFO - Iteration through files over. 06:01:02 INFO - Return code: 0 06:01:02 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:01:02 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:01:02 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/688bad485e25a93c23d1b804b8a62482128b84084a31fbfb25de67d75a073dfbc8d9929e7b216e091237eac9db996a4ab7139a60f2d3cbdc1febaf3b925e5b13", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/133a914c94b952d5699279b2913a5440b72439b3c610469788db40af08d1126d6a5599f2cab84a7933f0f6574894d4f29cc73f69eee2304c67ad881d87515eb5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2e3884d2241ea7e28fcb6f7b53476fd27042f02cc7c57daf2556c7964ab2ae6ac2597e7afa7f2cab10e809e2300a43463eff86913a32c24f72bdc7ecc0c9dfe2"} 06:01:02 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:01:02 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:01:02 INFO - Contents: 06:01:02 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/688bad485e25a93c23d1b804b8a62482128b84084a31fbfb25de67d75a073dfbc8d9929e7b216e091237eac9db996a4ab7139a60f2d3cbdc1febaf3b925e5b13", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/133a914c94b952d5699279b2913a5440b72439b3c610469788db40af08d1126d6a5599f2cab84a7933f0f6574894d4f29cc73f69eee2304c67ad881d87515eb5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2e3884d2241ea7e28fcb6f7b53476fd27042f02cc7c57daf2556c7964ab2ae6ac2597e7afa7f2cab10e809e2300a43463eff86913a32c24f72bdc7ecc0c9dfe2"} 06:01:02 INFO - Running post-run listener: copy_logs_to_upload_dir 06:01:02 INFO - Copying logs to upload dir... 06:01:02 INFO - mkdir: /builds/slave/test/build/upload/logs 06:01:02 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.536643 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-06-24 06:01:01.388881) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-24 06:01:01.392499) ========= 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=fa44defc139c4ba8574fe040000001db-1466772025.399715-407914977 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/688bad485e25a93c23d1b804b8a62482128b84084a31fbfb25de67d75a073dfbc8d9929e7b216e091237eac9db996a4ab7139a60f2d3cbdc1febaf3b925e5b13", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/133a914c94b952d5699279b2913a5440b72439b3c610469788db40af08d1126d6a5599f2cab84a7933f0f6574894d4f29cc73f69eee2304c67ad881d87515eb5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2e3884d2241ea7e28fcb6f7b53476fd27042f02cc7c57daf2556c7964ab2ae6ac2597e7afa7f2cab10e809e2300a43463eff86913a32c24f72bdc7ecc0c9dfe2"} build_url:https://queue.taskcluster.net/v1/task/H5xSstgaRQ6-mUGxW0l7yQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011396 build_url: 'https://queue.taskcluster.net/v1/task/H5xSstgaRQ6-mUGxW0l7yQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/688bad485e25a93c23d1b804b8a62482128b84084a31fbfb25de67d75a073dfbc8d9929e7b216e091237eac9db996a4ab7139a60f2d3cbdc1febaf3b925e5b13", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/133a914c94b952d5699279b2913a5440b72439b3c610469788db40af08d1126d6a5599f2cab84a7933f0f6574894d4f29cc73f69eee2304c67ad881d87515eb5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2e3884d2241ea7e28fcb6f7b53476fd27042f02cc7c57daf2556c7964ab2ae6ac2597e7afa7f2cab10e809e2300a43463eff86913a32c24f72bdc7ecc0c9dfe2"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-24 06:01:01.418504) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 06:01:01.418903) ========= 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=fa44defc139c4ba8574fe040000001db-1466772025.399715-407914977 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004497 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 06:01:01.504667) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-24 06:01:01.505100) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-24 06:01:01.505471) ========= ========= Total master_lag: 0.18 =========