builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-053 starttime: 1465470605.58 results: success (0) buildid: 20160609025931 builduid: b264b20b80e14011904513992015937d revision: cb493102af8a50946ac601a86cc3d076703faa57 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-09 04:10:05.582983) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-09 04:10:05.583435) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-09 04:10:05.583734) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-09 04:10:05.621261) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 04:10:05.621551) ========= 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=920470bf432669ad7e3a5387000001ca-1465468442.500350-1997601859 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-09 04:10:06-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.1M=0s 2016-06-09 04:10:06 (46.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.265260 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 04:10:05.900313) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 04:10:05.900602) ========= 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=920470bf432669ad7e3a5387000001ca-1465468442.500350-1997601859 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014948 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 04:10:05.950920) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-09 04:10:05.951302) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev cb493102af8a50946ac601a86cc3d076703faa57 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev cb493102af8a50946ac601a86cc3d076703faa57 --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=920470bf432669ad7e3a5387000001ca-1465468442.500350-1997601859 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-09 04:10:06,627 truncating revision to first 12 chars 2016-06-09 04:10:06,627 Setting DEBUG logging. 2016-06-09 04:10:06,627 attempt 1/10 2016-06-09 04:10:06,627 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/cb493102af8a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-09 04:10:07,540 unpacking tar archive at: mozilla-central-cb493102af8a/testing/mozharness/ program finished with exit code 0 elapsedTime=1.259278 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-09 04:10:07.223862) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-09 04:10:07.224171) ========= script_repo_revision: cb493102af8a50946ac601a86cc3d076703faa57 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-09 04:10:07.224587) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-09 04:10:07.224870) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-09 04:10:07.234968) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2016-06-09 04:10:07.235257) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=920470bf432669ad7e3a5387000001ca-1465468442.500350-1997601859 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:10:07 INFO - MultiFileLogger online at 20160609 04:10:07 in /builds/slave/test 04:10:07 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 04:10:07 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:10:07 INFO - {'append_to_log': False, 04:10:07 INFO - 'base_work_dir': '/builds/slave/test', 04:10:07 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 04:10:07 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:10:07 INFO - 'branch': 'Firefox-Non-PGO', 04:10:07 INFO - 'buildbot_json_path': 'buildprops.json', 04:10:07 INFO - 'config_files': ('talos/linux_config.py',), 04:10:07 INFO - 'default_actions': ('clobber', 04:10:07 INFO - 'read-buildbot-config', 04:10:07 INFO - 'download-and-extract', 04:10:07 INFO - 'populate-webroot', 04:10:07 INFO - 'create-virtualenv', 04:10:07 INFO - 'install', 04:10:07 INFO - 'run-tests'), 04:10:07 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:10:07 INFO - 'download_minidump_stackwalk': True, 04:10:07 INFO - 'download_symbols': 'ondemand', 04:10:07 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:10:07 INFO - 'tooltool.py': '/tools/tooltool.py', 04:10:07 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:10:07 INFO - '/tools/misc-python/virtualenv.py')}, 04:10:07 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:10:07 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:10:07 INFO - 'installer_path': 'installer.exe', 04:10:07 INFO - 'log_level': 'info', 04:10:07 INFO - 'log_name': 'talos', 04:10:07 INFO - 'log_to_console': True, 04:10:07 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:10:07 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:10:07 INFO - 'opt_config_files': (), 04:10:07 INFO - 'pip_index': False, 04:10:07 INFO - 'sps_profile': False, 04:10:07 INFO - 'sps_profile_interval': 0, 04:10:07 INFO - 'suite': 'dromaeojs', 04:10:07 INFO - 'system_bits': '32', 04:10:07 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:10:07 INFO - 'title': 'talos-linux64-ix-053', 04:10:07 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:10:07 INFO - 'use_talos_json': True, 04:10:07 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:10:07 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:10:07 INFO - 'work_dir': 'build'} 04:10:07 INFO - ##### 04:10:07 INFO - ##### Running clobber step. 04:10:07 INFO - ##### 04:10:07 INFO - Running pre-action listener: _resource_record_pre_action 04:10:07 INFO - Running main action method: clobber 04:10:07 INFO - rmtree: /builds/slave/test/build 04:10:08 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:10:08 INFO - Running post-action listener: _resource_record_post_action 04:10:08 INFO - ##### 04:10:08 INFO - ##### Finished clobber step (success) 04:10:08 INFO - ##### 04:10:08 INFO - ##### 04:10:08 INFO - ##### Running read-buildbot-config step. 04:10:08 INFO - ##### 04:10:08 INFO - Running pre-action listener: _resource_record_pre_action 04:10:08 INFO - Running main action method: read_buildbot_config 04:10:08 INFO - Using buildbot properties: 04:10:08 INFO - { 04:10:08 INFO - "project": "", 04:10:08 INFO - "product": "firefox", 04:10:08 INFO - "script_repo_revision": "production", 04:10:08 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 04:10:08 INFO - "repository": "", 04:10:08 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 04:10:08 INFO - "buildid": "20160609025931", 04:10:08 INFO - "pgo_build": "False", 04:10:08 INFO - "basedir": "/builds/slave/test", 04:10:08 INFO - "buildnumber": 524, 04:10:08 INFO - "slavename": "talos-linux64-ix-053", 04:10:08 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 04:10:08 INFO - "platform": "ubuntu64_hw", 04:10:08 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 04:10:08 INFO - "branch": "mozilla-central", 04:10:08 INFO - "repo_path": "mozilla-central", 04:10:08 INFO - "revision": "cb493102af8a50946ac601a86cc3d076703faa57", 04:10:08 INFO - "stage_platform": "linux64", 04:10:08 INFO - "builduid": "b264b20b80e14011904513992015937d", 04:10:08 INFO - "slavebuilddir": "test" 04:10:08 INFO - } 04:10:08 INFO - Found installer url https://queue.taskcluster.net/v1/task/dGeUCIvaTC-yhn-fZQ-qbA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 04:10:08 INFO - Running post-action listener: _resource_record_post_action 04:10:08 INFO - ##### 04:10:08 INFO - ##### Finished read-buildbot-config step (success) 04:10:08 INFO - ##### 04:10:08 INFO - ##### 04:10:08 INFO - ##### Running download-and-extract step. 04:10:08 INFO - ##### 04:10:08 INFO - Running pre-action listener: _resource_record_pre_action 04:10:08 INFO - Running main action method: download_and_extract 04:10:08 INFO - mkdir: /builds/slave/test/build/tests 04:10:08 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')]} 04:10:08 INFO - https://queue.taskcluster.net/v1/task/dGeUCIvaTC-yhn-fZQ-qbA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 04:10:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dGeUCIvaTC-yhn-fZQ-qbA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:10:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dGeUCIvaTC-yhn-fZQ-qbA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:10:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dGeUCIvaTC-yhn-fZQ-qbA/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 04:10:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dGeUCIvaTC-yhn-fZQ-qbA/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 04:10:14 INFO - Downloaded 1361 bytes. 04:10:14 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:10:14 INFO - Using the following test package requirements: 04:10:14 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 04:10:14 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:10:14 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:10:14 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:10:14 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:10:14 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:10:14 INFO - u'jsshell-linux-x86_64.zip'], 04:10:14 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:10:14 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:10:14 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 04:10:14 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:10:14 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:10:14 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:10:14 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:10:14 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:10:14 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:10:14 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:10:14 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:10:14 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:10:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:10:14 INFO - https://queue.taskcluster.net/v1/task/dGeUCIvaTC-yhn-fZQ-qbA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:10:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dGeUCIvaTC-yhn-fZQ-qbA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:10:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dGeUCIvaTC-yhn-fZQ-qbA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:10:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dGeUCIvaTC-yhn-fZQ-qbA/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 04:10:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dGeUCIvaTC-yhn-fZQ-qbA/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 04:10:15 INFO - Downloaded 22879571 bytes. 04:10:15 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'] 04:10:15 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 04:10:17 INFO - Return code: 0 04:10:17 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 04:10:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 04:10:17 INFO - https://queue.taskcluster.net/v1/task/dGeUCIvaTC-yhn-fZQ-qbA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:10:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dGeUCIvaTC-yhn-fZQ-qbA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:10:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dGeUCIvaTC-yhn-fZQ-qbA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:10:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dGeUCIvaTC-yhn-fZQ-qbA/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 04:10:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dGeUCIvaTC-yhn-fZQ-qbA/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 04:10:20 INFO - Downloaded 22879571 bytes. 04:10:20 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:10:20 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 04:10:22 INFO - Return code: 0 04:10:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 04:10:22 INFO - https://queue.taskcluster.net/v1/task/dGeUCIvaTC-yhn-fZQ-qbA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:10:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dGeUCIvaTC-yhn-fZQ-qbA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 04:10:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dGeUCIvaTC-yhn-fZQ-qbA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 04:10:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dGeUCIvaTC-yhn-fZQ-qbA/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 04:10:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dGeUCIvaTC-yhn-fZQ-qbA/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 04:10:23 INFO - Downloaded 10833377 bytes. 04:10:23 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'] 04:10:23 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 04:10:23 INFO - Return code: 0 04:10:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 04:10:23 INFO - https://queue.taskcluster.net/v1/task/dGeUCIvaTC-yhn-fZQ-qbA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:10:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dGeUCIvaTC-yhn-fZQ-qbA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:10:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dGeUCIvaTC-yhn-fZQ-qbA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:10:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dGeUCIvaTC-yhn-fZQ-qbA/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 04:10:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dGeUCIvaTC-yhn-fZQ-qbA/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 04:10:25 INFO - Downloaded 55435697 bytes. 04:10:25 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dGeUCIvaTC-yhn-fZQ-qbA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:10:25 INFO - mkdir: /builds/slave/test/properties 04:10:25 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:10:25 INFO - Writing to file /builds/slave/test/properties/build_url 04:10:25 INFO - Contents: 04:10:25 INFO - build_url:https://queue.taskcluster.net/v1/task/dGeUCIvaTC-yhn-fZQ-qbA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:10:25 INFO - Running post-action listener: _resource_record_post_action 04:10:25 INFO - Running post-action listener: set_extra_try_arguments 04:10:25 INFO - ##### 04:10:25 INFO - ##### Finished download-and-extract step (success) 04:10:25 INFO - ##### 04:10:25 INFO - ##### 04:10:25 INFO - ##### Running populate-webroot step. 04:10:25 INFO - ##### 04:10:25 INFO - Running pre-action listener: _resource_record_pre_action 04:10:25 INFO - Running main action method: populate_webroot 04:10:25 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:10:25 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:10:25 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:10:25 INFO - '--tppagecycles', 04:10:25 INFO - '7'], 04:10:25 INFO - 'tests': ['tsvgm']}}, 04:10:25 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:10:25 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:10:25 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:10:25 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:10:25 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:10:25 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:10:25 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:10:25 INFO - 'talos_options': ['--disable-e10s'], 04:10:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:10:25 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:10:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:10:25 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:10:25 INFO - 'talos_options': ['--disable-e10s'], 04:10:25 INFO - 'tests': ['damp', 'tps']}, 04:10:25 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:10:25 INFO - 'tests': ['damp', 'tps']}, 04:10:25 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:10:25 INFO - 'tests': ['dromaeo_dom']}, 04:10:25 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:10:25 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:10:25 INFO - 'tests': ['a11yr', 04:10:25 INFO - 'ts_paint', 04:10:25 INFO - 'tpaint', 04:10:25 INFO - 'sessionrestore', 04:10:25 INFO - 'sessionrestore_no_auto_restore', 04:10:25 INFO - 'tabpaint']}, 04:10:25 INFO - 'other-e10s': {'tests': ['a11yr', 04:10:25 INFO - 'ts_paint', 04:10:25 INFO - 'tpaint', 04:10:25 INFO - 'sessionrestore', 04:10:25 INFO - 'sessionrestore_no_auto_restore', 04:10:25 INFO - 'tabpaint']}, 04:10:25 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:10:25 INFO - 'ts_paint', 04:10:25 INFO - 'tpaint', 04:10:25 INFO - 'sessionrestore', 04:10:25 INFO - 'sessionrestore_no_auto_restore', 04:10:25 INFO - 'tabpaint']}, 04:10:25 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:10:25 INFO - 'ts_paint', 04:10:25 INFO - 'tpaint', 04:10:25 INFO - 'sessionrestore', 04:10:25 INFO - 'sessionrestore_no_auto_restore', 04:10:25 INFO - 'tabpaint']}, 04:10:25 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:10:25 INFO - 'tests': ['a11yr', 04:10:25 INFO - 'ts_paint', 04:10:25 INFO - 'tpaint', 04:10:25 INFO - 'sessionrestore', 04:10:25 INFO - 'sessionrestore_no_auto_restore', 04:10:25 INFO - 'tabpaint']}, 04:10:25 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:10:25 INFO - 'tests': ['a11yr', 04:10:25 INFO - 'ts_paint', 04:10:25 INFO - 'tpaint', 04:10:25 INFO - 'sessionrestore', 04:10:25 INFO - 'sessionrestore_no_auto_restore', 04:10:25 INFO - 'tabpaint']}, 04:10:25 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:10:25 INFO - 'tests': ['tsvgx', 04:10:25 INFO - 'tsvgr_opacity', 04:10:25 INFO - 'tart', 04:10:25 INFO - 'tscrollx', 04:10:25 INFO - 'cart']}, 04:10:25 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:10:25 INFO - 'tsvgr_opacity', 04:10:25 INFO - 'tart', 04:10:25 INFO - 'tscrollx', 04:10:25 INFO - 'cart']}, 04:10:25 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:10:25 INFO - 'talos_options': ['--disable-e10s'], 04:10:25 INFO - 'tests': ['tp5o']}, 04:10:25 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:10:25 INFO - 'tests': ['tp5o']}, 04:10:25 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:10:25 INFO - 'talos_options': ['--disable-e10s', 04:10:25 INFO - '--xperf_path', 04:10:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:10:25 INFO - 'tests': ['tp5n']}, 04:10:25 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:10:25 INFO - 'talos_options': ['--xperf_path', 04:10:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:10:25 INFO - 'tests': ['tp5n']}}, 04:10:25 INFO - 'talos.zip': {'path': '', 04:10:25 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:10:25 INFO - Running post-action listener: _resource_record_post_action 04:10:25 INFO - ##### 04:10:25 INFO - ##### Finished populate-webroot step (success) 04:10:25 INFO - ##### 04:10:25 INFO - ##### 04:10:25 INFO - ##### Running create-virtualenv step. 04:10:25 INFO - ##### 04:10:25 INFO - Running pre-action listener: _resource_record_pre_action 04:10:25 INFO - Running main action method: create_virtualenv 04:10:25 INFO - Creating virtualenv /builds/slave/test/build/venv 04:10:25 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 04:10:25 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:10:26 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:10:26 INFO - Using real prefix '/usr' 04:10:26 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:10:26 INFO - Installing distribute.............................................................................................................................................................................................done. 04:10:28 INFO - Installing pip.................done. 04:10:28 INFO - Return code: 0 04:10:28 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:10: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')]} 04:10:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:10:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:10: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')]} 04:10:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:10:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:10:28 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 0x7f57dcf65f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13d4020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14662e0>, '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 0x13d2140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13d25d0>, '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': '920470bf432669ad7e3a5387000001ca-1465468442.500350-1997601859', '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 04:10:28 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 04:10:28 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 04:10:28 INFO - Using env: {'DISPLAY': ':0', 04:10:28 INFO - 'HOME': '/home/cltbld', 04:10:28 INFO - 'LANG': 'en_US.UTF-8', 04:10:28 INFO - 'LANGUAGE': 'en_US:en', 04:10:28 INFO - 'LOGNAME': 'cltbld', 04:10:28 INFO - 'MAIL': '/var/mail/cltbld', 04:10:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:10:28 INFO - 'MOZ_NO_REMOTE': '1', 04:10:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:10:28 INFO - 'NO_EM_RESTART': '1', 04:10:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:10:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:10:28 INFO - 'PWD': '/builds/slave/test', 04:10:28 INFO - 'SHELL': '/bin/bash', 04:10:28 INFO - 'SHLVL': '1', 04:10:28 INFO - 'TERM': 'linux', 04:10:28 INFO - 'TMOUT': '86400', 04:10:28 INFO - 'USER': 'cltbld', 04:10:28 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1465468442.500350-1997601859', 04:10:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:10:28 INFO - '_': '/tools/buildbot/bin/python'} 04:10:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:10:28 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 04:10:28 INFO - Cleaning up... 04:10:28 INFO - Return code: 0 04:10:28 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:10: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')]} 04:10:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:10:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:10: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')]} 04:10:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:10:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:10:28 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 0x7f57dcf65f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13d4020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14662e0>, '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 0x13d2140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13d25d0>, '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': '920470bf432669ad7e3a5387000001ca-1465468442.500350-1997601859', '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 04:10:28 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 04:10:28 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 04:10:28 INFO - Using env: {'DISPLAY': ':0', 04:10:28 INFO - 'HOME': '/home/cltbld', 04:10:28 INFO - 'LANG': 'en_US.UTF-8', 04:10:28 INFO - 'LANGUAGE': 'en_US:en', 04:10:28 INFO - 'LOGNAME': 'cltbld', 04:10:28 INFO - 'MAIL': '/var/mail/cltbld', 04:10:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:10:28 INFO - 'MOZ_NO_REMOTE': '1', 04:10:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:10:28 INFO - 'NO_EM_RESTART': '1', 04:10:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:10:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:10:28 INFO - 'PWD': '/builds/slave/test', 04:10:28 INFO - 'SHELL': '/bin/bash', 04:10:28 INFO - 'SHLVL': '1', 04:10:28 INFO - 'TERM': 'linux', 04:10:28 INFO - 'TMOUT': '86400', 04:10:28 INFO - 'USER': 'cltbld', 04:10:28 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1465468442.500350-1997601859', 04:10:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:10:28 INFO - '_': '/tools/buildbot/bin/python'} 04:10:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:10:28 INFO - Downloading/unpacking psutil>=3.1.1 04:10:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:10:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:10:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:10:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:10:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:10:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:10:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:10:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:10:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:10:30 INFO - Installing collected packages: psutil 04:10:30 INFO - Running setup.py install for psutil 04:10:31 INFO - building 'psutil._psutil_linux' extension 04:10:31 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 04:10:31 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 04:10:31 INFO - building 'psutil._psutil_posix' extension 04:10:31 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 04:10:31 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 04:10:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:10:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:10:31 INFO - Successfully installed psutil 04:10:31 INFO - Cleaning up... 04:10:31 INFO - Return code: 0 04:10:31 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:10: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')]} 04:10:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:10:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:10: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')]} 04:10:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:10:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:10:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f57dcf65f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13d4020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14662e0>, '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 0x13d2140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13d25d0>, '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': '920470bf432669ad7e3a5387000001ca-1465468442.500350-1997601859', '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 04:10:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:10:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 04:10:31 INFO - Using env: {'DISPLAY': ':0', 04:10:31 INFO - 'HOME': '/home/cltbld', 04:10:31 INFO - 'LANG': 'en_US.UTF-8', 04:10:31 INFO - 'LANGUAGE': 'en_US:en', 04:10:31 INFO - 'LOGNAME': 'cltbld', 04:10:31 INFO - 'MAIL': '/var/mail/cltbld', 04:10:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:10:31 INFO - 'MOZ_NO_REMOTE': '1', 04:10:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:10:31 INFO - 'NO_EM_RESTART': '1', 04:10:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:10:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:10:31 INFO - 'PWD': '/builds/slave/test', 04:10:31 INFO - 'SHELL': '/bin/bash', 04:10:31 INFO - 'SHLVL': '1', 04:10:31 INFO - 'TERM': 'linux', 04:10:31 INFO - 'TMOUT': '86400', 04:10:31 INFO - 'USER': 'cltbld', 04:10:31 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1465468442.500350-1997601859', 04:10:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:10:31 INFO - '_': '/tools/buildbot/bin/python'} 04:10:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:10:31 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:10:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:10:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:10:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:10:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:10:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:10:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:10:33 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:10:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:10:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:10:33 INFO - Installing collected packages: mozsystemmonitor 04:10:33 INFO - Running setup.py install for mozsystemmonitor 04:10:33 INFO - Successfully installed mozsystemmonitor 04:10:33 INFO - Cleaning up... 04:10:33 INFO - Return code: 0 04:10:33 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:10:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 04:10:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:10:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:10:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 04:10:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:10:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:10:33 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 0x7f57dcf65f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13d4020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14662e0>, '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 0x13d2140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13d25d0>, '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': '920470bf432669ad7e3a5387000001ca-1465468442.500350-1997601859', '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 04:10:33 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 04:10:33 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 04:10:33 INFO - Using env: {'DISPLAY': ':0', 04:10:33 INFO - 'HOME': '/home/cltbld', 04:10:33 INFO - 'LANG': 'en_US.UTF-8', 04:10:33 INFO - 'LANGUAGE': 'en_US:en', 04:10:33 INFO - 'LOGNAME': 'cltbld', 04:10:33 INFO - 'MAIL': '/var/mail/cltbld', 04:10:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:10:33 INFO - 'MOZ_NO_REMOTE': '1', 04:10:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:10:33 INFO - 'NO_EM_RESTART': '1', 04:10:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:10:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:10:33 INFO - 'PWD': '/builds/slave/test', 04:10:33 INFO - 'SHELL': '/bin/bash', 04:10:33 INFO - 'SHLVL': '1', 04:10:33 INFO - 'TERM': 'linux', 04:10:33 INFO - 'TMOUT': '86400', 04:10:33 INFO - 'USER': 'cltbld', 04:10:33 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1465468442.500350-1997601859', 04:10:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:10:33 INFO - '_': '/tools/buildbot/bin/python'} 04:10:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:10:34 INFO - Downloading/unpacking jsonschema==2.5.1 04:10:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:10:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:10:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:10:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:10:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:10:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:10:35 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:10:35 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:10:35 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 04:10:35 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 04:10:35 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 04:10:35 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 04:10:35 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 04:10:35 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 04:10:36 INFO - Downloading functools32-3.2.3-2.tar.gz 04:10:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:10:36 INFO - warning: no files found matching '*.txt' 04:10:36 INFO - no previously-included directories found matching 'build' 04:10:36 INFO - no previously-included directories found matching 'dist' 04:10:36 INFO - no previously-included directories found matching '.git*' 04:10:36 INFO - Installing collected packages: jsonschema, functools32 04:10:36 INFO - Running setup.py install for functools32 04:10:36 INFO - warning: no files found matching '*.txt' 04:10:36 INFO - no previously-included directories found matching 'build' 04:10:36 INFO - no previously-included directories found matching 'dist' 04:10:36 INFO - no previously-included directories found matching '.git*' 04:10:36 INFO - Successfully installed jsonschema functools32 04:10:36 INFO - Cleaning up... 04:10:36 INFO - Return code: 0 04:10:36 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:10:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:10:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:10:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:10:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:10:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:10:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:10:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f57dcf65f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13d4020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14662e0>, '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 0x13d2140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13d25d0>, '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': '920470bf432669ad7e3a5387000001ca-1465468442.500350-1997601859', '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 04:10:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:10:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:10:36 INFO - Using env: {'DISPLAY': ':0', 04:10:36 INFO - 'HOME': '/home/cltbld', 04:10:36 INFO - 'LANG': 'en_US.UTF-8', 04:10:36 INFO - 'LANGUAGE': 'en_US:en', 04:10:36 INFO - 'LOGNAME': 'cltbld', 04:10:36 INFO - 'MAIL': '/var/mail/cltbld', 04:10:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:10:36 INFO - 'MOZ_NO_REMOTE': '1', 04:10:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:10:36 INFO - 'NO_EM_RESTART': '1', 04:10:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:10:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:10:36 INFO - 'PWD': '/builds/slave/test', 04:10:36 INFO - 'SHELL': '/bin/bash', 04:10:36 INFO - 'SHLVL': '1', 04:10:36 INFO - 'TERM': 'linux', 04:10:36 INFO - 'TMOUT': '86400', 04:10:36 INFO - 'USER': 'cltbld', 04:10:36 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1465468442.500350-1997601859', 04:10:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:10:36 INFO - '_': '/tools/buildbot/bin/python'} 04:10:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:10:36 INFO - Downloading/unpacking blobuploader==1.2.4 04:10:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:10:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:10:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:10:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:10:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:10:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:10:38 INFO - Downloading blobuploader-1.2.4.tar.gz 04:10:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:10:38 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:10:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:10:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:10:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:10:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:10:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:10:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:10:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:10:38 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:10:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:10:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:10:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:10:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:10:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:10:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:10:39 INFO - Downloading docopt-0.6.1.tar.gz 04:10:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:10:39 INFO - Installing collected packages: blobuploader, requests, docopt 04:10:39 INFO - Running setup.py install for blobuploader 04:10:39 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:10:39 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:10:39 INFO - Running setup.py install for requests 04:10:39 INFO - Running setup.py install for docopt 04:10:39 INFO - Successfully installed blobuploader requests docopt 04:10:39 INFO - Cleaning up... 04:10:39 INFO - Return code: 0 04:10:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:10:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:10:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:10:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:10:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:10:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:10:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:10:39 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 0x7f57dcf65f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13d4020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14662e0>, '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 0x13d2140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13d25d0>, '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': '920470bf432669ad7e3a5387000001ca-1465468442.500350-1997601859', '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 04:10:39 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 04:10:39 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 04:10:39 INFO - Using env: {'DISPLAY': ':0', 04:10:39 INFO - 'HOME': '/home/cltbld', 04:10:39 INFO - 'LANG': 'en_US.UTF-8', 04:10:39 INFO - 'LANGUAGE': 'en_US:en', 04:10:39 INFO - 'LOGNAME': 'cltbld', 04:10:39 INFO - 'MAIL': '/var/mail/cltbld', 04:10:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:10:39 INFO - 'MOZ_NO_REMOTE': '1', 04:10:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:10:39 INFO - 'NO_EM_RESTART': '1', 04:10:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:10:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:10:39 INFO - 'PWD': '/builds/slave/test', 04:10:39 INFO - 'SHELL': '/bin/bash', 04:10:39 INFO - 'SHLVL': '1', 04:10:39 INFO - 'TERM': 'linux', 04:10:39 INFO - 'TMOUT': '86400', 04:10:39 INFO - 'USER': 'cltbld', 04:10:39 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1465468442.500350-1997601859', 04:10:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:10:39 INFO - '_': '/tools/buildbot/bin/python'} 04:10:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:10:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:10:40 INFO - Running setup.py (path:/tmp/pip-je5VJQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:10:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:10:40 INFO - Running setup.py (path:/tmp/pip-4idrpI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:10:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:10:40 INFO - Running setup.py (path:/tmp/pip-ZM4Mmb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:10:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:10:40 INFO - Running setup.py (path:/tmp/pip-57FWwt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:10:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:10:40 INFO - Running setup.py (path:/tmp/pip-NUjfON-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:10:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:10:40 INFO - Running setup.py (path:/tmp/pip-aszIqv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:10:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:10:40 INFO - Running setup.py (path:/tmp/pip-hLyhgY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:10:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:10:40 INFO - Running setup.py (path:/tmp/pip-49icOX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:10:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:10:40 INFO - Running setup.py (path:/tmp/pip-RHQKu4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:10:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:10:40 INFO - Running setup.py (path:/tmp/pip-MGnVcM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:10:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:10:40 INFO - Running setup.py (path:/tmp/pip-Q2Fsm2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:10:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:10:40 INFO - Running setup.py (path:/tmp/pip-zq5_nU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:10:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:10:40 INFO - Running setup.py (path:/tmp/pip-8l3fCq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:10:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:10:41 INFO - Running setup.py (path:/tmp/pip-4PJXWQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:10:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:10:41 INFO - Running setup.py (path:/tmp/pip-JqCtuU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:10:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:10:41 INFO - Running setup.py (path:/tmp/pip-A4e_aw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:10:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:10:41 INFO - Running setup.py (path:/tmp/pip-hU9PnM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:10:41 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:10:41 INFO - Running setup.py install for manifestparser 04:10:41 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:10:41 INFO - Running setup.py install for mozcrash 04:10:41 INFO - Running setup.py install for mozdebug 04:10:41 INFO - Running setup.py install for mozdevice 04:10:41 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:10:41 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:10:41 INFO - Running setup.py install for mozfile 04:10:41 INFO - Running setup.py install for mozhttpd 04:10:41 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:10:41 INFO - Running setup.py install for mozinfo 04:10:41 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:10:41 INFO - Running setup.py install for mozInstall 04:10:42 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:10:42 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:10:42 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:10:42 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:10:42 INFO - Running setup.py install for mozleak 04:10:42 INFO - Running setup.py install for mozlog 04:10:42 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:10:42 INFO - Running setup.py install for moznetwork 04:10:42 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:10:42 INFO - Running setup.py install for mozprocess 04:10:42 INFO - Running setup.py install for mozprofile 04:10:42 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:10:42 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:10:42 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:10:42 INFO - Running setup.py install for mozrunner 04:10:42 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:10:42 INFO - Running setup.py install for mozscreenshot 04:10:42 INFO - Running setup.py install for moztest 04:10:42 INFO - Running setup.py install for mozversion 04:10:43 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:10:43 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:10:43 INFO - Cleaning up... 04:10:43 INFO - Return code: 0 04:10:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:10:43 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')]} 04:10:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:10:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:10:43 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')]} 04:10:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:10:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:10:43 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 0x7f57dcf65f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13d4020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14662e0>, '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 0x13d2140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13d25d0>, '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': '920470bf432669ad7e3a5387000001ca-1465468442.500350-1997601859', '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 04:10:43 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 04:10:43 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 04:10:43 INFO - Using env: {'DISPLAY': ':0', 04:10:43 INFO - 'HOME': '/home/cltbld', 04:10:43 INFO - 'LANG': 'en_US.UTF-8', 04:10:43 INFO - 'LANGUAGE': 'en_US:en', 04:10:43 INFO - 'LOGNAME': 'cltbld', 04:10:43 INFO - 'MAIL': '/var/mail/cltbld', 04:10:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:10:43 INFO - 'MOZ_NO_REMOTE': '1', 04:10:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:10:43 INFO - 'NO_EM_RESTART': '1', 04:10:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:10:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:10:43 INFO - 'PWD': '/builds/slave/test', 04:10:43 INFO - 'SHELL': '/bin/bash', 04:10:43 INFO - 'SHLVL': '1', 04:10:43 INFO - 'TERM': 'linux', 04:10:43 INFO - 'TMOUT': '86400', 04:10:43 INFO - 'USER': 'cltbld', 04:10:43 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1465468442.500350-1997601859', 04:10:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:10:43 INFO - '_': '/tools/buildbot/bin/python'} 04:10:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:10:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:10:43 INFO - Running setup.py (path:/tmp/pip-J5EmEH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:10:43 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)) 04:10:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:10:43 INFO - Running setup.py (path:/tmp/pip-JiEEXf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:10:43 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)) 04:10:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:10:43 INFO - Running setup.py (path:/tmp/pip-ASpKIW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:10:43 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)) 04:10:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:10:43 INFO - Running setup.py (path:/tmp/pip-YHSxyw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:10:43 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)) 04:10:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:10:43 INFO - Running setup.py (path:/tmp/pip-F8jqhZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:10:43 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)) 04:10:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:10:43 INFO - Running setup.py (path:/tmp/pip-n1Y8KR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:10:43 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)) 04:10:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:10:43 INFO - Running setup.py (path:/tmp/pip-_zRjo5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:10:43 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)) 04:10:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:10:43 INFO - Running setup.py (path:/tmp/pip-T7iIaj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:10:43 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)) 04:10:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:10:43 INFO - Running setup.py (path:/tmp/pip-f9iJ5C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:10:43 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)) 04:10:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:10:43 INFO - Running setup.py (path:/tmp/pip-rt1CgO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:10:44 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)) 04:10:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:10:44 INFO - Running setup.py (path:/tmp/pip-3i4XP5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:10:44 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)) 04:10:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:10:44 INFO - Running setup.py (path:/tmp/pip-YQBhsb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:10:44 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)) 04:10:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:10:44 INFO - Running setup.py (path:/tmp/pip-aaHmyG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:10:44 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)) 04:10:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:10:44 INFO - Running setup.py (path:/tmp/pip-CMqzin-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:10:44 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)) 04:10:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:10:44 INFO - Running setup.py (path:/tmp/pip-h1OgCm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:10:44 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)) 04:10:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:10:44 INFO - Running setup.py (path:/tmp/pip-mD3iNI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:10:44 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)) 04:10:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:10:44 INFO - Running setup.py (path:/tmp/pip-A4mxY3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:10:44 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)) 04:10:44 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)) 04:10:44 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)) 04:10:44 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)) 04:10:44 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)) 04:10:44 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)) 04:10:44 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:10: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 04:10: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 04:10: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 04:10: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 04:10: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 04:10: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 04:10:46 INFO - Downloading blessings-1.6.tar.gz 04:10:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:10:46 INFO - Installing collected packages: blessings 04:10:46 INFO - Running setup.py install for blessings 04:10:46 INFO - Successfully installed blessings 04:10:46 INFO - Cleaning up... 04:10:46 INFO - Return code: 0 04:10:46 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:10:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:10:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:10:46 INFO - Reading from file tmpfile_stdout 04:10:46 INFO - Current package versions: 04:10:46 INFO - argparse == 1.2.1 04:10:46 INFO - blessings == 1.6 04:10:46 INFO - blobuploader == 1.2.4 04:10:46 INFO - docopt == 0.6.1 04:10:46 INFO - functools32 == 3.2.3-2 04:10:46 INFO - jsonschema == 2.5.1 04:10:46 INFO - manifestparser == 1.1 04:10:46 INFO - mozInstall == 1.12 04:10:46 INFO - mozcrash == 0.17 04:10:46 INFO - mozdebug == 0.1 04:10:46 INFO - mozdevice == 0.48 04:10:46 INFO - mozfile == 1.2 04:10:46 INFO - mozhttpd == 0.7 04:10:46 INFO - mozinfo == 0.9 04:10:46 INFO - mozleak == 0.1 04:10:46 INFO - mozlog == 3.2 04:10:46 INFO - moznetwork == 0.27 04:10:46 INFO - mozprocess == 0.22 04:10:46 INFO - mozprofile == 0.28 04:10:46 INFO - mozrunner == 6.11 04:10:46 INFO - mozscreenshot == 0.1 04:10:46 INFO - mozsystemmonitor == 0.3 04:10:46 INFO - moztest == 0.7 04:10:46 INFO - mozversion == 1.4 04:10:46 INFO - psutil == 3.1.1 04:10:46 INFO - requests == 1.2.3 04:10:46 INFO - wsgiref == 0.1.2 04:10:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:10: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')]} 04:10:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:10:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:10: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')]} 04:10:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:10:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:10:46 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 0x7f57dcf65f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13d4020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14662e0>, '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 0x13d2140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13d25d0>, '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': '920470bf432669ad7e3a5387000001ca-1465468442.500350-1997601859', '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 04:10:46 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 04:10:46 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 04:10:46 INFO - Using env: {'DISPLAY': ':0', 04:10:47 INFO - 'HOME': '/home/cltbld', 04:10:47 INFO - 'LANG': 'en_US.UTF-8', 04:10:47 INFO - 'LANGUAGE': 'en_US:en', 04:10:47 INFO - 'LOGNAME': 'cltbld', 04:10:47 INFO - 'MAIL': '/var/mail/cltbld', 04:10:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:10:47 INFO - 'MOZ_NO_REMOTE': '1', 04:10:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:10:47 INFO - 'NO_EM_RESTART': '1', 04:10:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:10:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:10:47 INFO - 'PWD': '/builds/slave/test', 04:10:47 INFO - 'SHELL': '/bin/bash', 04:10:47 INFO - 'SHLVL': '1', 04:10:47 INFO - 'TERM': 'linux', 04:10:47 INFO - 'TMOUT': '86400', 04:10:47 INFO - 'USER': 'cltbld', 04:10:47 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1465468442.500350-1997601859', 04:10:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:10:47 INFO - '_': '/tools/buildbot/bin/python'} 04:10:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:10:47 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)) 04:10:47 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)) 04:10:47 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)) 04:10:47 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)) 04:10:47 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)) 04:10:47 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)) 04:10:47 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)) 04:10:47 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)) 04:10:47 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)) 04:10:47 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)) 04:10:47 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)) 04:10:47 INFO - Cleaning up... 04:10:47 INFO - Return code: 0 04:10:47 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:10:47 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')]} 04:10:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:10:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:10:47 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')]} 04:10:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:10:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:10:47 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 0x7f57dcf65f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13d4020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14662e0>, '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 0x13d2140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13d25d0>, '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': '920470bf432669ad7e3a5387000001ca-1465468442.500350-1997601859', '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 04:10:47 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 04:10:47 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 04:10:47 INFO - Using env: {'DISPLAY': ':0', 04:10:47 INFO - 'HOME': '/home/cltbld', 04:10:47 INFO - 'LANG': 'en_US.UTF-8', 04:10:47 INFO - 'LANGUAGE': 'en_US:en', 04:10:47 INFO - 'LOGNAME': 'cltbld', 04:10:47 INFO - 'MAIL': '/var/mail/cltbld', 04:10:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:10:47 INFO - 'MOZ_NO_REMOTE': '1', 04:10:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:10:47 INFO - 'NO_EM_RESTART': '1', 04:10:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:10:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:10:47 INFO - 'PWD': '/builds/slave/test', 04:10:47 INFO - 'SHELL': '/bin/bash', 04:10:47 INFO - 'SHLVL': '1', 04:10:47 INFO - 'TERM': 'linux', 04:10:47 INFO - 'TMOUT': '86400', 04:10:47 INFO - 'USER': 'cltbld', 04:10:47 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1465468442.500350-1997601859', 04:10:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:10:47 INFO - '_': '/tools/buildbot/bin/python'} 04:10:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:10:47 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:10:47 INFO - Cleaning up... 04:10:47 INFO - Return code: 0 04:10:47 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:10:47 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')]} 04:10:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:10:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:10:47 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')]} 04:10:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:10:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:10:47 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 0x7f57dcf65f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13d4020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14662e0>, '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 0x13d2140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13d25d0>, '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': '920470bf432669ad7e3a5387000001ca-1465468442.500350-1997601859', '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 04:10:47 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 04:10:47 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 04:10:47 INFO - Using env: {'DISPLAY': ':0', 04:10:47 INFO - 'HOME': '/home/cltbld', 04:10:47 INFO - 'LANG': 'en_US.UTF-8', 04:10:47 INFO - 'LANGUAGE': 'en_US:en', 04:10:47 INFO - 'LOGNAME': 'cltbld', 04:10:47 INFO - 'MAIL': '/var/mail/cltbld', 04:10:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:10:47 INFO - 'MOZ_NO_REMOTE': '1', 04:10:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:10:47 INFO - 'NO_EM_RESTART': '1', 04:10:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:10:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:10:47 INFO - 'PWD': '/builds/slave/test', 04:10:47 INFO - 'SHELL': '/bin/bash', 04:10:47 INFO - 'SHLVL': '1', 04:10:47 INFO - 'TERM': 'linux', 04:10:47 INFO - 'TMOUT': '86400', 04:10:47 INFO - 'USER': 'cltbld', 04:10:47 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1465468442.500350-1997601859', 04:10:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:10:47 INFO - '_': '/tools/buildbot/bin/python'} 04:10:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:10:47 INFO - Downloading/unpacking flake8 04:10:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:10:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:10:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:10:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:10:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:10:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:10:49 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:10:49 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:10: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 04:10: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 04:10: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 04:10: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 04:10: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 04:10: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 04:10:49 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:10:49 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:10: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 04:10: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 04:10: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 04:10: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 04:10: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 04:10: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 04:10:49 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:10: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 04:10: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 04:10: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 04:10: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 04:10: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 04:10: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 04:10:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:10:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:10:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:10:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:10:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:10:50 INFO - no previously-included directories found matching 'docs/_build' 04:10:50 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:10:50 INFO - Running setup.py install for pep8 04:10:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:10:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:10:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:10:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:10:50 INFO - no previously-included directories found matching 'docs/_build' 04:10:50 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:10:50 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:10:50 INFO - Cleaning up... 04:10:50 INFO - Return code: 0 04:10:50 INFO - Running post-action listener: _resource_record_post_action 04:10:50 INFO - Running post-action listener: _start_resource_monitoring 04:10:50 INFO - Starting resource monitoring. 04:10:50 INFO - ##### 04:10:50 INFO - ##### Finished create-virtualenv step (success) 04:10:50 INFO - ##### 04:10:50 INFO - ##### 04:10:50 INFO - ##### Running install step. 04:10:50 INFO - ##### 04:10:50 INFO - Running pre-action listener: _resource_record_pre_action 04:10:50 INFO - Running main action method: install 04:10:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:10:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:10:50 INFO - Reading from file tmpfile_stdout 04:10:50 INFO - Detecting whether we're running mozinstall >=1.0... 04:10:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:10:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:10:50 INFO - Reading from file tmpfile_stdout 04:10:50 INFO - Output received: 04:10:50 INFO - Usage: mozinstall [options] installer 04:10:50 INFO - Options: 04:10:50 INFO - -h, --help show this help message and exit 04:10:50 INFO - -d DEST, --destination=DEST 04:10:50 INFO - Directory to install application into. [default: 04:10:50 INFO - "/builds/slave/test"] 04:10:50 INFO - --app=APP Application being installed. [default: firefox] 04:10:50 INFO - mkdir: /builds/slave/test/build/application 04:10:50 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'] 04:10:50 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 04:11:06 INFO - Reading from file tmpfile_stdout 04:11:06 INFO - Output received: 04:11:06 INFO - /builds/slave/test/build/application/firefox/firefox 04:11:06 INFO - Running post-action listener: _resource_record_post_action 04:11:06 INFO - ##### 04:11:06 INFO - ##### Finished install step (success) 04:11:06 INFO - ##### 04:11:06 INFO - ##### 04:11:06 INFO - ##### Running run-tests step. 04:11:06 INFO - ##### 04:11:06 INFO - Running pre-action listener: _resource_record_pre_action 04:11:06 INFO - Running main action method: run_tests 04:11:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:11:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:11:06 INFO - Python 2.7.3 04:11:06 INFO - Return code: 0 04:11:06 INFO - grabbing minidump binary from tooltool 04:11:06 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')]} 04:11:06 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 0x14662e0>, '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 0x13d2140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13d25d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:11:06 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 04:11:06 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 04:11:06 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 04:11:06 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:11:06 INFO - Return code: 0 04:11:06 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:11:06 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:11:06 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:11:06 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:11:06 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:11:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:11:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:11:07 INFO - Return code: 0 04:11:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dGeUCIvaTC-yhn-fZQ-qbA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-053', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 04:11:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/dGeUCIvaTC-yhn-fZQ-qbA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-053 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 04:11:07 INFO - Using env: {'DISPLAY': ':0', 04:11:07 INFO - 'HOME': '/home/cltbld', 04:11:07 INFO - 'LANG': 'en_US.UTF-8', 04:11:07 INFO - 'LANGUAGE': 'en_US:en', 04:11:07 INFO - 'LOGNAME': 'cltbld', 04:11:07 INFO - 'MAIL': '/var/mail/cltbld', 04:11:07 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:11:07 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:11:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:11:07 INFO - 'MOZ_NO_REMOTE': '1', 04:11:07 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:11:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:11:07 INFO - 'NO_EM_RESTART': '1', 04:11:07 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:11:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:11:07 INFO - 'PWD': '/builds/slave/test', 04:11:07 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:11:07 INFO - 'SHELL': '/bin/bash', 04:11:07 INFO - 'SHLVL': '1', 04:11:07 INFO - 'TERM': 'linux', 04:11:07 INFO - 'TMOUT': '86400', 04:11:07 INFO - 'USER': 'cltbld', 04:11:07 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1465468442.500350-1997601859', 04:11:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:11:07 INFO - '_': '/tools/buildbot/bin/python'} 04:11:07 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dGeUCIvaTC-yhn-fZQ-qbA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-053', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 04:11:08 INFO - mozversion application_buildid: 20160609025931 04:11:08 INFO - mozversion application_changeset: cb493102af8a50946ac601a86cc3d076703faa57 04:11:08 INFO - mozversion application_display_name: Nightly 04:11:08 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:11:08 INFO - mozversion application_name: Firefox 04:11:08 INFO - mozversion application_remotingname: firefox 04:11:08 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:11:08 INFO - mozversion application_vendor: Mozilla 04:11:08 INFO - mozversion application_version: 50.0a1 04:11:08 INFO - mozversion platform_buildid: 20160609025931 04:11:08 INFO - mozversion platform_changeset: cb493102af8a50946ac601a86cc3d076703faa57 04:11:08 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:11:08 INFO - mozversion platform_version: 50.0a1 04:11:08 INFO - using testdate: 1465470668 04:11:08 INFO - actual date: 1465470668 04:11:08 INFO - starting webserver on 'localhost:56512' 04:11:08 INFO - SUITE-START | Running 2 tests 04:11:08 INFO - TEST-START | dromaeo_css 04:11:08 INFO - operating with platform_type : linux_ 04:11:08 INFO - Initialising browser for dromaeo_css test... 04:11:08 INFO - TEST-INFO | started process 698 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbfrtnb/profile http://localhost:56512/getInfo.html) 04:11:12 INFO - PROCESS | 698 | __metrics Screen width/height:1600/1200 04:11:12 INFO - PROCESS | 698 | colorDepth:24 04:11:12 INFO - PROCESS | 698 | Browser inner width/height: 1024/697 04:11:12 INFO - PROCESS | 698 | __metrics 04:11:13 ERROR - PROCESS | 698 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 04:11:13 INFO - PROCESS | 698 | console.error: PushService: 04:11:13 INFO - PROCESS | 698 | stateChangeProcessEnqueue: Error transitioning state 04:11:13 INFO - PROCESS | 698 | UnknownError 04:11:14 INFO - TEST-INFO | 698: exit 0 04:11:14 INFO - Browser initialized. 04:11:14 INFO - Running cycle 1/1 for dromaeo_css test... 04:11:14 INFO - TEST-INFO | started process 781 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbfrtnb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:11:26 INFO - PROCESS | 781 | RSS: Main: 174514176 04:11:26 INFO - PROCESS | 781 | 04:12:17 INFO - PROCESS | 781 | 1465470737932 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] 04:14:30 INFO - PROCESS | 781 | Cycle 1(1): loaded http://localhost:56512/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56512/tests/dromaeo/cssquery-ext.html) 04:14:30 INFO - PROCESS | 781 | RSS: Main: 263905280 04:14:30 INFO - PROCESS | 781 | 04:17:33 INFO - PROCESS | 781 | Cycle 1(1): loaded http://localhost:56512/tests/dromaeo/cssquery-ext.html (next: http://localhost:56512/tests/dromaeo/cssquery-jquery.html) 04:17:34 INFO - PROCESS | 781 | RSS: Main: 256016384 04:17:34 INFO - PROCESS | 781 | 04:20:36 INFO - PROCESS | 781 | Cycle 1(1): loaded http://localhost:56512/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56512/tests/dromaeo/cssquery-mootools.html) 04:20:36 INFO - PROCESS | 781 | RSS: Main: 255459328 04:20:36 INFO - PROCESS | 781 | 04:23:39 INFO - PROCESS | 781 | Cycle 1(1): loaded http://localhost:56512/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56512/tests/dromaeo/cssquery-prototype.html) 04:23:39 INFO - PROCESS | 781 | RSS: Main: 248946688 04:23:39 INFO - PROCESS | 781 | 04:26:42 INFO - PROCESS | 781 | Cycle 1(1): loaded http://localhost:56512/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56512/tests/dromaeo/cssquery-yui.html) 04:26:43 INFO - PROCESS | 781 | RSS: Main: 234147840 04:26:43 INFO - PROCESS | 781 | 04:29:46 INFO - PROCESS | 781 | Cycle 1(1): loaded http://localhost:56512/tests/dromaeo/cssquery-yui.html (next: http://localhost:56512/tests/dromaeo/cssquery-dojo.html) 04:29:46 INFO - PROCESS | 781 | RSS: Main: 291299328 04:29:46 INFO - PROCESS | 781 | 04:29:46 INFO - PROCESS | 781 | __start_tp_report 04:29:46 INFO - PROCESS | 781 | _x_x_mozilla_page_load 04:29:46 INFO - PROCESS | 781 | _x_x_mozilla_page_load_details 04:29:46 INFO - PROCESS | 781 | |i|pagename|runs| 04:29:46 INFO - PROCESS | 781 | |0;dojo.html;2566.1403429851;2575.6909170899494;2598.6621739173906;2601.8959241630328;2613.529564678357;4463.107378524292;4545.636349092073;4556.9088618227615;4594.74728889911;4598.678092533524;4517.593416592506;4564.338170965208;4573.176828170928;4573.656975726817;4643.094596553673;4182.121754431565;4188.958110418903;4245.957540424587;4288.742675439468;4361.563843615645;4319.632831209351;4328.935065974013;4348.673849461287;4351.956480435187;4374.693771436001;4147.4815648044;4165.937510937339;4187.8324867005285;4233.830646774125;4235.9364609530885;4216.388623649554;4231.365295205713;4237.0466645004935;4237.724547904377;4237.724547904407;4108.342665173588;4226.323788193874;4231.978840105779;4232.217039847638;4232.76719780412;4477.48508921475;4493.303537951622;4508.188526065307;4534.750588717619;4539.795709193094;4924.162892308281;4925.458199598042;4926.236433352836;4926.4088309403105;4928.186849169882;4692.906141877143;4866.343043689092;4930.309756634074;4948.752562371867;4955.603551715854;4618.468876079294;4664.510226426177;4664.5335466453425;4668.043051174501;4669.579737823612;5084.237364395371;5112.054269960069;5127.564157046693;5130.102232109366;5134.101532231844;4665.160271151225;4689.648276379286;4739.928901066487;4740.241561350167;4898;4854.077725232195;4862.805487780449;4867.805287788519;4873.098476781735;4919.7540122993705;4815.831445899376;4828.444728856156;4832.685875418087;4835.758212089381;4891.192953162759;4665.86002419928;4763.73799441034;4811.975940120277;4820.325154478376;4823.3729615149805;4127.504699436087;4128.091819799639;4130.752154870717;4162.146759914211;4180.205760905418;3617;3619.8914032579064;3634.4184930411006;3665.047087757149;3675.044488433027;4232.682548808852;4238.6397156242065;4287.656987440997;4289.635380992589;4296.720713153635;4924.285978533093;4931.112399768004;4945.184044632595;4946.802127914915;4995.8001679932395;4284.67864910133;4288.678349123828;4290.957090429056;4293.69944103916;4339.891502712458;4296.119295544406;4391.363252328394;4422.75674837887;4430.667699922455;4444.622207112367;4657.650676199299;4672.649551283599;4673.602743766818;4682.297655351725;4705.106029854385;4787.784549695341;4938.75306234694;4948.802047918043;4950.430700469492;5023.32185155014;4587.541245875519;4643.5356464354645;4648.8140474382;4651.837185698484;4661.463931647768;4844.394450693663;4872.3909511311085;4879.634027447884;4888.462269150319;4929.580985616263;4768.594669453136;4805.879853003703;4948.257761335828;4952.826651067339;5002.624803139852;4665.6734028617675;4704.341392205026;4714.811407543797;4721.7403042832975;4776.737279449663;4742.810287588458;4745.383100196952;4746.43042834862;4778.880527986828;4794.328793968777;4608.124456353282;4643.605293550086;4680.485146633936;4685.156671799109;4718.363020992122;4818.253170758538;4842.951570484391;4844.46710861812;4880.731559764105;4888.633352498506;4761.833335833229;4761.9285710713675;4764.237721964469;4765.380500534909;4801.4718380977365 04:29:46 INFO - PROCESS | 781 | |1;ext.html;518.6369541321073;558.6675927822945;569.7777866632013;573.2461812716281;573.701675128933;28545.857270713645;30672.38655226894;30672.539911901284;30747.538786918216;39172.60827391725;37452.812735936284;40923.18153636925;40987.59012409875;40988.795056024755;41006.17987640253;7792.844143117134;7964.323032542241;7974.242446967529;7975.082865470458;7977.16239794819;7807.609619519029;7883.921160788404;7900.525968441883;7905.0513938327485;7906.169852165526;7911.802204944894;7983;7985.6406461709075;7985.760427187193;7986.600669966479;7869.606519674022;7925.445218834713;7944.6027698614835;7946.7615971520945;7957.084935232465;7835.96082019592;7843.294103530652;7894.171112033211;7900.920990790076;7901.60491975399;38285.42571861424;38671;38699.8065009676;38744.225115497815;38878.61121388778;3020.622422197225;3094.470617406397;3121.2352973521406;3190.7925984811145;3317.3862835375535;29266.268343291376;29413.41173176546;29463;29908.700912991026;29924.8503757482;3348.79907205566;3450.913727156816;3469.5836499619954;3515.5605549306338;3546.946795798065;262826;264597;266779.66610166826;267596;269922;31714.524282135786;53885.46114538804;54711.72644136754;54720.72639636776;54776.17835732467;31866;34278.14304642354;34329.828350858086;34403.13992150216;34417.82791086079;13532.797008044887;13603.795943060863;13610.455581776816;13720.93139534296;13730.862691373159;11402.315861048364;11485.885141148648;11499.080073594092;11528.942355288338;11569;7794.8051298716855;7903.288704016666;7957.3634109271115;7981.561014144278;8017.238362355567;3091.335362896988;3115.6572776994967;3173.936521269608;3190.1067701043744;3196.408664397094;815.4129027100478;882.8587426011808;907.1518130547827;943.9811203776023;951.7335146159087;27620.723792762215;27942.022029229287;28005.71994280072;28442.004529841357;28651.71348286532;935.6538080910107;962.5812771444444;965.8020105878278;966.6181858165985;1004.8342023566175;14369.6407589809;14731.116133031837;14755.614200816624;14774.704505909822;15013.924930375497;367453;370512;375535;376284;377645;48549.27176092361;48859;49264.50735492599;49296;49403.50596494061;1076.3004047369116;1180.8287798269203;1187.4122309456875;1206.1978784108644;1212.4483360071322;27936.30159246035;28322.85838570794;28741.42517149687;28955.42089158247;29287;41040.38439423471;41298.79350603228;41772;41774.16451670889;41801.79099104485;284627;285391;285665;286071.11431085045;286250;21788;24456.26631201067;25016.62475062839;25029.49941001206;25257.116000939877;41250.79374603108;41573.584264158184;41670.58329416788;41844.79077604593;41880.79059604804;35150.12124696903;35496.645033549335;35733.46399804057;36005.819970899975;36250.8187459061;35185;35640.643593563735;35955.82022089873;36003.45994810132;36310.27379452449;34625;35231.82384088063;35251.47122793109;35259;35499.112522187155;28905.42189156163;31487.370252594363;31512.52731208988;31530;31767.841160794047;24322.148724794548;24377.39056523601;24596;25001;25203.369915752253 04:29:46 INFO - PROCESS | 781 | |2;jquery.html;345.90141809584276;348.1782992138553;354.9414346632805;357.4513122357179;362.1381112951176;12920.224786512816;13446.32768361583;15598.84401155988;16189.109598972067;17329.826701732996;14782.630434239149;15575.143367114804;15593.766093508606;16389.262483188257;16426.917865410654;4554.567316104964;5041.747912604374;5190.169572868342;5206.479352064801;5273.235380869772;5008.774605142778;5126.307948426952;5130.6152038597065;5151.76817043232;5180.689158650474;5096.5922726182;5141.0489059523925;5147.382314122292;5147.716875571842;5151.665141765773;4986.850394488153;5086;5119.948800511985;5148.202028685541;5156.613254005946;4493.505714371417;4497.685162038659;4503.437070366204;4503.459584849807;4506.256467682829;18651.813481865145;19807.504812379662;19839.90080049605;20532.794672053238;20851.5829683407;1837.5038739540382;1867.253098760493;1879.3234435603172;1894.2612381171355;2169.915042478761;8875.423097498706;9125.77185570366;9402.106799854002;9523.57143928525;9649.903500965042;1569.6389830338971;1579.297212740331;1612.5081850035735;1639.5655151384892;1649.2495914358938;63783.68108159476;67007;68805.31194688089;69489.65255173742;69661;9785.183778326458;9797.461139637246;9918.752031199278;10024.398536087858;10063.64140840977;11740.647780566596;12161.270323780602;13357.532486363125;13363.866361336262;13376.197428154148;7146.464015198777;7416.737894941986;7466.925330746732;7556.773296801105;7565.2812982766545;7196.856062878713;7239.04545772649;7255.927440725631;7396.482246242711;7402.9629851850395;4319.092990471973;4338.154059958341;4383.232934236559;4418.116376724668;4418.469783625986;1717.8441056474046;1786.606946471774;1788.2936240185054;1796.62270923105;1852.1850385830191;837.7696133563197;845.8435189489841;880.6169316347409;893.9731808045769;898.8786513820551;16195.919020404823;16582.17089145538;16901.492955211117;16968.915155424143;17365;858.3305022082785;880.506916126971;887.6050157679771;900.594732370436;931.9394239374419;9400.200982916529;9462;9556.808863822824;9703.854442183372;9787.46168960714;391636;402811;404995;406122;406349;73495;76159.23840761633;77261;77444;79536.60231698805;919.0671468459519;920.7283851263893;934.5140526926097;945.9006804285589;946.9337146399823;15003.099814011195;15034.32345544475;15202.391904323704;15224.46714364992;15424.151671657717;27027.02702702662;28860.27849303784;33723.83138084294;34134.31731365309;36548.63451365452;41648.79175604103;46591.53408465872;47199.76400117978;47838.76080619574;48088;6732.158480189976;6956.652167391509;7173.1392232932385;7649.388048955959;7785.805354866174;11656.592019279284;11814.232074915446;11967.281963082243;11970.58102966392;12000.219985700902;10057.69826905194;10083.14293285079;10147.49262536885;10280.794384112127;10365.429901355497;10345.172386208935;10545.367277963347;10610.098141658045;10792.352458852494;10798.67603971882;10113.64602238918;10137.087662110445;10192.643257485952;10199.643012494824;10364.481775911325;7063.540869843444;7223.9165368980175;7232.710691572278;7387.889181662387;7401.59291238987;8742.956285218788;9110.088991100836;9323.254139668674;9328;9948.403095814274 04:29:46 INFO - PROCESS | 781 | |3;mootools.html;1264.5574049082827;1370.547719252647;1418.3475601223436;1434.648511114777;1657.5110342448977;6334.461570766484;7115.6442177891095;7357.3746231570385;7394.038774959261;7519.060117485315;7304.196538380774;7405.851882962337;7407.851842963151;7413.406927445805;7420.332170104703;2134.4877229464896;2167.143978128638;2169.1648715244587;2174.1738139506965;2174.967375489369;2103.3584756649216;2124.8300135989084;2164.8051675349216;2165.2096984600585;2167.1331467413;2078.740157480315;2093.4661661276355;2105.905234264462;2107.346722516025;2144.2602302205714;2089.759677637076;2097.81119699227;2100.327895073577;2100.737407824022;2100.842436817245;1989.5125694204867;2062.061761898333;2064.421961850684;2066.545360020793;2066.8346532277383;7195.280471952815;7383.6677349519405;7450.105987281507;7491.8501629967095;7496.8125796854965;4320.978395108035;4381.934270985906;4416.028473735773;4420.977895110504;4425.491068527129;2690.0853709738585;2824.5480723084206;2858.056841242385;2862.9284267893263;2873.741363277315;888.5424006636588;899.3929097858985;909.8771665825095;917.5595714057223;920.2270093121809;9821.852672209923;9859.556319965546;9892.15916647086;9913.65302214419;9931.106200441995;3701.574318953301;3800.277947190025;3832.6358995895343;3834.0606551395085;3852.5376954765607;7784.260495252942;7818.8827167592535;7827.412944029106;7848.568328741974;7855.214478552099;4243.321068629066;4308.633766129851;4327.32926396409;4334.241507736134;4337.7180483268485;3460.79235245881;3892.2993861104706;3997.6801855851463;4014.6386825185873;4059.9594004060173;3205.2627895584146;3227.2738633807207;3266.1671273825496;3295.1762059485127;3304.0253125328086;940.2947789158131;998.6854140945579;998.7752755629925;1002.5989604158395;1003.2776400991274;756.7994481462307;782.8356045230565;816.1308206759782;828.2007862412801;830.9376796740148;5058.595312375001;5081.5426611605135;5082.847514574569;5096.286519887145;5096.439391666913;833.9874901876477;850.1625898489982;850.3239924260228;891.7324802559207;897.8518544440094;3472.6353732858192;3531.4702794581017;3544.91137721559;3545.5213546170935;3611;8895.332850036273;9018.729438116867;9085.863712044325;9137.680181193626;9157.450552966844;8980.730578082668;9006.59470323837;9061.68284110053;9094.499802510925;9122.179003889682;6740.460763138937;6823.420009299265;6942.097527321416;6952.93047069533;6966;4951.282064100757;5013.222950442687;5030.622703297194;5031.119554077948;5064.063148317573;8369.330453563578;8372.623231954454;8416.452930559739;8427.536485493356;8498.065212826708;8399.28606068491;8566.957165214135;8568.314534837073;8644.96260448725;8652.351073669373;5486.231927530069;6053.061775424816;6216.751329946932;6325.367463253638;6327.145835312174;7106.395956343768;7241.094863142107;7241.891371629325;7244.963775181091;7248.347648711641;6420.26166990802;6518.902216466851;6568.146141001639;6588.176477940257;6611.371919667624;6318.052292156213;6478.449331806849;6521.380468855451;6587.604743715392;6628.270890201978;5653.095504719226;5698.629589076697;5708.4862362387585;5711.257536520226;5716.199732037435;4221.97889010553;4288.31386978082;4299.118680670393;4352.390665306796;4352.499462561846;4305.48334199898;4337.089211265544;4392.648588112879;4446.110777844379;4461.843835465743 04:29:46 INFO - PROCESS | 781 | |4;prototype.html;278.1987874920231;282.66036775497497;285.96139521164645;292.28098876763164;293.73710529076476;4525.348247889521;4681.789319480623;4723.551262630049;4762.428508578971;4789.688670236436;4550.522195169509;4681.969966607349;4688.32019357193;4691.756684478607;4700.318453824193;3682.1531047859007;3712.517372741553;3721.423179407196;3728.962710372902;3737.2338670572603;3478.8782392616263;3561.483584880191;3726.441033844918;3726.77639341639;3735.972607532923;3662.7436079474446;3668.3030224257304;3692.926141477169;3694.371956767356;3701.5002974598356;3655.780653160819;3662.5421822272215;3668.321360548307;3675.7610755300952;3685.3182161300247;3253.511973204015;3259.1689119274433;3262.1518405214815;3265.755068369882;3276.918077048069;4392.714473559208;4586.885327866797;4602.861914142581;4617.353570500132;4645.256758918591;4104.733192342518;4110;4133.855315063958;4160.45914031174;4170.374443833419;4901.65688401812;4909.410870695539;4924.704517728947;4937.23472861707;4938.777755000998;3274.672532746706;3462.601800792916;3474.062003259131;3485.268093700326;3510.947335789965;5071.923921141186;5096.23556466533;5108.233764935252;5127.948720512784;5134.974325128388;3499.3001399720156;3509.4560343146854;3515.7538972272205;3517.753757236969;3524.8942531724088;3564.8592450416136;3565.893023209308;3569.1255642367787;3583;3585.6952159066773;3982.4623675803396;4071.185762847442;4100.138970816162;4109.198706252312;4118.279301122292;4841.515848415201;4848.224284114524;4858.902821943612;4890.853274401702;4918.8770280743265;1127.7631697343486;1191.350713860948;1234.9256147152034;1240.231056744824;1256.145820841818;777.9222077792289;782.1982467970375;795.7055889320989;795.7453614843195;808.0747544062016;3918.2555314490155;3945.6054394560315;3957.3288030579242;3970.7021973352116;3978.2839088963688;4435.2016637005645;4480.932786008212;4483.461984561874;4494.640428765691;4511.142882852248;3974.741641793274;4002.3396139636634;4015.6988225883174;4018.8995275118355;4033.838646454109;2313.178821518337;2383.41606306456;2401.3516350585246;2413.4328432818274;2447.898445699442;4240.554741752072;4284.250256205151;4295.892602684958;4301.91396172081;4312.792418122931;4518.401918896648;4527.660425468103;4579.534548944373;4580.816767329269;4594.5864872161;4092.8921605373257;4258.84928111308;4273.722208056466;4341.218580655449;4346.217680817484;4519.706219095749;4526.099038403812;4533.954660453353;4551.362809206647;4557.612602928788;4367.213901497761;4381.67137464685;4413.073254616438;4436.0462500562535;4460.977695111504;4071.8371265149062;4193.7693426861815;4250.256205164146;4262.87211383659;4317.7193482423545;3224.322892192572;3233.579634647481;3257.869685212565;3268.3953468608383;3284.3267130237764;4544.363789069599;4575.473820510684;4612;4637.426228443246;4919.581835544019;4735.289706544046;4873.707577545359;4929.531694489017;4930.6795058321095;4941.135301322182;4920.6801557898625;4943.752812359439;4974.32846565709;4978.726170060681;5012.598992080698;4597.448306203277;4882.536159064884;4883.413990321042;4889.2910527972535;4914.8771280718265;4909.7545122743;4950.648441990026;4994.276974443811;4995.5004499551205;5005.124103281838;4839.733814640229;4868.440129385166;4897.8734890974565;4901.21580547125;4935.062338155739 04:29:46 INFO - PROCESS | 781 | |5;yui.html;620.0921731906561;683.5966779600042;708.5536112249283;711.8078118907895;757.1935888278982;12696.80954785679;13643.249621270827;13655.317234138278;13656.180629162245;13660.385282662279;12959.740805183914;14157.50448734292;14359.425622975068;14385.712285754278;15200.923995380008;624.1044101714032;787.2009909941399;791.8178818871663;792.0614072324286;793.5357815677835;773.2036002916976;796.191865256762;799.256691277112;799.3764863406552;800.3597122302164;829.601791140253;829.8755186721979;832.2592892325835;832.488019867783;832.5753865528563;644.9935500644981;797.8244786147038;826.0459169659024;826.0665448043702;826.6486743134174;602.5510994309268;607.8389226854887;607.9574429789916;608.1668114682868;608.3126067543692;13166.539171128965;13270.86729132706;13475.595732128051;13489.797653035212;13490.52783152585;12335.876641233652;12631.684207894785;12641.49434022638;13153.947684185337;13311.40098695561;9029.819403611957;9184.724458266262;9431.339806213567;9528.952355238249;9643.469609171492;2944.180137992889;3014.291641464254;3019.3055597212765;3020.6828283030404;3050.6186726659166;62690.37309626891;62881.37118628801;62886.37113628851;63272.68363658198;63361.36638633647;9674.467904265191;9791.755206119762;9875.703728888146;10053.296269261082;10097.545610447547;18510.629787404177;18513.074346282632;18562.44312670622;18568.81431185698;18581.25674973013;6530.249021362604;6538.869222615521;6610.7025183866845;6635.767748128792;6845.5550389224545;3486.825658717105;3524.0308915048054;3545.4859045438266;3556.2354093869944;3590.2101537661674;2753.6420265365373;2888.725571070745;2889.436559870805;2896.6668833084045;2897.8116422432477;488.10920070870804;490.4359986016039;501.11803226321933;508.81936912396304;510.698687774215;606.4178388746852;612.4487960835284;620.7299824576323;636.3064259956669;645.4158986117571;8082.959585202154;8150.796230094295;8423.960468119687;8433.83132337362;8434.493930364199;593.7506247376112;603.5111559636708;615.7198474694003;630.3475902440952;639.178655427773;3772.754770939935;3849.364854798983;3867.3425517662067;3900.278448487039;4026.53694825093;88556.5572172135;89619;93457;93676;96739.03260967441;79340.60329698314;79781;80208;80401.19598804053;81051.18948810555;69632;70412;70417.29582704107;71732.64133679403;75739;7426.740064097947;7611.467197296136;7651.081870175614;7654.043244594426;7656;43108.56891431171;43184.99999999874;44769.552304476536;45005.54994450144;45455.54544454513;61884.38115618786;62126.68936655288;62154;62404;62413.68793156005;10062.69811905644;10260.486975651038;10412.635557755442;10478.423686697304;10734.141268698642;10654.25420220608;10657.626983055556;10840.403777791982;10865.837012444978;11206.047485963785;9884;10014.449205293779;10151.54318055704;10484.79030419372;10682.359058456517;9545.188658964065;9618.086281803218;9733.318667693193;9888.406695598287;9892.85160722604;9609.9039009609;9712.660056898258;9822.75443113928;9871.111599955751;10032.899671003488;7746.109197442366;7758.7672369829;7807.011005937786;7815.960920195363;7821.651990277686;6994.965025174842;7221.602811845399;7304.452166087671;7425.108986921604;7511.136219334628 04:29:46 INFO - PROCESS | 781 | __end_tp_report 04:29:46 INFO - PROCESS | 781 | __start_cc_report 04:29:46 INFO - PROCESS | 781 | _x_x_mozilla_cycle_collect,869 04:29:46 INFO - PROCESS | 781 | __end_cc_report 04:29:46 INFO - PROCESS | 781 | __startTimestamp1465471786396__endTimestamp 04:29:46 INFO - PROCESS | 781 | 04:29:46 INFO - PROCESS | 781 | ------- Summary: start ------- 04:29:46 INFO - PROCESS | 781 | Number of tests: 6 04:29:46 INFO - PROCESS | 781 | 04:29:46 INFO - PROCESS | 781 | [#0] dojo.html Cycles:165 Average:4538.71 Median:4665.67 stddev:467.67 (10.0%) stddev-sans-first:442.76 04:29:46 INFO - PROCESS | 781 | Values: 2566.1 2575.7 2598.7 2601.9 2613.5 4463.1 4545.6 4556.9 4594.7 4598.7 4517.6 4564.3 4573.2 4573.7 4643.1 4182.1 4189.0 4246.0 4288.7 4361.6 4319.6 4328.9 4348.7 4352.0 4374.7 4147.5 4165.9 4187.8 4233.8 4235.9 4216.4 4231.4 4237.0 4237.7 4237.7 4108.3 4226.3 4232.0 4232.2 4232.8 4477.5 4493.3 4508.2 4534.8 4539.8 4924.2 4925.5 4926.2 4926.4 4928.2 4692.9 4866.3 4930.3 4948.8 4955.6 4618.5 4664.5 4664.5 4668.0 4669.6 5084.2 5112.1 5127.6 5130.1 5134.1 4665.2 4689.6 4739.9 4740.2 4898.0 4854.1 4862.8 4867.8 4873.1 4919.8 4815.8 4828.4 4832.7 4835.8 4891.2 4665.9 4763.7 4812.0 4820.3 4823.4 4127.5 4128.1 4130.8 4162.1 4180.2 3617.0 3619.9 3634.4 3665.0 3675.0 4232.7 4238.6 4287.7 4289.6 4296.7 4924.3 4931.1 4945.2 4946.8 4995.8 4284.7 4288.7 4291.0 4293.7 4339.9 4296.1 4391.4 4422.8 4430.7 4444.6 4657.7 4672.6 4673.6 4682.3 4705.1 4787.8 4938.8 4948.8 4950.4 5023.3 4587.5 4643.5 4648.8 4651.8 4661.5 4844.4 4872.4 4879.6 4888.5 4929.6 4768.6 4805.9 4948.3 4952.8 5002.6 4665.7 4704.3 4714.8 4721.7 4776.7 4742.8 4745.4 4746.4 4778.9 4794.3 4608.1 4643.6 4680.5 4685.2 4718.4 4818.3 4843.0 4844.5 4880.7 4888.6 4761.8 4761.9 4764.2 4765.4 4801.5 04:29:46 INFO - PROCESS | 781 | 04:29:46 INFO - PROCESS | 781 | [#1] ext.html Cycles:180 Average:45174.98 Median:19402.97 stddev:82166.93 (423.5%) stddev-sans-first:82329.02 04:29:46 INFO - PROCESS | 781 | Values: 518.6 558.7 569.8 573.2 573.7 28545.9 30672.4 30672.5 30747.5 39172.6 37452.8 40923.2 40987.6 40988.8 41006.2 7792.8 7964.3 7974.2 7975.1 7977.2 7807.6 7883.9 7900.5 7905.1 7906.2 7911.8 7983.0 7985.6 7985.8 7986.6 7869.6 7925.4 7944.6 7946.8 7957.1 7836.0 7843.3 7894.2 7900.9 7901.6 38285.4 38671.0 38699.8 38744.2 38878.6 3020.6 3094.5 3121.2 3190.8 3317.4 29266.3 29413.4 29463.0 29908.7 29924.9 3348.8 3450.9 3469.6 3515.6 3546.9 262826.0 264597.0 266779.7 267596.0 269922.0 31714.5 53885.5 54711.7 54720.7 54776.2 31866.0 34278.1 34329.8 34403.1 34417.8 13532.8 13603.8 13610.5 13720.9 13730.9 11402.3 11485.9 11499.1 11528.9 11569.0 7794.8 7903.3 7957.4 7981.6 8017.2 3091.3 3115.7 3173.9 3190.1 3196.4 815.4 882.9 907.2 944.0 951.7 27620.7 27942.0 28005.7 28442.0 28651.7 935.7 962.6 965.8 966.6 1004.8 14369.6 14731.1 14755.6 14774.7 15013.9 367453.0 370512.0 375535.0 376284.0 377645.0 48549.3 48859.0 49264.5 49296.0 49403.5 1076.3 1180.8 1187.4 1206.2 1212.4 27936.3 28322.9 28741.4 28955.4 29287.0 41040.4 41298.8 41772.0 41774.2 41801.8 284627.0 285391.0 285665.0 286071.1 286250.0 21788.0 24456.3 25016.6 25029.5 25257.1 41250.8 41573.6 41670.6 41844.8 41880.8 35150.1 35496.6 35733.5 36005.8 36250.8 35185.0 35640.6 35955.8 36003.5 36310.3 34625.0 35231.8 35251.5 35259.0 35499.1 28905.4 31487.4 31512.5 31530.0 31767.8 24322.1 24377.4 24596.0 25001.0 25203.4 04:29:46 INFO - PROCESS | 781 | 04:29:46 INFO - PROCESS | 781 | [#2] jquery.html Cycles:180 Average:24131.09 Median:4503.45 stddev:66309.25 (1472.4%) stddev-sans-first:66471.22 04:29:46 INFO - PROCESS | 781 | Values: 345.9 348.2 354.9 357.5 362.1 12920.2 13446.3 15598.8 16189.1 17329.8 14782.6 15575.1 15593.8 16389.3 16426.9 4554.6 5041.7 5190.2 5206.5 5273.2 5008.8 5126.3 5130.6 5151.8 5180.7 5096.6 5141.0 5147.4 5147.7 5151.7 4986.9 5086.0 5119.9 5148.2 5156.6 4493.5 4497.7 4503.4 4503.5 4506.3 18651.8 19807.5 19839.9 20532.8 20851.6 1837.5 1867.3 1879.3 1894.3 2169.9 8875.4 9125.8 9402.1 9523.6 9649.9 1569.6 1579.3 1612.5 1639.6 1649.2 63783.7 67007.0 68805.3 69489.7 69661.0 9785.2 9797.5 9918.8 10024.4 10063.6 11740.6 12161.3 13357.5 13363.9 13376.2 7146.5 7416.7 7466.9 7556.8 7565.3 7196.9 7239.0 7255.9 7396.5 7403.0 4319.1 4338.2 4383.2 4418.1 4418.5 1717.8 1786.6 1788.3 1796.6 1852.2 837.8 845.8 880.6 894.0 898.9 16195.9 16582.2 16901.5 16968.9 17365.0 858.3 880.5 887.6 900.6 931.9 9400.2 9462.0 9556.8 9703.9 9787.5 391636.0 402811.0 404995.0 406122.0 406349.0 73495.0 76159.2 77261.0 77444.0 79536.6 919.1 920.7 934.5 945.9 946.9 15003.1 15034.3 15202.4 15224.5 15424.2 27027.0 28860.3 33723.8 34134.3 36548.6 41648.8 46591.5 47199.8 47838.8 48088.0 6732.2 6956.7 7173.1 7649.4 7785.8 11656.6 11814.2 11967.3 11970.6 12000.2 10057.7 10083.1 10147.5 10280.8 10365.4 10345.2 10545.4 10610.1 10792.4 10798.7 10113.6 10137.1 10192.6 10199.6 10364.5 7063.5 7223.9 7232.7 7387.9 7401.6 8743.0 9110.1 9323.3 9328.0 9948.4 04:29:46 INFO - PROCESS | 781 | 04:29:46 INFO - PROCESS | 781 | [#3] mootools.html Cycles:180 Average:4834.34 Median:5709.87 stddev:2672.70 (46.8%) stddev-sans-first:2666.74 04:29:46 INFO - PROCESS | 781 | Values: 1264.6 1370.5 1418.3 1434.6 1657.5 6334.5 7115.6 7357.4 7394.0 7519.1 7304.2 7405.9 7407.9 7413.4 7420.3 2134.5 2167.1 2169.2 2174.2 2175.0 2103.4 2124.8 2164.8 2165.2 2167.1 2078.7 2093.5 2105.9 2107.3 2144.3 2089.8 2097.8 2100.3 2100.7 2100.8 1989.5 2062.1 2064.4 2066.5 2066.8 7195.3 7383.7 7450.1 7491.9 7496.8 4321.0 4381.9 4416.0 4421.0 4425.5 2690.1 2824.5 2858.1 2862.9 2873.7 888.5 899.4 909.9 917.6 920.2 9821.9 9859.6 9892.2 9913.7 9931.1 3701.6 3800.3 3832.6 3834.1 3852.5 7784.3 7818.9 7827.4 7848.6 7855.2 4243.3 4308.6 4327.3 4334.2 4337.7 3460.8 3892.3 3997.7 4014.6 4060.0 3205.3 3227.3 3266.2 3295.2 3304.0 940.3 998.7 998.8 1002.6 1003.3 756.8 782.8 816.1 828.2 830.9 5058.6 5081.5 5082.8 5096.3 5096.4 834.0 850.2 850.3 891.7 897.9 3472.6 3531.5 3544.9 3545.5 3611.0 8895.3 9018.7 9085.9 9137.7 9157.5 8980.7 9006.6 9061.7 9094.5 9122.2 6740.5 6823.4 6942.1 6952.9 6966.0 4951.3 5013.2 5030.6 5031.1 5064.1 8369.3 8372.6 8416.5 8427.5 8498.1 8399.3 8567.0 8568.3 8645.0 8652.4 5486.2 6053.1 6216.8 6325.4 6327.1 7106.4 7241.1 7241.9 7245.0 7248.3 6420.3 6518.9 6568.1 6588.2 6611.4 6318.1 6478.4 6521.4 6587.6 6628.3 5653.1 5698.6 5708.5 5711.3 5716.2 4222.0 4288.3 4299.1 4352.4 4352.5 4305.5 4337.1 4392.6 4446.1 4461.8 04:29:46 INFO - PROCESS | 781 | 04:29:46 INFO - PROCESS | 781 | [#4] prototype.html Cycles:180 Average:3927.95 Median:4307.35 stddev:1139.76 (26.5%) stddev-sans-first:1109.54 04:29:46 INFO - PROCESS | 781 | Values: 278.2 282.7 286.0 292.3 293.7 4525.3 4681.8 4723.6 4762.4 4789.7 4550.5 4682.0 4688.3 4691.8 4700.3 3682.2 3712.5 3721.4 3729.0 3737.2 3478.9 3561.5 3726.4 3726.8 3736.0 3662.7 3668.3 3692.9 3694.4 3701.5 3655.8 3662.5 3668.3 3675.8 3685.3 3253.5 3259.2 3262.2 3265.8 3276.9 4392.7 4586.9 4602.9 4617.4 4645.3 4104.7 4110.0 4133.9 4160.5 4170.4 4901.7 4909.4 4924.7 4937.2 4938.8 3274.7 3462.6 3474.1 3485.3 3510.9 5071.9 5096.2 5108.2 5127.9 5135.0 3499.3 3509.5 3515.8 3517.8 3524.9 3564.9 3565.9 3569.1 3583.0 3585.7 3982.5 4071.2 4100.1 4109.2 4118.3 4841.5 4848.2 4858.9 4890.9 4918.9 1127.8 1191.4 1234.9 1240.2 1256.1 777.9 782.2 795.7 795.7 808.1 3918.3 3945.6 3957.3 3970.7 3978.3 4435.2 4480.9 4483.5 4494.6 4511.1 3974.7 4002.3 4015.7 4018.9 4033.8 2313.2 2383.4 2401.4 2413.4 2447.9 4240.6 4284.3 4295.9 4301.9 4312.8 4518.4 4527.7 4579.5 4580.8 4594.6 4092.9 4258.8 4273.7 4341.2 4346.2 4519.7 4526.1 4534.0 4551.4 4557.6 4367.2 4381.7 4413.1 4436.0 4461.0 4071.8 4193.8 4250.3 4262.9 4317.7 3224.3 3233.6 3257.9 3268.4 3284.3 4544.4 4575.5 4612.0 4637.4 4919.6 4735.3 4873.7 4929.5 4930.7 4941.1 4920.7 4943.8 4974.3 4978.7 5012.6 4597.4 4882.5 4883.4 4889.3 4914.9 4909.8 4950.6 4994.3 4995.5 5005.1 4839.7 4868.4 4897.9 4901.2 4935.1 04:29:46 INFO - PROCESS | 781 | 04:29:46 INFO - PROCESS | 781 | [#5] yui.html Cycles:180 Average:17041.73 Median:62785.87 stddev:24542.94 (39.1%) stddev-sans-first:24580.81 04:29:46 INFO - PROCESS | 781 | Values: 620.1 683.6 708.6 711.8 757.2 12696.8 13643.2 13655.3 13656.2 13660.4 12959.7 14157.5 14359.4 14385.7 15200.9 624.1 787.2 791.8 792.1 793.5 773.2 796.2 799.3 799.4 800.4 829.6 829.9 832.3 832.5 832.6 645.0 797.8 826.0 826.1 826.6 602.6 607.8 608.0 608.2 608.3 13166.5 13270.9 13475.6 13489.8 13490.5 12335.9 12631.7 12641.5 13153.9 13311.4 9029.8 9184.7 9431.3 9529.0 9643.5 2944.2 3014.3 3019.3 3020.7 3050.6 62690.4 62881.4 62886.4 63272.7 63361.4 9674.5 9791.8 9875.7 10053.3 10097.5 18510.6 18513.1 18562.4 18568.8 18581.3 6530.2 6538.9 6610.7 6635.8 6845.6 3486.8 3524.0 3545.5 3556.2 3590.2 2753.6 2888.7 2889.4 2896.7 2897.8 488.1 490.4 501.1 508.8 510.7 606.4 612.4 620.7 636.3 645.4 8083.0 8150.8 8424.0 8433.8 8434.5 593.8 603.5 615.7 630.3 639.2 3772.8 3849.4 3867.3 3900.3 4026.5 88556.6 89619.0 93457.0 93676.0 96739.0 79340.6 79781.0 80208.0 80401.2 81051.2 69632.0 70412.0 70417.3 71732.6 75739.0 7426.7 7611.5 7651.1 7654.0 7656.0 43108.6 43185.0 44769.6 45005.5 45455.5 61884.4 62126.7 62154.0 62404.0 62413.7 10062.7 10260.5 10412.6 10478.4 10734.1 10654.3 10657.6 10840.4 10865.8 11206.0 9884.0 10014.4 10151.5 10484.8 10682.4 9545.2 9618.1 9733.3 9888.4 9892.9 9609.9 9712.7 9822.8 9871.1 10032.9 7746.1 7758.8 7807.0 7816.0 7821.7 6995.0 7221.6 7304.5 7425.1 7511.1 04:29:46 INFO - PROCESS | 781 | -------- Summary: end -------- 04:29:46 INFO - PROCESS | 781 | 04:29:47 INFO - TEST-INFO | 781: exit 0 04:29:47 INFO - TEST-OK | dromaeo_css | took 1119111ms 04:29:47 INFO - TEST-START | kraken 04:29:47 INFO - operating with platform_type : linux_ 04:29:47 INFO - Initialising browser for kraken test... 04:29:47 INFO - TEST-INFO | started process 969 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRGoXBN/profile http://localhost:56512/getInfo.html) 04:29:51 INFO - PROCESS | 969 | __metrics Screen width/height:1600/1200 04:29:51 INFO - PROCESS | 969 | colorDepth:24 04:29:51 INFO - PROCESS | 969 | Browser inner width/height: 1024/697 04:29:51 INFO - PROCESS | 969 | __metrics 04:29:52 ERROR - PROCESS | 969 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 04:29:53 INFO - PROCESS | 969 | console.error: PushService: 04:29:53 INFO - PROCESS | 969 | stateChangeProcessEnqueue: Error transitioning state 04:29:53 INFO - PROCESS | 969 | UnknownError 04:29:53 INFO - TEST-INFO | 969: exit 0 04:29:53 INFO - Browser initialized. 04:29:53 INFO - Running cycle 1/1 for kraken test... 04:29:53 INFO - TEST-INFO | started process 1050 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRGoXBN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:30:05 INFO - PROCESS | 1050 | RSS: Main: 175357952 04:30:05 INFO - PROCESS | 1050 | 04:30:08 INFO - PROCESS | 1050 | Cycle 1(1): loaded http://localhost:56512/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56512/tests/kraken/driver.html?testName=audio-beat-detection) 04:30:09 INFO - PROCESS | 1050 | RSS: Main: 233111552 04:30:09 INFO - PROCESS | 1050 | 04:30:12 INFO - PROCESS | 1050 | Cycle 1(1): loaded http://localhost:56512/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56512/tests/kraken/driver.html?testName=audio-dft) 04:30:12 INFO - PROCESS | 1050 | RSS: Main: 218439680 04:30:12 INFO - PROCESS | 1050 | 04:30:16 INFO - PROCESS | 1050 | Cycle 1(1): loaded http://localhost:56512/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56512/tests/kraken/driver.html?testName=audio-fft) 04:30:16 INFO - PROCESS | 1050 | RSS: Main: 286519296 04:30:16 INFO - PROCESS | 1050 | 04:30:18 INFO - PROCESS | 1050 | Cycle 1(1): loaded http://localhost:56512/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56512/tests/kraken/driver.html?testName=audio-oscillator) 04:30:19 INFO - PROCESS | 1050 | RSS: Main: 197718016 04:30:19 INFO - PROCESS | 1050 | 04:30:21 INFO - PROCESS | 1050 | Cycle 1(1): loaded http://localhost:56512/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56512/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:30:22 INFO - PROCESS | 1050 | RSS: Main: 201183232 04:30:22 INFO - PROCESS | 1050 | 04:30:25 INFO - PROCESS | 1050 | Cycle 1(1): loaded http://localhost:56512/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56512/tests/kraken/driver.html?testName=imaging-darkroom) 04:30:26 INFO - PROCESS | 1050 | RSS: Main: 237629440 04:30:26 INFO - PROCESS | 1050 | 04:30:29 INFO - PROCESS | 1050 | Cycle 1(1): loaded http://localhost:56512/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56512/tests/kraken/driver.html?testName=imaging-desaturate) 04:30:30 INFO - PROCESS | 1050 | RSS: Main: 233394176 04:30:30 INFO - PROCESS | 1050 | 04:30:33 INFO - PROCESS | 1050 | Cycle 1(1): loaded http://localhost:56512/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56512/tests/kraken/driver.html?testName=json-parse-financial) 04:30:33 INFO - PROCESS | 1050 | RSS: Main: 235692032 04:30:33 INFO - PROCESS | 1050 | 04:30:35 INFO - PROCESS | 1050 | Cycle 1(1): loaded http://localhost:56512/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56512/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:30:36 INFO - PROCESS | 1050 | RSS: Main: 224083968 04:30:36 INFO - PROCESS | 1050 | 04:30:37 INFO - PROCESS | 1050 | Cycle 1(1): loaded http://localhost:56512/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56512/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:30:38 INFO - PROCESS | 1050 | RSS: Main: 225673216 04:30:38 INFO - PROCESS | 1050 | 04:30:40 INFO - PROCESS | 1050 | Cycle 1(1): loaded http://localhost:56512/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56512/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:30:41 INFO - PROCESS | 1050 | RSS: Main: 235151360 04:30:41 INFO - PROCESS | 1050 | 04:30:44 INFO - PROCESS | 1050 | Cycle 1(1): loaded http://localhost:56512/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56512/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:30:44 INFO - PROCESS | 1050 | RSS: Main: 238956544 04:30:44 INFO - PROCESS | 1050 | 04:30:47 INFO - PROCESS | 1050 | Cycle 1(1): loaded http://localhost:56512/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56512/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:30:48 INFO - PROCESS | 1050 | RSS: Main: 238493696 04:30:48 INFO - PROCESS | 1050 | 04:30:50 INFO - PROCESS | 1050 | Cycle 1(1): loaded http://localhost:56512/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56512/tests/kraken/driver.html?testName=ai-astar) 04:30:50 INFO - PROCESS | 1050 | RSS: Main: 281509888 04:30:50 INFO - PROCESS | 1050 | 04:30:50 INFO - PROCESS | 1050 | __start_tp_report 04:30:50 INFO - PROCESS | 1050 | _x_x_mozilla_page_load 04:30:50 INFO - PROCESS | 1050 | _x_x_mozilla_page_load_details 04:30:50 INFO - PROCESS | 1050 | |i|pagename|runs| 04:30:50 INFO - PROCESS | 1050 | |0;ai-astar;113;109;112;114;115;113;114;113;113;114 04:30:50 INFO - PROCESS | 1050 | |1;audio-beat-detection;163;135;134;184;136;152;151;132;187;131 04:30:50 INFO - PROCESS | 1050 | |2;audio-dft;162;162;162;162;162;162;163;163;161;163 04:30:50 INFO - PROCESS | 1050 | |3;audio-fft;99;77;76;106;76;77;74;77;98;76 04:30:50 INFO - PROCESS | 1050 | |4;audio-oscillator;86;86;113;85;87;85;120;86;86;116 04:30:50 INFO - PROCESS | 1050 | |5;imaging-gaussian-blur;117;117;117;117;117;118;117;117;117;117 04:30:50 INFO - PROCESS | 1050 | |6;imaging-darkroom;147;151;146;145;147;146;146;146;146;146 04:30:50 INFO - PROCESS | 1050 | |7;imaging-desaturate;95;95;94;95;95;95;95;95;95;94 04:30:50 INFO - PROCESS | 1050 | |8;json-parse-financial;64;63;62;64;64;62;62;63;63;63 04:30:50 INFO - PROCESS | 1050 | |9;json-stringify-tinderbox;64;64;64;65;65;66;65;65;65;64 04:30:50 INFO - PROCESS | 1050 | |10;stanford-crypto-aes;84;83;84;85;85;83;91;85;119;88 04:30:50 INFO - PROCESS | 1050 | |11;stanford-crypto-ccm;139;136;145;137;133;140;142;134;142;138 04:30:50 INFO - PROCESS | 1050 | |12;stanford-crypto-pbkdf2;172;170;170;171;176;176;171;171;172;176 04:30:50 INFO - PROCESS | 1050 | |13;stanford-crypto-sha256-iterative;68;68;74;66;67;66;65;65;68;65 04:30:50 INFO - PROCESS | 1050 | __end_tp_report 04:30:50 INFO - PROCESS | 1050 | __start_cc_report 04:30:50 INFO - PROCESS | 1050 | _x_x_mozilla_cycle_collect,1883 04:30:50 INFO - PROCESS | 1050 | __end_cc_report 04:30:50 INFO - PROCESS | 1050 | __startTimestamp1465471850431__endTimestamp 04:30:50 INFO - PROCESS | 1050 | 04:30:50 INFO - PROCESS | 1050 | ------- Summary: start ------- 04:30:50 INFO - PROCESS | 1050 | Number of tests: 14 04:30:50 INFO - PROCESS | 1050 | 04:30:50 INFO - PROCESS | 1050 | [#0] ai-astar Cycles:10 Average:113.00 Median:113.50 stddev:1.63 (1.4%) stddev-sans-first:1.73 04:30:50 INFO - PROCESS | 1050 | Values: 113.0 109.0 112.0 114.0 115.0 113.0 114.0 113.0 113.0 114.0 04:30:50 INFO - PROCESS | 1050 | 04:30:50 INFO - PROCESS | 1050 | [#1] audio-beat-detection Cycles:10 Average:150.50 Median:151.50 stddev:21.24 (14.0%) stddev-sans-first:22.04 04:30:50 INFO - PROCESS | 1050 | Values: 163.0 135.0 134.0 184.0 136.0 152.0 151.0 132.0 187.0 131.0 04:30:50 INFO - PROCESS | 1050 | 04:30:50 INFO - PROCESS | 1050 | [#2] audio-dft Cycles:10 Average:162.20 Median:162.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 04:30:50 INFO - PROCESS | 1050 | Values: 162.0 162.0 162.0 162.0 162.0 162.0 163.0 163.0 161.0 163.0 04:30:50 INFO - PROCESS | 1050 | 04:30:50 INFO - PROCESS | 1050 | [#3] audio-fft Cycles:10 Average:83.60 Median:77.00 stddev:12.21 (15.9%) stddev-sans-first:11.61 04:30:50 INFO - PROCESS | 1050 | Values: 99.0 77.0 76.0 106.0 76.0 77.0 74.0 77.0 98.0 76.0 04:30:50 INFO - PROCESS | 1050 | 04:30:50 INFO - PROCESS | 1050 | [#4] audio-oscillator Cycles:10 Average:95.00 Median:86.00 stddev:14.82 (17.2%) stddev-sans-first:15.36 04:30:50 INFO - PROCESS | 1050 | Values: 86.0 86.0 113.0 85.0 87.0 85.0 120.0 86.0 86.0 116.0 04:30:50 INFO - PROCESS | 1050 | 04:30:50 INFO - PROCESS | 1050 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 04:30:50 INFO - PROCESS | 1050 | Values: 117.0 117.0 117.0 117.0 117.0 118.0 117.0 117.0 117.0 117.0 04:30:50 INFO - PROCESS | 1050 | 04:30:50 INFO - PROCESS | 1050 | [#6] imaging-darkroom Cycles:10 Average:146.60 Median:146.00 stddev:1.65 (1.1%) stddev-sans-first:1.74 04:30:50 INFO - PROCESS | 1050 | Values: 147.0 151.0 146.0 145.0 147.0 146.0 146.0 146.0 146.0 146.0 04:30:50 INFO - PROCESS | 1050 | 04:30:50 INFO - PROCESS | 1050 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 04:30:50 INFO - PROCESS | 1050 | Values: 95.0 95.0 94.0 95.0 95.0 95.0 95.0 95.0 95.0 94.0 04:30:50 INFO - PROCESS | 1050 | 04:30:50 INFO - PROCESS | 1050 | [#8] json-parse-financial Cycles:10 Average:63.00 Median:63.00 stddev:0.82 (1.3%) stddev-sans-first:0.78 04:30:50 INFO - PROCESS | 1050 | Values: 64.0 63.0 62.0 64.0 64.0 62.0 62.0 63.0 63.0 63.0 04:30:50 INFO - PROCESS | 1050 | 04:30:50 INFO - PROCESS | 1050 | [#9] json-stringify-tinderbox Cycles:10 Average:64.70 Median:65.00 stddev:0.67 (1.0%) stddev-sans-first:0.67 04:30:50 INFO - PROCESS | 1050 | Values: 64.0 64.0 64.0 65.0 65.0 66.0 65.0 65.0 65.0 64.0 04:30:50 INFO - PROCESS | 1050 | 04:30:50 INFO - PROCESS | 1050 | [#10] stanford-crypto-aes Cycles:10 Average:88.70 Median:85.00 stddev:10.92 (12.9%) stddev-sans-first:11.45 04:30:50 INFO - PROCESS | 1050 | Values: 84.0 83.0 84.0 85.0 85.0 83.0 91.0 85.0 119.0 88.0 04:30:50 INFO - PROCESS | 1050 | 04:30:50 INFO - PROCESS | 1050 | [#11] stanford-crypto-ccm Cycles:10 Average:138.60 Median:139.50 stddev:3.78 (2.7%) stddev-sans-first:4.00 04:30:50 INFO - PROCESS | 1050 | Values: 139.0 136.0 145.0 137.0 133.0 140.0 142.0 134.0 142.0 138.0 04:30:50 INFO - PROCESS | 1050 | 04:30:50 INFO - PROCESS | 1050 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.50 Median:172.00 stddev:2.51 (1.5%) stddev-sans-first:2.65 04:30:50 INFO - PROCESS | 1050 | Values: 172.0 170.0 170.0 171.0 176.0 176.0 171.0 171.0 172.0 176.0 04:30:50 INFO - PROCESS | 1050 | 04:30:50 INFO - PROCESS | 1050 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.20 Median:67.50 stddev:2.70 (4.0%) stddev-sans-first:2.85 04:30:50 INFO - PROCESS | 1050 | Values: 68.0 68.0 74.0 66.0 67.0 66.0 65.0 65.0 68.0 65.0 04:30:50 INFO - PROCESS | 1050 | -------- Summary: end -------- 04:30:50 INFO - PROCESS | 1050 | 04:30:51 INFO - TEST-INFO | 1050: exit 0 04:30:51 INFO - TEST-OK | kraken | took 64413ms 04:30:51 INFO - SUITE-END | took 1183s 04:30:51 INFO - Completed test suite (00:19:43) 04:30:51 INFO - javascript benchmark 04:30:51 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2566.1403429851, 2575.6909170899494, 2598.6621739173906, 2601.8959241630328, 2613.529564678357, 4463.107378524292, 4545.636349092073, 4556.9088618227615, 4594.74728889911, 4598.678092533524, 4517.593416592506, 4564.338170965208, 4573.176828170928, 4573.656975726817, 4643.094596553673, 4182.121754431565, 4188.958110418903, 4245.957540424587, 4288.742675439468, 4361.563843615645, 4319.632831209351, 4328.935065974013, 4348.673849461287, 4351.956480435187, 4374.693771436001, 4147.4815648044, 4165.937510937339, 4187.8324867005285, 4233.830646774125, 4235.9364609530885, 4216.388623649554, 4231.365295205713, 4237.0466645004935, 4237.724547904377, 4237.724547904407, 4108.342665173588, 4226.323788193874, 4231.978840105779, 4232.217039847638, 4232.76719780412, 4477.48508921475, 4493.303537951622, 4508.188526065307, 4534.750588717619, 4539.795709193094, 4924.162892308281, 4925.458199598042, 4926.236433352836, 4926.4088309403105, 4928.186849169882, 4692.906141877143, 4866.343043689092, 4930.309756634074, 4948.752562371867, 4955.603551715854, 4618.468876079294, 4664.510226426177, 4664.5335466453425, 4668.043051174501, 4669.579737823612, 5084.237364395371, 5112.054269960069, 5127.564157046693, 5130.102232109366, 5134.101532231844, 4665.160271151225, 4689.648276379286, 4739.928901066487, 4740.241561350167, 4898.0, 4854.077725232195, 4862.805487780449, 4867.805287788519, 4873.098476781735, 4919.7540122993705, 4815.831445899376, 4828.444728856156, 4832.685875418087, 4835.758212089381, 4891.192953162759, 4665.86002419928, 4763.73799441034, 4811.975940120277, 4820.325154478376, 4823.3729615149805, 4127.504699436087, 4128.091819799639, 4130.752154870717, 4162.146759914211, 4180.205760905418, 3617.0, 3619.8914032579064, 3634.4184930411006, 3665.047087757149, 3675.044488433027, 4232.682548808852, 4238.6397156242065, 4287.656987440997, 4289.635380992589, 4296.720713153635, 4924.285978533093, 4931.112399768004, 4945.184044632595, 4946.802127914915, 4995.8001679932395, 4284.67864910133, 4288.678349123828, 4290.957090429056, 4293.69944103916, 4339.891502712458, 4296.119295544406, 4391.363252328394, 4422.75674837887, 4430.667699922455, 4444.622207112367, 4657.650676199299, 4672.649551283599, 4673.602743766818, 4682.297655351725, 4705.106029854385, 4787.784549695341, 4938.75306234694, 4948.802047918043, 4950.430700469492, 5023.32185155014, 4587.541245875519, 4643.5356464354645, 4648.8140474382, 4651.837185698484, 4661.463931647768, 4844.394450693663, 4872.3909511311085, 4879.634027447884, 4888.462269150319, 4929.580985616263, 4768.594669453136, 4805.879853003703, 4948.257761335828, 4952.826651067339, 5002.624803139852, 4665.6734028617675, 4704.341392205026, 4714.811407543797, 4721.7403042832975, 4776.737279449663, 4742.810287588458, 4745.383100196952, 4746.43042834862, 4778.880527986828, 4794.328793968777, 4608.124456353282, 4643.605293550086, 4680.485146633936, 4685.156671799109, 4718.363020992122, 4818.253170758538, 4842.951570484391, 4844.46710861812, 4880.731559764105, 4888.633352498506, 4761.833335833229, 4761.9285710713675, 4764.237721964469, 4765.380500534909, 4801.4718380977365], "value": 4509.418861353526, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [518.6369541321073, 558.6675927822945, 569.7777866632013, 573.2461812716281, 573.701675128933, 28545.857270713645, 30672.38655226894, 30672.539911901284, 30747.538786918216, 39172.60827391725, 37452.812735936284, 40923.18153636925, 40987.59012409875, 40988.795056024755, 41006.17987640253, 7792.844143117134, 7964.323032542241, 7974.242446967529, 7975.082865470458, 7977.16239794819, 7807.609619519029, 7883.921160788404, 7900.525968441883, 7905.0513938327485, 7906.169852165526, 7911.802204944894, 7983.0, 7985.6406461709075, 7985.760427187193, 7986.600669966479, 7869.606519674022, 7925.445218834713, 7944.6027698614835, 7946.7615971520945, 7957.084935232465, 7835.96082019592, 7843.294103530652, 7894.171112033211, 7900.920990790076, 7901.60491975399, 38285.42571861424, 38671.0, 38699.8065009676, 38744.225115497815, 38878.61121388778, 3020.622422197225, 3094.470617406397, 3121.2352973521406, 3190.7925984811145, 3317.3862835375535, 29266.268343291376, 29413.41173176546, 29463.0, 29908.700912991026, 29924.8503757482, 3348.79907205566, 3450.913727156816, 3469.5836499619954, 3515.5605549306338, 3546.946795798065, 262826.0, 264597.0, 266779.66610166826, 267596.0, 269922.0, 31714.524282135786, 53885.46114538804, 54711.72644136754, 54720.72639636776, 54776.17835732467, 31866.0, 34278.14304642354, 34329.828350858086, 34403.13992150216, 34417.82791086079, 13532.797008044887, 13603.795943060863, 13610.455581776816, 13720.93139534296, 13730.862691373159, 11402.315861048364, 11485.885141148648, 11499.080073594092, 11528.942355288338, 11569.0, 7794.8051298716855, 7903.288704016666, 7957.3634109271115, 7981.561014144278, 8017.238362355567, 3091.335362896988, 3115.6572776994967, 3173.936521269608, 3190.1067701043744, 3196.408664397094, 815.4129027100478, 882.8587426011808, 907.1518130547827, 943.9811203776023, 951.7335146159087, 27620.723792762215, 27942.022029229287, 28005.71994280072, 28442.004529841357, 28651.71348286532, 935.6538080910107, 962.5812771444444, 965.8020105878278, 966.6181858165985, 1004.8342023566175, 14369.6407589809, 14731.116133031837, 14755.614200816624, 14774.704505909822, 15013.924930375497, 367453.0, 370512.0, 375535.0, 376284.0, 377645.0, 48549.27176092361, 48859.0, 49264.50735492599, 49296.0, 49403.50596494061, 1076.3004047369116, 1180.8287798269203, 1187.4122309456875, 1206.1978784108644, 1212.4483360071322, 27936.30159246035, 28322.85838570794, 28741.42517149687, 28955.42089158247, 29287.0, 41040.38439423471, 41298.79350603228, 41772.0, 41774.16451670889, 41801.79099104485, 284627.0, 285391.0, 285665.0, 286071.11431085045, 286250.0, 21788.0, 24456.26631201067, 25016.62475062839, 25029.49941001206, 25257.116000939877, 41250.79374603108, 41573.584264158184, 41670.58329416788, 41844.79077604593, 41880.79059604804, 35150.12124696903, 35496.645033549335, 35733.46399804057, 36005.819970899975, 36250.8187459061, 35185.0, 35640.643593563735, 35955.82022089873, 36003.45994810132, 36310.27379452449, 34625.0, 35231.82384088063, 35251.47122793109, 35259.0, 35499.112522187155, 28905.42189156163, 31487.370252594363, 31512.52731208988, 31530.0, 31767.841160794047, 24322.148724794548, 24377.39056523601, 24596.0, 25001.0, 25203.369915752253], "value": 16322.20448313416, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [345.90141809584276, 348.1782992138553, 354.9414346632805, 357.4513122357179, 362.1381112951176, 12920.224786512816, 13446.32768361583, 15598.84401155988, 16189.109598972067, 17329.826701732996, 14782.630434239149, 15575.143367114804, 15593.766093508606, 16389.262483188257, 16426.917865410654, 4554.567316104964, 5041.747912604374, 5190.169572868342, 5206.479352064801, 5273.235380869772, 5008.774605142778, 5126.307948426952, 5130.6152038597065, 5151.76817043232, 5180.689158650474, 5096.5922726182, 5141.0489059523925, 5147.382314122292, 5147.716875571842, 5151.665141765773, 4986.850394488153, 5086.0, 5119.948800511985, 5148.202028685541, 5156.613254005946, 4493.505714371417, 4497.685162038659, 4503.437070366204, 4503.459584849807, 4506.256467682829, 18651.813481865145, 19807.504812379662, 19839.90080049605, 20532.794672053238, 20851.5829683407, 1837.5038739540382, 1867.253098760493, 1879.3234435603172, 1894.2612381171355, 2169.915042478761, 8875.423097498706, 9125.77185570366, 9402.106799854002, 9523.57143928525, 9649.903500965042, 1569.6389830338971, 1579.297212740331, 1612.5081850035735, 1639.5655151384892, 1649.2495914358938, 63783.68108159476, 67007.0, 68805.31194688089, 69489.65255173742, 69661.0, 9785.183778326458, 9797.461139637246, 9918.752031199278, 10024.398536087858, 10063.64140840977, 11740.647780566596, 12161.270323780602, 13357.532486363125, 13363.866361336262, 13376.197428154148, 7146.464015198777, 7416.737894941986, 7466.925330746732, 7556.773296801105, 7565.2812982766545, 7196.856062878713, 7239.04545772649, 7255.927440725631, 7396.482246242711, 7402.9629851850395, 4319.092990471973, 4338.154059958341, 4383.232934236559, 4418.116376724668, 4418.469783625986, 1717.8441056474046, 1786.606946471774, 1788.2936240185054, 1796.62270923105, 1852.1850385830191, 837.7696133563197, 845.8435189489841, 880.6169316347409, 893.9731808045769, 898.8786513820551, 16195.919020404823, 16582.17089145538, 16901.492955211117, 16968.915155424143, 17365.0, 858.3305022082785, 880.506916126971, 887.6050157679771, 900.594732370436, 931.9394239374419, 9400.200982916529, 9462.0, 9556.808863822824, 9703.854442183372, 9787.46168960714, 391636.0, 402811.0, 404995.0, 406122.0, 406349.0, 73495.0, 76159.23840761633, 77261.0, 77444.0, 79536.60231698805, 919.0671468459519, 920.7283851263893, 934.5140526926097, 945.9006804285589, 946.9337146399823, 15003.099814011195, 15034.32345544475, 15202.391904323704, 15224.46714364992, 15424.151671657717, 27027.02702702662, 28860.27849303784, 33723.83138084294, 34134.31731365309, 36548.63451365452, 41648.79175604103, 46591.53408465872, 47199.76400117978, 47838.76080619574, 48088.0, 6732.158480189976, 6956.652167391509, 7173.1392232932385, 7649.388048955959, 7785.805354866174, 11656.592019279284, 11814.232074915446, 11967.281963082243, 11970.58102966392, 12000.219985700902, 10057.69826905194, 10083.14293285079, 10147.49262536885, 10280.794384112127, 10365.429901355497, 10345.172386208935, 10545.367277963347, 10610.098141658045, 10792.352458852494, 10798.67603971882, 10113.64602238918, 10137.087662110445, 10192.643257485952, 10199.643012494824, 10364.481775911325, 7063.540869843444, 7223.9165368980175, 7232.710691572278, 7387.889181662387, 7401.59291238987, 8742.956285218788, 9110.088991100836, 9323.254139668674, 9328.0, 9948.403095814274], "value": 7970.178463688707, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1264.5574049082827, 1370.547719252647, 1418.3475601223436, 1434.648511114777, 1657.5110342448977, 6334.461570766484, 7115.6442177891095, 7357.3746231570385, 7394.038774959261, 7519.060117485315, 7304.196538380774, 7405.851882962337, 7407.851842963151, 7413.406927445805, 7420.332170104703, 2134.4877229464896, 2167.143978128638, 2169.1648715244587, 2174.1738139506965, 2174.967375489369, 2103.3584756649216, 2124.8300135989084, 2164.8051675349216, 2165.2096984600585, 2167.1331467413, 2078.740157480315, 2093.4661661276355, 2105.905234264462, 2107.346722516025, 2144.2602302205714, 2089.759677637076, 2097.81119699227, 2100.327895073577, 2100.737407824022, 2100.842436817245, 1989.5125694204867, 2062.061761898333, 2064.421961850684, 2066.545360020793, 2066.8346532277383, 7195.280471952815, 7383.6677349519405, 7450.105987281507, 7491.8501629967095, 7496.8125796854965, 4320.978395108035, 4381.934270985906, 4416.028473735773, 4420.977895110504, 4425.491068527129, 2690.0853709738585, 2824.5480723084206, 2858.056841242385, 2862.9284267893263, 2873.741363277315, 888.5424006636588, 899.3929097858985, 909.8771665825095, 917.5595714057223, 920.2270093121809, 9821.852672209923, 9859.556319965546, 9892.15916647086, 9913.65302214419, 9931.106200441995, 3701.574318953301, 3800.277947190025, 3832.6358995895343, 3834.0606551395085, 3852.5376954765607, 7784.260495252942, 7818.8827167592535, 7827.412944029106, 7848.568328741974, 7855.214478552099, 4243.321068629066, 4308.633766129851, 4327.32926396409, 4334.241507736134, 4337.7180483268485, 3460.79235245881, 3892.2993861104706, 3997.6801855851463, 4014.6386825185873, 4059.9594004060173, 3205.2627895584146, 3227.2738633807207, 3266.1671273825496, 3295.1762059485127, 3304.0253125328086, 940.2947789158131, 998.6854140945579, 998.7752755629925, 1002.5989604158395, 1003.2776400991274, 756.7994481462307, 782.8356045230565, 816.1308206759782, 828.2007862412801, 830.9376796740148, 5058.595312375001, 5081.5426611605135, 5082.847514574569, 5096.286519887145, 5096.439391666913, 833.9874901876477, 850.1625898489982, 850.3239924260228, 891.7324802559207, 897.8518544440094, 3472.6353732858192, 3531.4702794581017, 3544.91137721559, 3545.5213546170935, 3611.0, 8895.332850036273, 9018.729438116867, 9085.863712044325, 9137.680181193626, 9157.450552966844, 8980.730578082668, 9006.59470323837, 9061.68284110053, 9094.499802510925, 9122.179003889682, 6740.460763138937, 6823.420009299265, 6942.097527321416, 6952.93047069533, 6966.0, 4951.282064100757, 5013.222950442687, 5030.622703297194, 5031.119554077948, 5064.063148317573, 8369.330453563578, 8372.623231954454, 8416.452930559739, 8427.536485493356, 8498.065212826708, 8399.28606068491, 8566.957165214135, 8568.314534837073, 8644.96260448725, 8652.351073669373, 5486.231927530069, 6053.061775424816, 6216.751329946932, 6325.367463253638, 6327.145835312174, 7106.395956343768, 7241.094863142107, 7241.891371629325, 7244.963775181091, 7248.347648711641, 6420.26166990802, 6518.902216466851, 6568.146141001639, 6588.176477940257, 6611.371919667624, 6318.052292156213, 6478.449331806849, 6521.380468855451, 6587.604743715392, 6628.270890201978, 5653.095504719226, 5698.629589076697, 5708.4862362387585, 5711.257536520226, 5716.199732037435, 4221.97889010553, 4288.31386978082, 4299.118680670393, 4352.390665306796, 4352.499462561846, 4305.48334199898, 4337.089211265544, 4392.648588112879, 4446.110777844379, 4461.843835465743], "value": 3914.0036832038754, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [278.1987874920231, 282.66036775497497, 285.96139521164645, 292.28098876763164, 293.73710529076476, 4525.348247889521, 4681.789319480623, 4723.551262630049, 4762.428508578971, 4789.688670236436, 4550.522195169509, 4681.969966607349, 4688.32019357193, 4691.756684478607, 4700.318453824193, 3682.1531047859007, 3712.517372741553, 3721.423179407196, 3728.962710372902, 3737.2338670572603, 3478.8782392616263, 3561.483584880191, 3726.441033844918, 3726.77639341639, 3735.972607532923, 3662.7436079474446, 3668.3030224257304, 3692.926141477169, 3694.371956767356, 3701.5002974598356, 3655.780653160819, 3662.5421822272215, 3668.321360548307, 3675.7610755300952, 3685.3182161300247, 3253.511973204015, 3259.1689119274433, 3262.1518405214815, 3265.755068369882, 3276.918077048069, 4392.714473559208, 4586.885327866797, 4602.861914142581, 4617.353570500132, 4645.256758918591, 4104.733192342518, 4110.0, 4133.855315063958, 4160.45914031174, 4170.374443833419, 4901.65688401812, 4909.410870695539, 4924.704517728947, 4937.23472861707, 4938.777755000998, 3274.672532746706, 3462.601800792916, 3474.062003259131, 3485.268093700326, 3510.947335789965, 5071.923921141186, 5096.23556466533, 5108.233764935252, 5127.948720512784, 5134.974325128388, 3499.3001399720156, 3509.4560343146854, 3515.7538972272205, 3517.753757236969, 3524.8942531724088, 3564.8592450416136, 3565.893023209308, 3569.1255642367787, 3583.0, 3585.6952159066773, 3982.4623675803396, 4071.185762847442, 4100.138970816162, 4109.198706252312, 4118.279301122292, 4841.515848415201, 4848.224284114524, 4858.902821943612, 4890.853274401702, 4918.8770280743265, 1127.7631697343486, 1191.350713860948, 1234.9256147152034, 1240.231056744824, 1256.145820841818, 777.9222077792289, 782.1982467970375, 795.7055889320989, 795.7453614843195, 808.0747544062016, 3918.2555314490155, 3945.6054394560315, 3957.3288030579242, 3970.7021973352116, 3978.2839088963688, 4435.2016637005645, 4480.932786008212, 4483.461984561874, 4494.640428765691, 4511.142882852248, 3974.741641793274, 4002.3396139636634, 4015.6988225883174, 4018.8995275118355, 4033.838646454109, 2313.178821518337, 2383.41606306456, 2401.3516350585246, 2413.4328432818274, 2447.898445699442, 4240.554741752072, 4284.250256205151, 4295.892602684958, 4301.91396172081, 4312.792418122931, 4518.401918896648, 4527.660425468103, 4579.534548944373, 4580.816767329269, 4594.5864872161, 4092.8921605373257, 4258.84928111308, 4273.722208056466, 4341.218580655449, 4346.217680817484, 4519.706219095749, 4526.099038403812, 4533.954660453353, 4551.362809206647, 4557.612602928788, 4367.213901497761, 4381.67137464685, 4413.073254616438, 4436.0462500562535, 4460.977695111504, 4071.8371265149062, 4193.7693426861815, 4250.256205164146, 4262.87211383659, 4317.7193482423545, 3224.322892192572, 3233.579634647481, 3257.869685212565, 3268.3953468608383, 3284.3267130237764, 4544.363789069599, 4575.473820510684, 4612.0, 4637.426228443246, 4919.581835544019, 4735.289706544046, 4873.707577545359, 4929.531694489017, 4930.6795058321095, 4941.135301322182, 4920.6801557898625, 4943.752812359439, 4974.32846565709, 4978.726170060681, 5012.598992080698, 4597.448306203277, 4882.536159064884, 4883.413990321042, 4889.2910527972535, 4914.8771280718265, 4909.7545122743, 4950.648441990026, 4994.276974443811, 4995.5004499551205, 5005.124103281838, 4839.733814640229, 4868.440129385166, 4897.8734890974565, 4901.21580547125, 4935.062338155739], "value": 3566.409656759074, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [620.0921731906561, 683.5966779600042, 708.5536112249283, 711.8078118907895, 757.1935888278982, 12696.80954785679, 13643.249621270827, 13655.317234138278, 13656.180629162245, 13660.385282662279, 12959.740805183914, 14157.50448734292, 14359.425622975068, 14385.712285754278, 15200.923995380008, 624.1044101714032, 787.2009909941399, 791.8178818871663, 792.0614072324286, 793.5357815677835, 773.2036002916976, 796.191865256762, 799.256691277112, 799.3764863406552, 800.3597122302164, 829.601791140253, 829.8755186721979, 832.2592892325835, 832.488019867783, 832.5753865528563, 644.9935500644981, 797.8244786147038, 826.0459169659024, 826.0665448043702, 826.6486743134174, 602.5510994309268, 607.8389226854887, 607.9574429789916, 608.1668114682868, 608.3126067543692, 13166.539171128965, 13270.86729132706, 13475.595732128051, 13489.797653035212, 13490.52783152585, 12335.876641233652, 12631.684207894785, 12641.49434022638, 13153.947684185337, 13311.40098695561, 9029.819403611957, 9184.724458266262, 9431.339806213567, 9528.952355238249, 9643.469609171492, 2944.180137992889, 3014.291641464254, 3019.3055597212765, 3020.6828283030404, 3050.6186726659166, 62690.37309626891, 62881.37118628801, 62886.37113628851, 63272.68363658198, 63361.36638633647, 9674.467904265191, 9791.755206119762, 9875.703728888146, 10053.296269261082, 10097.545610447547, 18510.629787404177, 18513.074346282632, 18562.44312670622, 18568.81431185698, 18581.25674973013, 6530.249021362604, 6538.869222615521, 6610.7025183866845, 6635.767748128792, 6845.5550389224545, 3486.825658717105, 3524.0308915048054, 3545.4859045438266, 3556.2354093869944, 3590.2101537661674, 2753.6420265365373, 2888.725571070745, 2889.436559870805, 2896.6668833084045, 2897.8116422432477, 488.10920070870804, 490.4359986016039, 501.11803226321933, 508.81936912396304, 510.698687774215, 606.4178388746852, 612.4487960835284, 620.7299824576323, 636.3064259956669, 645.4158986117571, 8082.959585202154, 8150.796230094295, 8423.960468119687, 8433.83132337362, 8434.493930364199, 593.7506247376112, 603.5111559636708, 615.7198474694003, 630.3475902440952, 639.178655427773, 3772.754770939935, 3849.364854798983, 3867.3425517662067, 3900.278448487039, 4026.53694825093, 88556.5572172135, 89619.0, 93457.0, 93676.0, 96739.03260967441, 79340.60329698314, 79781.0, 80208.0, 80401.19598804053, 81051.18948810555, 69632.0, 70412.0, 70417.29582704107, 71732.64133679403, 75739.0, 7426.740064097947, 7611.467197296136, 7651.081870175614, 7654.043244594426, 7656.0, 43108.56891431171, 43184.99999999874, 44769.552304476536, 45005.54994450144, 45455.54544454513, 61884.38115618786, 62126.68936655288, 62154.0, 62404.0, 62413.68793156005, 10062.69811905644, 10260.486975651038, 10412.635557755442, 10478.423686697304, 10734.141268698642, 10654.25420220608, 10657.626983055556, 10840.403777791982, 10865.837012444978, 11206.047485963785, 9884.0, 10014.449205293779, 10151.54318055704, 10484.79030419372, 10682.359058456517, 9545.188658964065, 9618.086281803218, 9733.318667693193, 9888.406695598287, 9892.85160722604, 9609.9039009609, 9712.660056898258, 9822.75443113928, 9871.111599955751, 10032.899671003488, 7746.109197442366, 7758.7672369829, 7807.011005937786, 7815.960920195363, 7821.651990277686, 6994.965025174842, 7221.602811845399, 7304.452166087671, 7425.108986921604, 7511.136219334628], "value": 6275.7456363913225, "unit": "score"}], "name": "dromaeo_css", "value": 6097.561662994333, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 109.0, 112.0, 114.0, 115.0, 113.0, 114.0, 113.0, 113.0, 114.0], "value": 113.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 135.0, 134.0, 184.0, 136.0, 152.0, 151.0, 132.0, 187.0, 131.0], "value": 150.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 162.0, 162.0, 162.0, 162.0, 163.0, 163.0, 161.0, 163.0], "value": 162.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 77.0, 76.0, 106.0, 76.0, 77.0, 74.0, 77.0, 98.0, 76.0], "value": 83.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 113.0, 85.0, 87.0, 85.0, 120.0, 86.0, 86.0, 116.0], "value": 95.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 117.0, 117.0, 117.0, 117.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 151.0, 146.0, 145.0, 147.0, 146.0, 146.0, 146.0, 146.0, 146.0], "value": 146.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 62.0, 64.0, 64.0, 62.0, 62.0, 63.0, 63.0, 63.0], "value": 63.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 64.0, 65.0, 65.0, 66.0, 65.0, 65.0, 65.0, 64.0], "value": 64.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 84.0, 85.0, 85.0, 83.0, 91.0, 85.0, 119.0, 88.0], "value": 88.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 136.0, 145.0, 137.0, 133.0, 140.0, 142.0, 134.0, 142.0, 138.0], "value": 138.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 170.0, 170.0, 171.0, 176.0, 176.0, 171.0, 171.0, 172.0, 176.0], "value": 172.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 74.0, 66.0, 67.0, 66.0, 65.0, 65.0, 68.0, 65.0], "value": 67.2, "unit": "score"}], "name": "kraken", "value": 1557.5, "alertThreshold": 2.0}]} 04:30:51 INFO - Return code: 0 04:30:51 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:30:51 ERROR - # TBPL SUCCESS # 04:30:51 INFO - Running post-action listener: _resource_record_post_action 04:30:51 INFO - ##### 04:30:51 INFO - ##### Finished run-tests step (success) 04:30:51 INFO - ##### 04:30:51 INFO - Running post-run listener: _resource_record_post_run 04:30:51 INFO - Total resource usage - Wall time: 1201s; CPU: 13.0%; Read bytes: 4096; Write bytes: 535711744; Read time: 12; Write time: 542128 04:30:51 INFO - TinderboxPrint: CPU usage
13.2% 04:30:51 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 04:30:51 INFO - TinderboxPrint: I/O write bytes / time
535,711,744 / 542,128 04:30:51 INFO - TinderboxPrint: CPU idle
8,314.6 (86.8%) 04:30:51 INFO - TinderboxPrint: CPU user
1,219.8 (12.7%) 04:30:51 INFO - TinderboxPrint: Swap in / out
0 / 0 04:30:51 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 196141056; Read time: 0; Write time: 220264 04:30:51 INFO - run-tests - Wall time: 1185s; CPU: 13.0%; Read bytes: 4096; Write bytes: 297197568; Read time: 12; Write time: 310980 04:30:52 INFO - Running post-run listener: _upload_blobber_files 04:30:52 INFO - Blob upload gear active. 04:30:52 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:30:52 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 04:30:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:30:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:30:52 INFO - (blobuploader) - INFO - Open directory for files ... 04:30:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:30:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:30:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:30:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:30:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:30:54 INFO - (blobuploader) - INFO - Done attempting. 04:30:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:30:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:30:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:30:58 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:30:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:30:58 INFO - (blobuploader) - INFO - Done attempting. 04:30:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:30:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:30:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:30:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:30:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:30:58 INFO - (blobuploader) - INFO - Done attempting. 04:30:58 INFO - (blobuploader) - INFO - Iteration through files over. 04:30:58 INFO - Return code: 0 04:30:58 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:30:58 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:30:58 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c8303c8b35a70d8683c1e2ce62aebc162f7c49379b0644686312e3e6943fc7c4d7c41f3da89702676cfc6694e591f62da64ab8ac027d5e383b2b1485c5e9256c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/99ff0396fd6fc1d651fdbe2cd000fd6747018cc1602387d2b2924d65cbf5c1a77496935492d4db2751db56355daad529d1e2c0536c4697fb83b24f9426feb683", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fe6d44dc61db8b5799da1af97493794ef5adb559cc549376ea9557424cc0aba3a9542e7626e99f7f21addeabdf0d00eefaef1806d82ad1be93ce9affabafc9fa"} 04:30:58 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:30:58 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:30:58 INFO - Contents: 04:30:58 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c8303c8b35a70d8683c1e2ce62aebc162f7c49379b0644686312e3e6943fc7c4d7c41f3da89702676cfc6694e591f62da64ab8ac027d5e383b2b1485c5e9256c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/99ff0396fd6fc1d651fdbe2cd000fd6747018cc1602387d2b2924d65cbf5c1a77496935492d4db2751db56355daad529d1e2c0536c4697fb83b24f9426feb683", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fe6d44dc61db8b5799da1af97493794ef5adb559cc549376ea9557424cc0aba3a9542e7626e99f7f21addeabdf0d00eefaef1806d82ad1be93ce9affabafc9fa"} 04:30:58 INFO - Running post-run listener: copy_logs_to_upload_dir 04:30:58 INFO - Copying logs to upload dir... 04:30:58 INFO - mkdir: /builds/slave/test/build/upload/logs 04:30:58 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1251.034584 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2016-06-09 04:30:58.280292) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-09 04:30:58.283941) ========= 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=920470bf432669ad7e3a5387000001ca-1465468442.500350-1997601859 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c8303c8b35a70d8683c1e2ce62aebc162f7c49379b0644686312e3e6943fc7c4d7c41f3da89702676cfc6694e591f62da64ab8ac027d5e383b2b1485c5e9256c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/99ff0396fd6fc1d651fdbe2cd000fd6747018cc1602387d2b2924d65cbf5c1a77496935492d4db2751db56355daad529d1e2c0536c4697fb83b24f9426feb683", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fe6d44dc61db8b5799da1af97493794ef5adb559cc549376ea9557424cc0aba3a9542e7626e99f7f21addeabdf0d00eefaef1806d82ad1be93ce9affabafc9fa"} build_url:https://queue.taskcluster.net/v1/task/dGeUCIvaTC-yhn-fZQ-qbA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011348 build_url: 'https://queue.taskcluster.net/v1/task/dGeUCIvaTC-yhn-fZQ-qbA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c8303c8b35a70d8683c1e2ce62aebc162f7c49379b0644686312e3e6943fc7c4d7c41f3da89702676cfc6694e591f62da64ab8ac027d5e383b2b1485c5e9256c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/99ff0396fd6fc1d651fdbe2cd000fd6747018cc1602387d2b2924d65cbf5c1a77496935492d4db2751db56355daad529d1e2c0536c4697fb83b24f9426feb683", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fe6d44dc61db8b5799da1af97493794ef5adb559cc549376ea9557424cc0aba3a9542e7626e99f7f21addeabdf0d00eefaef1806d82ad1be93ce9affabafc9fa"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-09 04:30:58.313895) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 04:30:58.314585) ========= 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=920470bf432669ad7e3a5387000001ca-1465468442.500350-1997601859 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004532 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 04:30:58.394709) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-09 04:30:58.395042) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-09 04:30:58.395662) ========= ========= Total master_lag: 0.17 =========