builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-038 starttime: 1466614765.84 results: success (0) buildid: 20160622073017 builduid: d623d88932c74e69b5e823469afb9bb4 revision: 812e027b2adeaadb9b11db9303327300512a2ec9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-22 09:59:25.839180) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-22 09:59:25.839679) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-22 09:59:25.840018) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-22 09:59:25.910467) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 09:59:25.910886) ========= 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=8783db0840cc980e80bb0bd400000236-1466613596.232306-769184124 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-22 09:59:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 67.0M=0s 2016-06-22 09:59:26 (67.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.122012 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 09:59:26.059378) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 09:59:26.059801) ========= 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=8783db0840cc980e80bb0bd400000236-1466613596.232306-769184124 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014860 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 09:59:26.124829) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 09:59:26.125280) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 812e027b2adeaadb9b11db9303327300512a2ec9 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 812e027b2adeaadb9b11db9303327300512a2ec9 --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=8783db0840cc980e80bb0bd400000236-1466613596.232306-769184124 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-22 09:59:26,222 truncating revision to first 12 chars 2016-06-22 09:59:26,222 Setting DEBUG logging. 2016-06-22 09:59:26,222 attempt 1/10 2016-06-22 09:59:26,222 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/812e027b2ade?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-22 09:59:26,548 unpacking tar archive at: mozilla-inbound-812e027b2ade/testing/mozharness/ program finished with exit code 0 elapsedTime=0.670656 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 09:59:26.812548) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-22 09:59:26.812903) ========= script_repo_revision: 812e027b2adeaadb9b11db9303327300512a2ec9 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-22 09:59:26.813355) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-22 09:59:26.813700) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-22 09:59:26.842176) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2016-06-22 09:59:26.842543) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 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', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] 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=8783db0840cc980e80bb0bd400000236-1466613596.232306-769184124 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:59:27 INFO - MultiFileLogger online at 20160622 09:59:27 in /builds/slave/test 09:59:27 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 09:59:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:59:27 INFO - {'append_to_log': False, 09:59:27 INFO - 'base_work_dir': '/builds/slave/test', 09:59:27 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 09:59:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:59:27 INFO - 'branch': 'Mozilla-Inbound', 09:59:27 INFO - 'buildbot_json_path': 'buildprops.json', 09:59:27 INFO - 'config_files': ('talos/linux_config.py',), 09:59:27 INFO - 'default_actions': ('clobber', 09:59:27 INFO - 'read-buildbot-config', 09:59:27 INFO - 'download-and-extract', 09:59:27 INFO - 'populate-webroot', 09:59:27 INFO - 'create-virtualenv', 09:59:27 INFO - 'install', 09:59:27 INFO - 'run-tests'), 09:59:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:59:27 INFO - 'download_minidump_stackwalk': True, 09:59:27 INFO - 'download_symbols': 'ondemand', 09:59:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:59:27 INFO - 'tooltool.py': '/tools/tooltool.py', 09:59:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:59:27 INFO - '/tools/misc-python/virtualenv.py')}, 09:59:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:59:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:59:27 INFO - 'installer_path': 'installer.exe', 09:59:27 INFO - 'log_level': 'info', 09:59:27 INFO - 'log_name': 'talos', 09:59:27 INFO - 'log_to_console': True, 09:59:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:59:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:59:27 INFO - 'opt_config_files': (), 09:59:27 INFO - 'pip_index': False, 09:59:27 INFO - 'sps_profile': False, 09:59:27 INFO - 'sps_profile_interval': 0, 09:59:27 INFO - 'suite': 'dromaeojs', 09:59:27 INFO - 'system_bits': '32', 09:59:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:59:27 INFO - 'title': 'talos-linux64-ix-038', 09:59:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:59:27 INFO - 'use_talos_json': True, 09:59:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:59:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:59:27 INFO - 'work_dir': 'build'} 09:59:27 INFO - ##### 09:59:27 INFO - ##### Running clobber step. 09:59:27 INFO - ##### 09:59:27 INFO - Running pre-action listener: _resource_record_pre_action 09:59:27 INFO - Running main action method: clobber 09:59:27 INFO - rmtree: /builds/slave/test/build 09:59:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:59:28 INFO - Running post-action listener: _resource_record_post_action 09:59:28 INFO - ##### 09:59:28 INFO - ##### Finished clobber step (success) 09:59:28 INFO - ##### 09:59:28 INFO - ##### 09:59:28 INFO - ##### Running read-buildbot-config step. 09:59:28 INFO - ##### 09:59:28 INFO - Running pre-action listener: _resource_record_pre_action 09:59:28 INFO - Running main action method: read_buildbot_config 09:59:28 INFO - Using buildbot properties: 09:59:28 INFO - { 09:59:28 INFO - "project": "", 09:59:28 INFO - "product": "firefox", 09:59:28 INFO - "script_repo_revision": "production", 09:59:28 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 09:59:28 INFO - "repository": "", 09:59:28 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 09:59:28 INFO - "buildid": "20160622073017", 09:59:28 INFO - "pgo_build": "True", 09:59:28 INFO - "basedir": "/builds/slave/test", 09:59:28 INFO - "buildnumber": 1149, 09:59:28 INFO - "slavename": "talos-linux64-ix-038", 09:59:28 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 09:59:28 INFO - "platform": "ubuntu64_hw", 09:59:28 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 09:59:28 INFO - "branch": "mozilla-inbound", 09:59:28 INFO - "repo_path": "integration/mozilla-inbound", 09:59:28 INFO - "revision": "812e027b2adeaadb9b11db9303327300512a2ec9", 09:59:28 INFO - "stage_platform": "linux64-pgo", 09:59:28 INFO - "builduid": "d623d88932c74e69b5e823469afb9bb4", 09:59:28 INFO - "slavebuilddir": "test" 09:59:28 INFO - } 09:59:28 INFO - Found installer url https://queue.taskcluster.net/v1/task/cx0oPaHhS_OO8wzmZreKwg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 09:59:28 INFO - Running post-action listener: _resource_record_post_action 09:59:28 INFO - ##### 09:59:28 INFO - ##### Finished read-buildbot-config step (success) 09:59:28 INFO - ##### 09:59:28 INFO - ##### 09:59:28 INFO - ##### Running download-and-extract step. 09:59:28 INFO - ##### 09:59:28 INFO - Running pre-action listener: _resource_record_pre_action 09:59:28 INFO - Running main action method: download_and_extract 09:59:28 INFO - mkdir: /builds/slave/test/build/tests 09:59: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')]} 09:59:28 INFO - https://queue.taskcluster.net/v1/task/cx0oPaHhS_OO8wzmZreKwg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 09:59:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cx0oPaHhS_OO8wzmZreKwg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 09:59:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cx0oPaHhS_OO8wzmZreKwg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 09:59:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cx0oPaHhS_OO8wzmZreKwg/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 09:59:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cx0oPaHhS_OO8wzmZreKwg/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 09:59:36 INFO - Downloaded 1361 bytes. 09:59:36 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 09:59:36 INFO - Using the following test package requirements: 09:59:36 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 09:59:36 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:59:36 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:59:36 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:59:36 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 09:59:36 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:59:36 INFO - u'jsshell-linux-x86_64.zip'], 09:59:36 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:59:36 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:59:36 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 09:59:36 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:59:36 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:59:36 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:59:36 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:59:36 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:59:36 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:59:36 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:59:36 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:59:36 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:59: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')]} 09:59:36 INFO - https://queue.taskcluster.net/v1/task/cx0oPaHhS_OO8wzmZreKwg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:59:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cx0oPaHhS_OO8wzmZreKwg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 09:59:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cx0oPaHhS_OO8wzmZreKwg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 09:59:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cx0oPaHhS_OO8wzmZreKwg/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 09:59:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cx0oPaHhS_OO8wzmZreKwg/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 09:59:42 INFO - Downloaded 24269662 bytes. 09:59:42 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'] 09:59:42 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 09:59:43 INFO - Return code: 0 09:59:43 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 09:59: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')]} 09:59:43 INFO - https://queue.taskcluster.net/v1/task/cx0oPaHhS_OO8wzmZreKwg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:59:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cx0oPaHhS_OO8wzmZreKwg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 09:59:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cx0oPaHhS_OO8wzmZreKwg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 09:59:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cx0oPaHhS_OO8wzmZreKwg/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 09:59:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cx0oPaHhS_OO8wzmZreKwg/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 09:59:45 INFO - Downloaded 24269662 bytes. 09:59:45 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'] 09:59:45 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 09:59:46 INFO - Return code: 0 09:59: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')]} 09:59:46 INFO - https://queue.taskcluster.net/v1/task/cx0oPaHhS_OO8wzmZreKwg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 09:59:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cx0oPaHhS_OO8wzmZreKwg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 09:59:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cx0oPaHhS_OO8wzmZreKwg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 09:59:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cx0oPaHhS_OO8wzmZreKwg/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 09:59:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cx0oPaHhS_OO8wzmZreKwg/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 09:59:48 INFO - Downloaded 14405384 bytes. 09:59:48 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'] 09:59:48 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 09:59:48 INFO - Return code: 0 09:59:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:59:48 INFO - https://queue.taskcluster.net/v1/task/cx0oPaHhS_OO8wzmZreKwg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 09:59:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cx0oPaHhS_OO8wzmZreKwg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 09:59:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cx0oPaHhS_OO8wzmZreKwg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 09:59:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cx0oPaHhS_OO8wzmZreKwg/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 09:59:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cx0oPaHhS_OO8wzmZreKwg/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 09:59:50 INFO - Downloaded 60151008 bytes. 09:59:50 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/cx0oPaHhS_OO8wzmZreKwg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 09:59:50 INFO - mkdir: /builds/slave/test/properties 09:59:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:59:50 INFO - Writing to file /builds/slave/test/properties/build_url 09:59:50 INFO - Contents: 09:59:50 INFO - build_url:https://queue.taskcluster.net/v1/task/cx0oPaHhS_OO8wzmZreKwg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 09:59:50 INFO - Running post-action listener: _resource_record_post_action 09:59:50 INFO - Running post-action listener: set_extra_try_arguments 09:59:50 INFO - ##### 09:59:50 INFO - ##### Finished download-and-extract step (success) 09:59:50 INFO - ##### 09:59:50 INFO - ##### 09:59:50 INFO - ##### Running populate-webroot step. 09:59:50 INFO - ##### 09:59:50 INFO - Running pre-action listener: _resource_record_pre_action 09:59:50 INFO - Running main action method: populate_webroot 09:59:50 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:59:50 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:59:50 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:59:50 INFO - '--tppagecycles', 09:59:50 INFO - '7'], 09:59:50 INFO - 'tests': ['tsvgm']}}, 09:59:50 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:59:50 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:59:50 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:59:50 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:59:50 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:59:50 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:59:50 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:59:50 INFO - 'talos_options': ['--disable-e10s'], 09:59:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:59:50 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:59:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:59:50 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:59:50 INFO - 'talos_options': ['--disable-e10s'], 09:59:50 INFO - 'tests': ['damp', 'tps']}, 09:59:50 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:59:50 INFO - 'tests': ['damp', 'tps']}, 09:59:50 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:59:50 INFO - 'tests': ['dromaeo_dom']}, 09:59:50 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:59:50 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:59:50 INFO - 'tests': ['basic_compositor_video']}, 09:59:50 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:59:50 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:59:50 INFO - 'tests': ['a11yr', 09:59:50 INFO - 'ts_paint', 09:59:50 INFO - 'tpaint', 09:59:50 INFO - 'sessionrestore', 09:59:50 INFO - 'sessionrestore_no_auto_restore', 09:59:50 INFO - 'tabpaint']}, 09:59:50 INFO - 'other-e10s': {'tests': ['a11yr', 09:59:50 INFO - 'ts_paint', 09:59:50 INFO - 'tpaint', 09:59:50 INFO - 'sessionrestore', 09:59:50 INFO - 'sessionrestore_no_auto_restore', 09:59:50 INFO - 'tabpaint']}, 09:59:50 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:59:50 INFO - 'ts_paint', 09:59:50 INFO - 'tpaint', 09:59:50 INFO - 'sessionrestore', 09:59:50 INFO - 'sessionrestore_no_auto_restore', 09:59:50 INFO - 'tabpaint']}, 09:59:50 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:59:50 INFO - 'ts_paint', 09:59:50 INFO - 'tpaint', 09:59:50 INFO - 'sessionrestore', 09:59:50 INFO - 'sessionrestore_no_auto_restore', 09:59:50 INFO - 'tabpaint']}, 09:59:50 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:59:50 INFO - 'tests': ['a11yr', 09:59:50 INFO - 'ts_paint', 09:59:50 INFO - 'tpaint', 09:59:50 INFO - 'sessionrestore', 09:59:50 INFO - 'sessionrestore_no_auto_restore', 09:59:50 INFO - 'tabpaint']}, 09:59:50 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:59:50 INFO - 'tests': ['a11yr', 09:59:50 INFO - 'ts_paint', 09:59:50 INFO - 'tpaint', 09:59:50 INFO - 'sessionrestore', 09:59:50 INFO - 'sessionrestore_no_auto_restore', 09:59:50 INFO - 'tabpaint']}, 09:59:50 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:59:50 INFO - 'tests': ['tsvgx', 09:59:50 INFO - 'tsvgr_opacity', 09:59:50 INFO - 'tart', 09:59:50 INFO - 'tscrollx', 09:59:50 INFO - 'cart']}, 09:59:50 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:59:50 INFO - 'tsvgr_opacity', 09:59:50 INFO - 'tart', 09:59:50 INFO - 'tscrollx', 09:59:50 INFO - 'cart']}, 09:59:50 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:59:50 INFO - 'talos_options': ['--disable-e10s'], 09:59:50 INFO - 'tests': ['tp5o']}, 09:59:50 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:59:50 INFO - 'tests': ['tp5o']}, 09:59:50 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:59:50 INFO - 'talos_options': ['--disable-e10s', 09:59:50 INFO - '--xperf_path', 09:59:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:59:50 INFO - 'tests': ['tp5n']}, 09:59:50 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:59:50 INFO - 'talos_options': ['--xperf_path', 09:59:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:59:50 INFO - 'tests': ['tp5n']}}, 09:59:50 INFO - 'talos.zip': {'path': '', 09:59:50 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:59:50 INFO - Running post-action listener: _resource_record_post_action 09:59:50 INFO - ##### 09:59:50 INFO - ##### Finished populate-webroot step (success) 09:59:50 INFO - ##### 09:59:50 INFO - ##### 09:59:50 INFO - ##### Running create-virtualenv step. 09:59:50 INFO - ##### 09:59:50 INFO - Running pre-action listener: _resource_record_pre_action 09:59:50 INFO - Running main action method: create_virtualenv 09:59:50 INFO - Creating virtualenv /builds/slave/test/build/venv 09:59:50 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 09:59:50 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:59:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:59:51 INFO - Using real prefix '/usr' 09:59:51 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:59:51 INFO - Installing distribute.............................................................................................................................................................................................done. 09:59:53 INFO - Installing pip.................done. 09:59:53 INFO - Return code: 0 09:59:53 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:59:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 09:59:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:59:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:59:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 09:59:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:59:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:59:53 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 0x7fa965c8ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xcf6020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd882e0>, '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 0xcf4140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xcf45d0>, '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': '8783db0840cc980e80bb0bd400000236-1466613596.232306-769184124', '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 09:59:53 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 09:59:53 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 09:59:53 INFO - Using env: {'DISPLAY': ':0', 09:59:53 INFO - 'HOME': '/home/cltbld', 09:59:53 INFO - 'LANG': 'en_US.UTF-8', 09:59:53 INFO - 'LANGUAGE': 'en_US:en', 09:59:53 INFO - 'LOGNAME': 'cltbld', 09:59:53 INFO - 'MAIL': '/var/mail/cltbld', 09:59:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:59:53 INFO - 'MOZ_NO_REMOTE': '1', 09:59:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:59:53 INFO - 'NO_EM_RESTART': '1', 09:59:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:59:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:59:53 INFO - 'PWD': '/builds/slave/test', 09:59:53 INFO - 'SHELL': '/bin/bash', 09:59:53 INFO - 'SHLVL': '1', 09:59:53 INFO - 'TERM': 'linux', 09:59:53 INFO - 'TMOUT': '86400', 09:59:53 INFO - 'USER': 'cltbld', 09:59:53 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1466613596.232306-769184124', 09:59:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:59:53 INFO - '_': '/tools/buildbot/bin/python'} 09:59:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:59:53 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 09:59:53 INFO - Cleaning up... 09:59:53 INFO - Return code: 0 09:59:53 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:59:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 09:59:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:59:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:59:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 09:59:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:59:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:59:53 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 0x7fa965c8ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xcf6020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd882e0>, '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 0xcf4140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xcf45d0>, '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': '8783db0840cc980e80bb0bd400000236-1466613596.232306-769184124', '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 09:59:53 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 09:59:53 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 09:59:53 INFO - Using env: {'DISPLAY': ':0', 09:59:53 INFO - 'HOME': '/home/cltbld', 09:59:53 INFO - 'LANG': 'en_US.UTF-8', 09:59:53 INFO - 'LANGUAGE': 'en_US:en', 09:59:53 INFO - 'LOGNAME': 'cltbld', 09:59:53 INFO - 'MAIL': '/var/mail/cltbld', 09:59:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:59:53 INFO - 'MOZ_NO_REMOTE': '1', 09:59:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:59:53 INFO - 'NO_EM_RESTART': '1', 09:59:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:59:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:59:53 INFO - 'PWD': '/builds/slave/test', 09:59:53 INFO - 'SHELL': '/bin/bash', 09:59:53 INFO - 'SHLVL': '1', 09:59:53 INFO - 'TERM': 'linux', 09:59:53 INFO - 'TMOUT': '86400', 09:59:53 INFO - 'USER': 'cltbld', 09:59:53 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1466613596.232306-769184124', 09:59:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:59:53 INFO - '_': '/tools/buildbot/bin/python'} 09:59:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:59:53 INFO - Downloading/unpacking psutil>=3.1.1 09:59:53 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 09:59:53 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 09:59:53 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 09:59:53 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 09:59:53 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 09:59:53 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 09:59:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:59:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:59:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:59:55 INFO - Installing collected packages: psutil 09:59:55 INFO - Running setup.py install for psutil 09:59:56 INFO - building 'psutil._psutil_linux' extension 09:59:56 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 09:59:56 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 09:59:56 INFO - building 'psutil._psutil_posix' extension 09:59:56 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 09:59:56 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 09:59:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:59:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:59:56 INFO - Successfully installed psutil 09:59:56 INFO - Cleaning up... 09:59:56 INFO - Return code: 0 09:59:56 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:59:56 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')]} 09:59:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:59:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:59:56 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')]} 09:59:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:59:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:59:56 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 0x7fa965c8ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xcf6020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd882e0>, '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 0xcf4140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xcf45d0>, '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': '8783db0840cc980e80bb0bd400000236-1466613596.232306-769184124', '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 09:59:56 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 09:59:56 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 09:59:56 INFO - Using env: {'DISPLAY': ':0', 09:59:56 INFO - 'HOME': '/home/cltbld', 09:59:56 INFO - 'LANG': 'en_US.UTF-8', 09:59:56 INFO - 'LANGUAGE': 'en_US:en', 09:59:56 INFO - 'LOGNAME': 'cltbld', 09:59:56 INFO - 'MAIL': '/var/mail/cltbld', 09:59:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:59:56 INFO - 'MOZ_NO_REMOTE': '1', 09:59:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:59:56 INFO - 'NO_EM_RESTART': '1', 09:59:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:59:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:59:56 INFO - 'PWD': '/builds/slave/test', 09:59:56 INFO - 'SHELL': '/bin/bash', 09:59:56 INFO - 'SHLVL': '1', 09:59:56 INFO - 'TERM': 'linux', 09:59:56 INFO - 'TMOUT': '86400', 09:59:56 INFO - 'USER': 'cltbld', 09:59:56 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1466613596.232306-769184124', 09:59:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:59:56 INFO - '_': '/tools/buildbot/bin/python'} 09:59:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:59:56 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:59:56 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 09:59:56 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 09:59:56 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 09:59:56 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 09:59:56 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 09:59:56 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 09:59:58 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:59:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:59:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:59:58 INFO - Installing collected packages: mozsystemmonitor 09:59:58 INFO - Running setup.py install for mozsystemmonitor 09:59:58 INFO - Successfully installed mozsystemmonitor 09:59:58 INFO - Cleaning up... 09:59:58 INFO - Return code: 0 09:59:58 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:59:58 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')]} 09:59:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:59:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:59:58 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')]} 09:59:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:59:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:59:58 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 0x7fa965c8ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xcf6020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd882e0>, '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 0xcf4140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xcf45d0>, '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': '8783db0840cc980e80bb0bd400000236-1466613596.232306-769184124', '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 09:59:58 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 09:59:58 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 09:59:58 INFO - Using env: {'DISPLAY': ':0', 09:59:58 INFO - 'HOME': '/home/cltbld', 09:59:58 INFO - 'LANG': 'en_US.UTF-8', 09:59:58 INFO - 'LANGUAGE': 'en_US:en', 09:59:58 INFO - 'LOGNAME': 'cltbld', 09:59:58 INFO - 'MAIL': '/var/mail/cltbld', 09:59:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:59:58 INFO - 'MOZ_NO_REMOTE': '1', 09:59:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:59:58 INFO - 'NO_EM_RESTART': '1', 09:59:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:59:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:59:58 INFO - 'PWD': '/builds/slave/test', 09:59:58 INFO - 'SHELL': '/bin/bash', 09:59:58 INFO - 'SHLVL': '1', 09:59:58 INFO - 'TERM': 'linux', 09:59:58 INFO - 'TMOUT': '86400', 09:59:58 INFO - 'USER': 'cltbld', 09:59:58 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1466613596.232306-769184124', 09:59:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:59:58 INFO - '_': '/tools/buildbot/bin/python'} 09:59:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:59:59 INFO - Downloading/unpacking jsonschema==2.5.1 09:59:59 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 09:59:59 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 09:59:59 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 09:59:59 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 09:59:59 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 09:59:59 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 10:00:00 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:00:00 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:00:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:00:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:00:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:00:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:00:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:00:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:00:01 INFO - Downloading functools32-3.2.3-2.tar.gz 10:00:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:00:01 INFO - warning: no files found matching '*.txt' 10:00:01 INFO - no previously-included directories found matching 'build' 10:00:01 INFO - no previously-included directories found matching 'dist' 10:00:01 INFO - no previously-included directories found matching '.git*' 10:00:01 INFO - Installing collected packages: jsonschema, functools32 10:00:01 INFO - Running setup.py install for functools32 10:00:01 INFO - warning: no files found matching '*.txt' 10:00:01 INFO - no previously-included directories found matching 'build' 10:00:01 INFO - no previously-included directories found matching 'dist' 10:00:01 INFO - no previously-included directories found matching '.git*' 10:00:01 INFO - Successfully installed jsonschema functools32 10:00:01 INFO - Cleaning up... 10:00:01 INFO - Return code: 0 10:00:01 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:00:01 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')]} 10:00:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:00:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:00:01 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')]} 10:00:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:00:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:00:01 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 0x7fa965c8ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xcf6020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd882e0>, '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 0xcf4140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xcf45d0>, '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': '8783db0840cc980e80bb0bd400000236-1466613596.232306-769184124', '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 10:00:01 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 10:00:01 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 10:00:01 INFO - Using env: {'DISPLAY': ':0', 10:00:01 INFO - 'HOME': '/home/cltbld', 10:00:01 INFO - 'LANG': 'en_US.UTF-8', 10:00:01 INFO - 'LANGUAGE': 'en_US:en', 10:00:01 INFO - 'LOGNAME': 'cltbld', 10:00:01 INFO - 'MAIL': '/var/mail/cltbld', 10:00:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:00:01 INFO - 'MOZ_NO_REMOTE': '1', 10:00:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:00:01 INFO - 'NO_EM_RESTART': '1', 10:00:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:00:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:00:01 INFO - 'PWD': '/builds/slave/test', 10:00:01 INFO - 'SHELL': '/bin/bash', 10:00:01 INFO - 'SHLVL': '1', 10:00:01 INFO - 'TERM': 'linux', 10:00:01 INFO - 'TMOUT': '86400', 10:00:01 INFO - 'USER': 'cltbld', 10:00:01 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1466613596.232306-769184124', 10:00:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:00:01 INFO - '_': '/tools/buildbot/bin/python'} 10:00:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:00:01 INFO - Downloading/unpacking blobuploader==1.2.4 10:00:01 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 10:00:01 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 10:00:01 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 10:00:01 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 10:00:01 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 10:00:01 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 10:00:03 INFO - Downloading blobuploader-1.2.4.tar.gz 10:00:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:00:03 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:00:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:00:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:00:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:00:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:00:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:00:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:00:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:00:03 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:00:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:00:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:00:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:00:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:00:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:00:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:00:04 INFO - Downloading docopt-0.6.1.tar.gz 10:00:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:00:04 INFO - Installing collected packages: blobuploader, requests, docopt 10:00:04 INFO - Running setup.py install for blobuploader 10:00:04 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:00:04 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:00:04 INFO - Running setup.py install for requests 10:00:04 INFO - Running setup.py install for docopt 10:00:04 INFO - Successfully installed blobuploader requests docopt 10:00:04 INFO - Cleaning up... 10:00:04 INFO - Return code: 0 10:00:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:00:04 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')]} 10:00:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:00:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:00:04 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')]} 10:00:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:00:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:00:04 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 0x7fa965c8ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xcf6020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd882e0>, '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 0xcf4140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xcf45d0>, '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': '8783db0840cc980e80bb0bd400000236-1466613596.232306-769184124', '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 10:00:04 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 10:00:04 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 10:00:04 INFO - Using env: {'DISPLAY': ':0', 10:00:04 INFO - 'HOME': '/home/cltbld', 10:00:04 INFO - 'LANG': 'en_US.UTF-8', 10:00:04 INFO - 'LANGUAGE': 'en_US:en', 10:00:04 INFO - 'LOGNAME': 'cltbld', 10:00:04 INFO - 'MAIL': '/var/mail/cltbld', 10:00:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:00:04 INFO - 'MOZ_NO_REMOTE': '1', 10:00:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:00:04 INFO - 'NO_EM_RESTART': '1', 10:00:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:00:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:00:04 INFO - 'PWD': '/builds/slave/test', 10:00:04 INFO - 'SHELL': '/bin/bash', 10:00:04 INFO - 'SHLVL': '1', 10:00:04 INFO - 'TERM': 'linux', 10:00:04 INFO - 'TMOUT': '86400', 10:00:04 INFO - 'USER': 'cltbld', 10:00:04 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1466613596.232306-769184124', 10:00:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:00:04 INFO - '_': '/tools/buildbot/bin/python'} 10:00:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:00:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:00:05 INFO - Running setup.py (path:/tmp/pip-x7z6pe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:00:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:00:05 INFO - Running setup.py (path:/tmp/pip-3lEKVY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:00:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:00:05 INFO - Running setup.py (path:/tmp/pip-vSE7BR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:00:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:00:05 INFO - Running setup.py (path:/tmp/pip-FWOUMq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:00:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:00:05 INFO - Running setup.py (path:/tmp/pip-XSunkQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:00:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:00:05 INFO - Running setup.py (path:/tmp/pip-o4QkBQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:00:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:00:05 INFO - Running setup.py (path:/tmp/pip-QKJsA_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:00:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:00:05 INFO - Running setup.py (path:/tmp/pip-NwL6Ur-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:00:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:00:05 INFO - Running setup.py (path:/tmp/pip-Z6ZlMj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:00:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:00:05 INFO - Running setup.py (path:/tmp/pip-urgPTd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:00:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:00:05 INFO - Running setup.py (path:/tmp/pip-qf2CTB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:00:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:00:05 INFO - Running setup.py (path:/tmp/pip-Z6m9UH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:00:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:00:06 INFO - Running setup.py (path:/tmp/pip-TVPphg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:00:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:00:06 INFO - Running setup.py (path:/tmp/pip-YXtnk8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:00:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:00:06 INFO - Running setup.py (path:/tmp/pip-EQNbBZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:00:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:00:06 INFO - Running setup.py (path:/tmp/pip-uoBkle-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:00:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:00:06 INFO - Running setup.py (path:/tmp/pip-kNh4v9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:00:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:00:06 INFO - Running setup.py install for manifestparser 10:00:06 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:00:06 INFO - Running setup.py install for mozcrash 10:00:06 INFO - Running setup.py install for mozdebug 10:00:06 INFO - Running setup.py install for mozdevice 10:00:07 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:00:07 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:00:07 INFO - Running setup.py install for mozfile 10:00:07 INFO - Running setup.py install for mozhttpd 10:00:07 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:00:07 INFO - Running setup.py install for mozinfo 10:00:07 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:00:07 INFO - Running setup.py install for mozInstall 10:00:07 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:00:07 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:00:07 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:00:07 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:00:07 INFO - Running setup.py install for mozleak 10:00:07 INFO - Running setup.py install for mozlog 10:00:07 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:00:07 INFO - Running setup.py install for moznetwork 10:00:07 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:00:07 INFO - Running setup.py install for mozprocess 10:00:07 INFO - Running setup.py install for mozprofile 10:00:08 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:00:08 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:00:08 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:00:08 INFO - Running setup.py install for mozrunner 10:00:08 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:00:08 INFO - Running setup.py install for mozscreenshot 10:00:08 INFO - Running setup.py install for moztest 10:00:08 INFO - Running setup.py install for mozversion 10:00:08 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:00:08 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:00:08 INFO - Cleaning up... 10:00:08 INFO - Return code: 0 10:00:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:00: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')]} 10:00:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:00:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:00: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')]} 10:00:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:00:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:00:08 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 0x7fa965c8ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xcf6020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd882e0>, '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 0xcf4140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xcf45d0>, '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': '8783db0840cc980e80bb0bd400000236-1466613596.232306-769184124', '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 10:00:08 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 10:00:08 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 10:00:08 INFO - Using env: {'DISPLAY': ':0', 10:00:08 INFO - 'HOME': '/home/cltbld', 10:00:08 INFO - 'LANG': 'en_US.UTF-8', 10:00:08 INFO - 'LANGUAGE': 'en_US:en', 10:00:08 INFO - 'LOGNAME': 'cltbld', 10:00:08 INFO - 'MAIL': '/var/mail/cltbld', 10:00:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:00:08 INFO - 'MOZ_NO_REMOTE': '1', 10:00:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:00:08 INFO - 'NO_EM_RESTART': '1', 10:00:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:00:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:00:08 INFO - 'PWD': '/builds/slave/test', 10:00:08 INFO - 'SHELL': '/bin/bash', 10:00:08 INFO - 'SHLVL': '1', 10:00:08 INFO - 'TERM': 'linux', 10:00:08 INFO - 'TMOUT': '86400', 10:00:08 INFO - 'USER': 'cltbld', 10:00:08 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1466613596.232306-769184124', 10:00:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:00:08 INFO - '_': '/tools/buildbot/bin/python'} 10:00:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:00:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:00:08 INFO - Running setup.py (path:/tmp/pip-CnqJtd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:00:08 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)) 10:00:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:00:08 INFO - Running setup.py (path:/tmp/pip-AopRaX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:00:08 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)) 10:00:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:00:08 INFO - Running setup.py (path:/tmp/pip-81EN2C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:00:08 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)) 10:00:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:00:08 INFO - Running setup.py (path:/tmp/pip-ysGsjM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:00:08 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)) 10:00:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:00:09 INFO - Running setup.py (path:/tmp/pip-CBDOxc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:00:09 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)) 10:00:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:00:09 INFO - Running setup.py (path:/tmp/pip-ksYYNK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:00:09 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)) 10:00:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:00:09 INFO - Running setup.py (path:/tmp/pip-rcgQXK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:00:09 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)) 10:00:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:00:09 INFO - Running setup.py (path:/tmp/pip-2O5QZq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:00:09 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)) 10:00:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:00:09 INFO - Running setup.py (path:/tmp/pip-bGD5Ym-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:00:09 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)) 10:00:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:00:09 INFO - Running setup.py (path:/tmp/pip-IyddAd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:00:09 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)) 10:00:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:00:09 INFO - Running setup.py (path:/tmp/pip-iYZeO8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:00:09 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)) 10:00:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:00:09 INFO - Running setup.py (path:/tmp/pip-pWetfX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:00:09 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)) 10:00:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:00:09 INFO - Running setup.py (path:/tmp/pip-HLSozJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:00:09 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)) 10:00:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:00:09 INFO - Running setup.py (path:/tmp/pip-wxpLoy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:00:09 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)) 10:00:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:00:09 INFO - Running setup.py (path:/tmp/pip-LYt3Sy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:00:09 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)) 10:00:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:00:09 INFO - Running setup.py (path:/tmp/pip-hTqxJS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:00:09 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)) 10:00:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:00:09 INFO - Running setup.py (path:/tmp/pip-hI47Aj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:00:09 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)) 10:00:09 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)) 10:00:09 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)) 10:00:09 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)) 10:00:09 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)) 10:00:09 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)) 10:00:09 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:00:09 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 10:00:09 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 10:00:09 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 10:00:09 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 10:00:09 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 10:00:09 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 10:00:11 INFO - Downloading blessings-1.6.tar.gz 10:00:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:00:11 INFO - Installing collected packages: blessings 10:00:11 INFO - Running setup.py install for blessings 10:00:12 INFO - Successfully installed blessings 10:00:12 INFO - Cleaning up... 10:00:12 INFO - Return code: 0 10:00:12 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:00:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:00:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:00:12 INFO - Reading from file tmpfile_stdout 10:00:12 INFO - Current package versions: 10:00:12 INFO - argparse == 1.2.1 10:00:12 INFO - blessings == 1.6 10:00:12 INFO - blobuploader == 1.2.4 10:00:12 INFO - docopt == 0.6.1 10:00:12 INFO - functools32 == 3.2.3-2 10:00:12 INFO - jsonschema == 2.5.1 10:00:12 INFO - manifestparser == 1.1 10:00:12 INFO - mozInstall == 1.12 10:00:12 INFO - mozcrash == 0.17 10:00:12 INFO - mozdebug == 0.1 10:00:12 INFO - mozdevice == 0.48 10:00:12 INFO - mozfile == 1.2 10:00:12 INFO - mozhttpd == 0.7 10:00:12 INFO - mozinfo == 0.9 10:00:12 INFO - mozleak == 0.1 10:00:12 INFO - mozlog == 3.2 10:00:12 INFO - moznetwork == 0.27 10:00:12 INFO - mozprocess == 0.22 10:00:12 INFO - mozprofile == 0.28 10:00:12 INFO - mozrunner == 6.11 10:00:12 INFO - mozscreenshot == 0.1 10:00:12 INFO - mozsystemmonitor == 0.3 10:00:12 INFO - moztest == 0.7 10:00:12 INFO - mozversion == 1.4 10:00:12 INFO - psutil == 3.1.1 10:00:12 INFO - requests == 1.2.3 10:00:12 INFO - wsgiref == 0.1.2 10:00:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:00:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:00:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:00:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:00:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:00:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:00:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:00:12 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 0x7fa965c8ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xcf6020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd882e0>, '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 0xcf4140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xcf45d0>, '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': '8783db0840cc980e80bb0bd400000236-1466613596.232306-769184124', '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 10:00:12 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 10:00:12 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 10:00:12 INFO - Using env: {'DISPLAY': ':0', 10:00:12 INFO - 'HOME': '/home/cltbld', 10:00:12 INFO - 'LANG': 'en_US.UTF-8', 10:00:12 INFO - 'LANGUAGE': 'en_US:en', 10:00:12 INFO - 'LOGNAME': 'cltbld', 10:00:12 INFO - 'MAIL': '/var/mail/cltbld', 10:00:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:00:12 INFO - 'MOZ_NO_REMOTE': '1', 10:00:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:00:12 INFO - 'NO_EM_RESTART': '1', 10:00:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:00:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:00:12 INFO - 'PWD': '/builds/slave/test', 10:00:12 INFO - 'SHELL': '/bin/bash', 10:00:12 INFO - 'SHLVL': '1', 10:00:12 INFO - 'TERM': 'linux', 10:00:12 INFO - 'TMOUT': '86400', 10:00:12 INFO - 'USER': 'cltbld', 10:00:12 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1466613596.232306-769184124', 10:00:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:00:12 INFO - '_': '/tools/buildbot/bin/python'} 10:00:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:00:12 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)) 10:00:12 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)) 10:00:12 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)) 10:00:12 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)) 10:00:12 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)) 10:00:12 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)) 10:00:12 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)) 10:00:12 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)) 10:00:12 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)) 10:00:12 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)) 10:00:12 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)) 10:00:12 INFO - Cleaning up... 10:00:12 INFO - Return code: 0 10:00:12 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:00:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:00:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:00:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:00:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:00:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:00:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:00:12 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 0x7fa965c8ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xcf6020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd882e0>, '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 0xcf4140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xcf45d0>, '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': '8783db0840cc980e80bb0bd400000236-1466613596.232306-769184124', '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 10:00:12 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 10:00:12 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 10:00:12 INFO - Using env: {'DISPLAY': ':0', 10:00:12 INFO - 'HOME': '/home/cltbld', 10:00:12 INFO - 'LANG': 'en_US.UTF-8', 10:00:12 INFO - 'LANGUAGE': 'en_US:en', 10:00:12 INFO - 'LOGNAME': 'cltbld', 10:00:12 INFO - 'MAIL': '/var/mail/cltbld', 10:00:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:00:12 INFO - 'MOZ_NO_REMOTE': '1', 10:00:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:00:12 INFO - 'NO_EM_RESTART': '1', 10:00:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:00:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:00:12 INFO - 'PWD': '/builds/slave/test', 10:00:12 INFO - 'SHELL': '/bin/bash', 10:00:12 INFO - 'SHLVL': '1', 10:00:12 INFO - 'TERM': 'linux', 10:00:12 INFO - 'TMOUT': '86400', 10:00:12 INFO - 'USER': 'cltbld', 10:00:12 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1466613596.232306-769184124', 10:00:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:00:12 INFO - '_': '/tools/buildbot/bin/python'} 10:00:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:00:12 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:00:12 INFO - Cleaning up... 10:00:12 INFO - Return code: 0 10:00:12 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 10:00:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:00:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:00:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:00:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:00:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:00:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:00:12 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 0x7fa965c8ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xcf6020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd882e0>, '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 0xcf4140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xcf45d0>, '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': '8783db0840cc980e80bb0bd400000236-1466613596.232306-769184124', '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 10:00:12 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 10:00:12 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 10:00:12 INFO - Using env: {'DISPLAY': ':0', 10:00:12 INFO - 'HOME': '/home/cltbld', 10:00:12 INFO - 'LANG': 'en_US.UTF-8', 10:00:12 INFO - 'LANGUAGE': 'en_US:en', 10:00:12 INFO - 'LOGNAME': 'cltbld', 10:00:12 INFO - 'MAIL': '/var/mail/cltbld', 10:00:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:00:12 INFO - 'MOZ_NO_REMOTE': '1', 10:00:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:00:12 INFO - 'NO_EM_RESTART': '1', 10:00:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:00:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:00:12 INFO - 'PWD': '/builds/slave/test', 10:00:12 INFO - 'SHELL': '/bin/bash', 10:00:12 INFO - 'SHLVL': '1', 10:00:12 INFO - 'TERM': 'linux', 10:00:12 INFO - 'TMOUT': '86400', 10:00:12 INFO - 'USER': 'cltbld', 10:00:12 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1466613596.232306-769184124', 10:00:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:00:12 INFO - '_': '/tools/buildbot/bin/python'} 10:00:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:00:12 INFO - Downloading/unpacking flake8 10:00:12 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 10:00:12 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 10:00:12 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 10:00:12 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 10:00:12 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 10:00:12 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 10:00:14 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:00:14 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:00:14 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 10:00:14 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 10:00:14 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 10:00:14 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 10:00:14 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 10:00:14 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 10:00:15 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:00:15 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:00:15 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 10:00:15 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 10:00:15 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 10:00:15 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 10:00:15 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 10:00:15 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 10:00:15 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:00:15 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 10:00:15 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 10:00:15 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 10:00:15 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 10:00:15 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 10:00:15 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 10:00:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 10:00:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:00:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:00:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:00:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:00:15 INFO - no previously-included directories found matching 'docs/_build' 10:00:15 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:00:15 INFO - Running setup.py install for pep8 10:00:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:00:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:00:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:00:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:00:15 INFO - no previously-included directories found matching 'docs/_build' 10:00:15 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 10:00:15 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:00:15 INFO - Cleaning up... 10:00:15 INFO - Return code: 0 10:00:15 INFO - Running post-action listener: _resource_record_post_action 10:00:15 INFO - Running post-action listener: _start_resource_monitoring 10:00:15 INFO - Starting resource monitoring. 10:00:15 INFO - ##### 10:00:15 INFO - ##### Finished create-virtualenv step (success) 10:00:15 INFO - ##### 10:00:15 INFO - ##### 10:00:15 INFO - ##### Running install step. 10:00:15 INFO - ##### 10:00:15 INFO - Running pre-action listener: _resource_record_pre_action 10:00:15 INFO - Running main action method: install 10:00:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:00:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:00:16 INFO - Reading from file tmpfile_stdout 10:00:16 INFO - Detecting whether we're running mozinstall >=1.0... 10:00:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:00:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:00:16 INFO - Reading from file tmpfile_stdout 10:00:16 INFO - Output received: 10:00:16 INFO - Usage: mozinstall [options] installer 10:00:16 INFO - Options: 10:00:16 INFO - -h, --help show this help message and exit 10:00:16 INFO - -d DEST, --destination=DEST 10:00:16 INFO - Directory to install application into. [default: 10:00:16 INFO - "/builds/slave/test"] 10:00:16 INFO - --app=APP Application being installed. [default: firefox] 10:00:16 INFO - mkdir: /builds/slave/test/build/application 10:00:16 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'] 10:00:16 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 10:00:33 INFO - Reading from file tmpfile_stdout 10:00:33 INFO - Output received: 10:00:33 INFO - /builds/slave/test/build/application/firefox/firefox 10:00:33 INFO - Running post-action listener: _resource_record_post_action 10:00:33 INFO - ##### 10:00:33 INFO - ##### Finished install step (success) 10:00:33 INFO - ##### 10:00:33 INFO - ##### 10:00:33 INFO - ##### Running run-tests step. 10:00:33 INFO - ##### 10:00:33 INFO - Running pre-action listener: _resource_record_pre_action 10:00:33 INFO - Running main action method: run_tests 10:00:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:00:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:00:33 INFO - Python 2.7.3 10:00:33 INFO - Return code: 0 10:00:33 INFO - grabbing minidump binary from tooltool 10:00: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')]} 10:00:33 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 0xd882e0>, '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 0xcf4140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xcf45d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:00:33 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 10:00:33 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 10:00:33 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 10:00:34 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:00:34 INFO - Return code: 0 10:00:34 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:00:34 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:00:34 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:00:34 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:00:34 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:00:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 10:00:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 10:00:34 INFO - Return code: 0 10:00:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cx0oPaHhS_OO8wzmZreKwg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-038', '--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 10:00:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/cx0oPaHhS_OO8wzmZreKwg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-038 --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 10:00:34 INFO - Using env: {'DISPLAY': ':0', 10:00:34 INFO - 'HOME': '/home/cltbld', 10:00:34 INFO - 'LANG': 'en_US.UTF-8', 10:00:34 INFO - 'LANGUAGE': 'en_US:en', 10:00:34 INFO - 'LOGNAME': 'cltbld', 10:00:34 INFO - 'MAIL': '/var/mail/cltbld', 10:00:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:00:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:00:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:00:34 INFO - 'MOZ_NO_REMOTE': '1', 10:00:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:00:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:00:34 INFO - 'NO_EM_RESTART': '1', 10:00:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:00:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:00:34 INFO - 'PWD': '/builds/slave/test', 10:00:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:00:34 INFO - 'SHELL': '/bin/bash', 10:00:34 INFO - 'SHLVL': '1', 10:00:34 INFO - 'TERM': 'linux', 10:00:34 INFO - 'TMOUT': '86400', 10:00:34 INFO - 'USER': 'cltbld', 10:00:34 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1466613596.232306-769184124', 10:00:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:00:34 INFO - '_': '/tools/buildbot/bin/python'} 10:00:34 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cx0oPaHhS_OO8wzmZreKwg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-038', '--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 10:00:35 INFO - mozversion application_buildid: 20160622073017 10:00:35 INFO - mozversion application_changeset: 812e027b2adeaadb9b11db9303327300512a2ec9 10:00:35 INFO - mozversion application_display_name: Nightly 10:00:35 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:00:35 INFO - mozversion application_name: Firefox 10:00:35 INFO - mozversion application_remotingname: firefox 10:00:35 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 10:00:35 INFO - mozversion application_vendor: Mozilla 10:00:35 INFO - mozversion application_version: 50.0a1 10:00:35 INFO - mozversion platform_buildid: 20160622073017 10:00:35 INFO - mozversion platform_changeset: 812e027b2adeaadb9b11db9303327300512a2ec9 10:00:35 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 10:00:35 INFO - mozversion platform_version: 50.0a1 10:00:35 INFO - using testdate: 1466614835 10:00:35 INFO - actual date: 1466614835 10:00:35 INFO - starting webserver on 'localhost:44753' 10:00:35 INFO - SUITE-START | Running 2 tests 10:00:35 INFO - TEST-START | dromaeo_css 10:00:35 INFO - operating with platform_type : linux_ 10:00:35 INFO - Initialising browser for dromaeo_css test... 10:00:35 INFO - TEST-INFO | started process 14586 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphtHFAD/profile http://localhost:44753/getInfo.html) 10:00:41 INFO - PROCESS | 14586 | __metrics Screen width/height:1600/1200 10:00:41 INFO - PROCESS | 14586 | colorDepth:24 10:00:41 INFO - PROCESS | 14586 | Browser inner width/height: 1024/697 10:00:41 INFO - PROCESS | 14586 | __metrics 10:00:43 INFO - PROCESS | 14586 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:00:43 INFO - PROCESS | 14586 | console.error: PushService: 10:00:43 INFO - PROCESS | 14586 | stateChangeProcessEnqueue: Error transitioning state 10:00:43 INFO - PROCESS | 14586 | UnknownError 10:00:44 INFO - TEST-INFO | 14586: exit 0 10:00:44 INFO - Browser initialized. 10:00:44 INFO - Running cycle 1/1 for dromaeo_css test... 10:00:44 INFO - TEST-INFO | started process 14670 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphtHFAD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:00:56 INFO - PROCESS | 14670 | RSS: Main: 174063616 10:00:56 INFO - PROCESS | 14670 | 10:01:47 INFO - PROCESS | 14670 | 1466614907906 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] 10:03:55 INFO - PROCESS | 14670 | Cycle 1(1): loaded http://localhost:44753/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44753/tests/dromaeo/cssquery-ext.html) 10:03:57 INFO - PROCESS | 14670 | RSS: Main: 254488576 10:03:57 INFO - PROCESS | 14670 | 10:06:59 INFO - PROCESS | 14670 | Cycle 1(1): loaded http://localhost:44753/tests/dromaeo/cssquery-ext.html (next: http://localhost:44753/tests/dromaeo/cssquery-jquery.html) 10:07:00 INFO - PROCESS | 14670 | RSS: Main: 263688192 10:07:00 INFO - PROCESS | 14670 | 10:10:02 INFO - PROCESS | 14670 | Cycle 1(1): loaded http://localhost:44753/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44753/tests/dromaeo/cssquery-mootools.html) 10:10:02 INFO - PROCESS | 14670 | RSS: Main: 266317824 10:10:02 INFO - PROCESS | 14670 | 10:13:04 INFO - PROCESS | 14670 | Cycle 1(1): loaded http://localhost:44753/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44753/tests/dromaeo/cssquery-prototype.html) 10:13:05 INFO - PROCESS | 14670 | RSS: Main: 249896960 10:13:05 INFO - PROCESS | 14670 | 10:16:07 INFO - PROCESS | 14670 | Cycle 1(1): loaded http://localhost:44753/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44753/tests/dromaeo/cssquery-yui.html) 10:16:08 INFO - PROCESS | 14670 | RSS: Main: 238292992 10:16:08 INFO - PROCESS | 14670 | 10:19:11 INFO - PROCESS | 14670 | Cycle 1(1): loaded http://localhost:44753/tests/dromaeo/cssquery-yui.html (next: http://localhost:44753/tests/dromaeo/cssquery-dojo.html) 10:19:11 INFO - PROCESS | 14670 | RSS: Main: 293318656 10:19:11 INFO - PROCESS | 14670 | 10:19:11 INFO - PROCESS | 14670 | __start_tp_report 10:19:11 INFO - PROCESS | 14670 | _x_x_mozilla_page_load 10:19:11 INFO - PROCESS | 14670 | _x_x_mozilla_page_load_details 10:19:11 INFO - PROCESS | 14670 | |i|pagename|runs| 10:19:11 INFO - PROCESS | 14670 | |0;dojo.html;3044.9695503044977;3083.938321233577;3099.3646302507987;3108.7668424868134;3108.849725601526;5171.0692075426405;5254.264402983586;5257.605679574033;5331.946680533193;5338.0658384782655;5262.236975638531;5283.709395983219;5291.841244762663;5298.046351656701;5311.415744268137;4758.571728544439;4798.1123492154065;4846;4868.318435419044;4965.726885021322;4852.102361063215;4863.416390033201;4889.291052797343;4916.43461001984;4937.80248790048;4659.464161621423;4676.18166820805;4751.762411879409;4782.569568738831;4784.11493873631;4766.904661906742;4769.499202583714;4779.593734532569;4857.2714092886;4898;4810.975945120252;4839.467658557556;4840.346553215306;4841.540053694894;4847.006363695434;5146.433892271847;5182.170852663593;5200.24596433515;5247.921281180786;5253.921191182136;5617.943820561783;5623.465770751813;5707.77168913243;5707.885842283131;5708.65748055118;5687.289088863892;5726;5726.3414707308775;5742.82771516851;5743.885122297531;5123.2315152727015;5270.57835373173;5301.151815709506;5314.681119132864;5396.622236443412;5836.9124463133085;5855.238818953509;5860.472557469848;5860.882782344414;5864.2083318752275;5410.053240682865;5619.775208991677;5632.4930756231315;5653.406392328829;5678.261825962599;5565.053940830068;5599.132134519156;5608;5704.258446402024;5708.172315014383;5629.802956896571;5639.605227634108;5642.915356269659;5643.5203007743985;5645.576581756384;5546.667199967934;5614.747336369873;5614.9438505615235;5618.52242559387;5624.578156638268;4153.522344930311;4266.445362102969;4267.317229243368;4280.571942805695;4313.331433627793;3838.616138386195;3848.5189351331082;3853.672437842815;3886.7862267574988;3887.8250478728523;5215.765290561933;5337.119375303109;5350.839474815762;5352.2506849041165;5355.598330125178;5620.213170156181;5645.887082258332;5650.067738823131;5680.715964201856;5685.090385538294;5337.412884582693;5363.973180134152;5371.382291036581;5371.75827087782;5374.086405311106;4745.786439610226;4835.564799168092;4921.926171107436;4926.75366231687;4961.553460188528;5797.275340582427;5817.621854579524;5834.737436815353;5844.3571207168025;5892.322382925932;5633.2395126657375;5637.774489020393;5639.295088113986;5643.52030077448;5649.519790817662;5649.435056494318;5774.538036957118;5793.04414771558;5845;5849.824505264849;5569.303837020372;5574.498295153456;5581.49766521015;5617.691026993554;5620.859478512906;5604.075327571069;5648.887022259614;5657.773689052392;5659.151127330933;5669.149627555899;4899;5367.543758780391;5465;5539.529140023144;5549;5467.6719396836315;5490.396056433869;5501.752421140978;5502.119660854244;5507.834764957058;5431.131019036935;5436.103042997861;5437.700926448925;5443.265159203615;5493.395726470165;5373.489518495737;5490.917636235539;5510.724463776715;5524.66851988882;5528.585356098389;5421.457854214705;5456.809011684731;5459.454054594509;5462.153366228241;5462.754176062166 10:19:11 INFO - PROCESS | 14670 | |1;ext.html;594.6491569973715;622.4335854372521;624.6158612453339;636.936306369363;640.679660169915;30743.385132297342;31319.21701957452;33809.492857607125;44798;46900.76549617256;44843.32735008978;45193;45255.32117018248;45295.54704452954;45302;8821.69124080659;8953.194212520872;8973.237274831614;8980;8992.595333210022;8881.511516866569;8998.910010899872;8999.865002024942;9007.414518056337;9008.54957252138;8982.101789820998;9007;9017.053209413016;9022.233110185642;9027.729168124966;8921.776955576097;8979.416337938013;8990.820183596292;8993.055729148477;8996.550172491381;8869.512176830336;8914.50970196639;8934.553272336358;8940.240079593243;8942.776430589287;41575.58424415747;41869.371959420634;42044.579554204676;42060.789696051324;42101.36847947283;3687.3915803892323;3705.4441833724886;3723.2925744108534;3777.2445510897655;4061.7969101544804;30065.098047058622;32054.839725801456;32381.83809080963;32450.513242301386;32501.83749081263;4186.811593478301;4301.935470967906;4331;4370.781460926941;4512.300593408027;369548;370064;371137;372888;373155.99999999726;60014.39985600176;60052.39947600556;60131.09803352953;60152;60483.69758151269;62490.437739055975;63062.68468657719;63098;63610.36389636137;63638.36361636417;16424.1787910604;16573.17134143288;16722.414715484898;16744.330226790793;16745.832541674426;12667.93666031664;12818.423170957329;12849;12850.742985140245;12851.100422970303;18859.434216973514;18926.3375781847;19105.522361940784;19124.139413726414;19295.614087718448;6930.549514281555;7096.432285417154;7167.211606723256;7229.7469588564145;7282.271772822675;919.2921450483091;1078.6063086973197;1084.969279184762;1125.9155563332783;1130.3161587239765;31906.840465797522;32114.59441107577;32229;33007.50488742623;33044.50433243503;998.8701468809154;1036.6268143468346;1072.1476426241156;1119.7144728094283;1156.5894107591685;16734.07558130806;17028.829711702725;17104.11545476164;17106.91446542759;17385.913070434566;562305;566189;566196;566265;567367;57997;58461.4153858456;58552.4144758547;58571.70714146402;58624.12063819046;1196.5333519927235;1282.3716378974423;1316.5721140629335;1327.508821735964;1329.0497294434526;32153.356932860745;33283;33679.66320336765;33710.325793483506;33898.83050584731;49768;49831;50244.24633630572;50247.49752502428;50290;414636;417838;418113;418959;419313;24434.14480493174;26391.34021649474;27468.429104216324;27634;27814.86092569524;48630;48886.26670599873;48924;49663;49984;39828;40010;40771.79614102029;40994.59005409908;41040.79479602583;40008.3998740025;40460.39309410303;40894.79552602218;40922.79538602288;41249.79375103105;40151.99620009523;40841.38737918874;41023.38464923088;41165.58834411618;41341.37987930243;32759;35835.462468063524;36125.27749445049;36325.27349453049;36479.817600911825;27170.32074198161;27472.725272747015;27509.62451877358;27533.17400477989;27636 10:19:11 INFO - PROCESS | 14670 | |2;jquery.html;390.6074395232791;396.3242671245525;397.197660725335;404.7510780869765;417.6700406678724;13061.24350641788;18455.26178952842;20016.19935202592;20030;20653.483662908435;14661.633459163526;19307.903460482677;19411.70882436761;19522.023898805037;19958.90020549895;5499.450054994509;5720.713964301789;5724.026915424388;5733.885322293551;5754.7410366533395;5579.944200558003;5663.830085097454;5684.147377893308;5688.11834165705;5689.743961521721;4154.335306350985;5940.554458415614;6195.8141255762175;6235.5011599072195;6336.5881217720935;6034.336223015464;6251.968740156293;6255.562110652256;6269.0909818076125;6323.873522529547;5503.394626591072;5554.222408862763;5570.526505247059;5570.637908535973;5574.414686457944;22631.77368226313;23063.077476900904;23988.760112398828;24086.518269634686;24097.156599518934;2084.4163634182455;2309.099451214028;2343.015933307998;2427.7693619106158;2808.4804311202492;9568.952155239249;10259.948700256526;10268.024537668909;11305.604303849326;15031;1909.284018493065;1941.708743688458;1998.4404366777326;2011.095007246745;2064.298138632872;73214.63392683056;78621;78689.60655196688;79741.60129199317;80874.99999999942;8664.350173736995;9118.452892826452;9285.210757085588;10048.296619236584;10176.643817466353;13024.47902083925;13147.14543554685;13215.207087574776;13229.73540529184;13234.470621175045;7160.749373771997;7475.289847464483;7574.659140338587;7610.581418022062;7668.309852113337;7315.4147668186415;7325.084364454443;7525.021747172833;7525.172231054579;7539.095308562898;4025.9798701006894;4193.18232944579;4378.16814805186;4548.363229147922;8238.217369350023;3307.9007629771145;3432.3993301172195;3477.3566890125408;3528.8588456461453;3631.418972964313;847.5211505499373;933.3839665820526;1000.7598176437602;1028.6348346337093;1056.4136904018344;18720.81279187218;19005.14476848545;19730.717503362237;19814.20743170257;19948.401547953294;936.1574582875467;945.5981207986579;963.8313295173317;967.5162418790604;1006.9395836249848;10821.458927053616;11150.832737508943;11163.218574699693;11175.44122793857;11193.776124477465;489120;492220;498430;503194;503211;92797;96321;96417;96832.51583742036;97380.51309743406;961.3078583419926;962.6390103711249;980.9166220871164;985.1527686189871;987.1905037868878;17499.212535435683;17641.206145723216;17913.552161195552;17914.462566122515;18213;42865.571344287404;43426;43553.56446435495;44056.339154913345;44119.33820992752;52927;53039.73480132574;54675.72662136664;61905.38094619176;62117.37882621116;7682.116556596063;7856;7858.096318923397;8163.428560000743;8469.110743371857;9570.377925434825;13047.28239946812;13712.65718357009;14077.929610351883;14222.577742225694;10769.192310576895;11837.881621183678;12169.452374642986;12220.144589878622;12300.384980751105;12083.939580302042;12132.272063676208;12244.10216416457;12377.443015064164;12484.313362764771;11761.529538818351;12503.187292825936;12650.987920966116;12773;12794.36028198605;8584.399092063495;8636.740897773077;8649.308055355683;8722.781930451789;9000.729978100668;11225.66323010311;12212.389380531116;12308.507659693512;12313.938430307791;12694.936525317315 10:19:11 INFO - PROCESS | 14670 | |3;mootools.html;1273.9681507962305;1435.239323158726;1466.3474753734586;1541.9306131224093;1716.605180808414;7491.925080749191;8406.327493800496;8591.012033616129;8606.784830379243;8862.158094980967;8594.87107693385;8632.568371581427;8694.21752042316;8699.217070463657;8703.173198546145;2217.3458829645215;2249.7862703043265;2251.448395143192;2254.4589298568308;2254.627986382245;2197.3627647982066;2246.5619204255177;2252.4594097416584;2255.041607316884;2259.7740225977436;2195.3304242206123;2201.966970495444;2209.237812954528;2211.3365990202956;2225.4547635829163;2155.8814265215406;2177.172674383732;2181.5854987552316;2182.0289970962926;2183.9890800545977;2206;2208.2602328220064;2210.801027907496;2213.878236696981;2215.2578886073184;8660.610272537751;8687.261582765472;8798.164174403422;8806.735797926072;8813.515256660881;4712.811487540494;4865.781039853215;4868.829590964335;4870.65905386623;4871.537203965618;3250.2849373137874;3434.587849458081;3438.6045604755273;3511.525943997553;3520.436730123168;1121.3216004317433;1165.702745799824;1173.5775120956448;1179.345463267886;1195.4500929572407;12706.872931270662;12927.48290068396;12937.547185848543;12941.288229147487;12944.805827912589;4381.101874115799;4403.691741578123;4457.64338852891;4493.775311234425;4509.932351014738;9643.855342169873;9650.855237171449;9662.275329350186;9664.516774161264;9667.516624168764;5112.6421150519855;5113.411957624847;5115.948840511622;5116.923246151311;5119.539241468286;4079.286124928126;4136.793160341971;4605.562471565196;4678.742669153161;4720.9141897363115;3586.3544561978574;3599.1721903962234;3626.9818650906577;3745.9063523412133;3865.5747867734526;1072.485207100596;1128.9491972861076;1131.960381386664;1141.4007645985923;1149.0290704354807;905.6241659711278;961.9470929098827;986.1519093579659;991.1179050644931;994.0159242350165;5943.762249510058;5954.761809527657;6046.3349031606485;6251.156093927261;6253;428.07322147550826;434.1685671938266;436.77069538492543;997.3915911294105;1026.9743256418649;4088.2436749200897;4159.625633692982;4169.10364271677;4169.1661667666585;4180.644645205191;11167.106631469464;11500.654980350602;11524.94237528807;11581;11583.305001699757;11261;11406.657800266004;11527.250728702607;11552.59565915189;11553.768924621461;8475.872861907077;8496.150384961455;8650.610722517502;8651.6971905983;8721.738347849574;6113.358097399887;6155.107509411021;6195.845103872439;6215.502759779117;6341.746330146927;8967.50678712651;9325.953370233105;9334.953325233331;10373.118284945864;10637.787244254916;9378.531073446164;9501.57242924084;9824.754381140528;9846.163076138322;9857.802843942938;6984.196817366068;7513.624318784148;7690.538567685957;7728.729494467667;7937.960310198643;8416.579171041301;8442.113578074213;8469.195426434479;8497.490150590984;8517.914820851713;7786.532808031537;7807.609619519115;7810.765677029698;7917.802054948673;7941.523508589503;7510.624468776648;7656.69373225087;7710.074791024888;7783.066032076187;7788.376929845485;6927.376536111774;6982.685779140053;6996.405305549085;6997.510174287751;6999.440044796303;5284.7886084556185;5343;5382.138857782736;5393.244945707525;5451.318585176853;4851.102546028996;4887.095887260868;4893.119238537098;5021.096202683552;5089.949100508948 10:19:11 INFO - PROCESS | 14670 | |4;prototype.html;302.96537325035007;312.65139369602895;320.2218608780665;322.10776150064316;323.2807004415175;4996.475370086143;5117.411497677768;5187.170052791555;5189.702574356411;5195.844124676261;5157.896842063156;5212;5226.320578324812;5229.947700522994;5252.71110088945;4074.9405154659853;4085.9795701021526;4093.774842383668;4095.262852686515;4099.426080348753;3864.7101467389916;3870.8645197418095;4079.77561234132;4103.199876024177;4122;4021.27085353298;4034.7377420467574;4085.2850751118585;4085.7957102144924;4087.4073259377374;4012.8796136115816;4028.536718277406;4035.4148648446103;4042.4542686737354;4085.428040074392;3533.152043509565;3597.334493118781;3609.657082577151;3617.4212126059965;3624.3294990426593;5070.771815268285;5075.467075957008;5089.592832573385;5091.26896855071;5096.79612815487;4640.744759038252;4651.86044418668;4658.930116048262;4661;4667.299905014275;5226.686398816083;5356.196570514415;5358.365698461967;5400.83797486076;5422.566194704415;3931.6461518463475;3952.288588054149;3953.150072734376;3954.169624378855;3962.2669806085964;5571.4150014248735;5587.413321601214;5600.299962504687;5666.178404131378;5691.772329106872;4050.4734384529825;4051.5745846685672;4061.862678450039;4071.1247081877536;4093.63157315843;3762.9247415051545;3966.603339666068;3967.7222594418113;3993.6405723485027;4004.5795191505053;4583.289590113538;4587.472440669299;4592.632589392841;4597.149527337453;4612.192866248461;5438.184272359178;5455.34535855692;5481.424450432727;5490.588205884575;5510.134729940409;1307.8038294255937;1333.8666133386585;1344.435337158396;1378.7518246715488;1387.6253411578816;868.5917618719192;872.9738107856774;881.7883707910055;889.621910687955;890.3633901760272;4640.909386294218;4687.507811679793;4693.24908014716;4693.319468677023;4701.200795864711;4929.926051109236;4958.380202474691;4982.252662100714;5001.5498605124985;5028.893643398446;4445.866624001285;4678.7660616969015;4691.225947718588;4763.927691454229;4782.402199725035;2598.2075466982374;2600.8569528675725;2608.6217498462615;2624.7506486883717;2645.973540264611;5066.949330506722;5116.462771409023;5118.899436621145;5129.487051294841;5146.639735218499;4807.759612019385;4897.657163998486;5008.799648014112;5024.794049428111;5055.3428054353435;5060.367454068241;5063.898722025612;5064.164412871834;5074.391073071255;5104.285400043997;4911.926321105258;4938.9259161111895;4951.751143787596;5018.573421259088;5024.949750502448;4655.883602909955;4952.579030782424;4963.379577552806;4997.275395067768;4998.525140111684;5123.513266239701;5138.229265610188;5143.6399452039495;5143.71709555978;5178.482151784791;3651.251493443891;3665.8533658654424;3691.9261614767015;3699.6115407881784;3710.7959062251834;4764;4907.656464047483;4968.180250258812;4971.787554538196;5073.16292811682;4847.515248475265;4857.489963553918;4858.295547145714;4916.746229711401;4921.9507804921495;4821.5178482152905;4862.173430516891;4872.220444728827;4898.559129678346;4927.457979622311;4703.647226458098;4728.456227533878;4740.407449068866;4779.402574678165;4972.776225069808;5461.808836690697;5485.6434331768305;5508.631288545964;5511.22842802016;5511.807086751945;5393.6224464287125;5395.379531353945;5396.7571459283645;5400.594955378284;5422.945770542244 10:19:11 INFO - PROCESS | 14670 | |5;yui.html;719.6797425145811;753.8379248461583;780.8321210939647;783.0916137280749;825.2531459029576;13893.096948698327;14468.855311446883;15206.619834504143;15424.383024679028;15513.534593962186;14152.929235353835;14326.068805527633;14341.354639041243;14366.712665746705;14559.708805823877;665.1552528289094;780.2782426255719;796.6056801883061;805.7179987004561;808.0465051239535;799.6841247707152;800.8078061265313;801.8516574433719;802.1256830055239;802.6829402386054;845.3364109174299;845.6913226672282;845.7800971747359;845.7843249971248;846.3102571404316;697.1146643762419;794.06697130871;809.2271880354248;810.8175660476346;844.6452489954233;599.1163034524086;601.4406601860268;601.5879122800895;601.714185761764;601.9488343490808;14361.49734759289;14370.065945713495;14376.856231437761;14411.135331880121;14445.349959251755;14256.144631322153;14585.854141458556;14719.411223551046;14796.482123125747;14955.850441495555;12426.627201183888;12819.487220511168;12831.230126192459;12917.418716157796;13105.934470327682;4489.393931819228;4639.721616703008;4676.462206846222;4703.3885594872445;4747.762611869427;73898;74006.25993740048;74134;74279.62860185718;74975.62512187459;11456.427178641035;11526.193166478433;11746.70633234176;11782.057435405148;12123.151379403533;21731.67402488964;21824;21910.12359505602;21943.341699749035;21957.341279761313;8314.919060522094;8558;8564.057953625097;8615.138486151334;8672.479651220947;4527.796249168795;4615.16926953145;4638.698484598491;4743.241081426955;4834.033193361342;3432.553768010143;3561.6438356164176;3568.125809176768;3568.9650001499276;3569.0185199070465;631.1983780598614;634.80321100459;645.1806206118204;649.4285029174297;649.8148027812051;616.4575173847076;662.5693299355457;672.9394354508117;733.7725305155419;763.9236076392427;9993.80012399748;10395.376277423378;10415.739606509898;10434.895651043544;10494.055535001733;527.3408239700375;575.3728436004775;627.8336240896166;720.1538192623751;755.4975940999174;4858.975705121452;4955.430125535538;5036.471170527115;5122.487751224848;5162.9741851291255;69869;84348;104504.00911799392;106914.46542767236;106969;76742;92503;93074;94049.0595094054;94379;58586;87240;88292.55853720818;89040.5547972269;89418;9754.75613109678;9783.719937666965;9834.655787047419;9861.112499875046;9904.455254961047;49497;49950.750246248535;50855.23717144172;50884.236736449726;53034.93930121453;68268.97596536155;76256.61871690606;76495;77534;78708.12918708083;12855.550055748005;13002.674933126747;13166.144200626928;13351.933240333736;14464.421423142956;15139.772903406678;15366;15411.152386618394;15617.14105724196;15649.765253520978;14125.293735312987;14158.787618185941;14168;14404.567862964128;14956.476523321631;13626;13943.233122177971;14148.363323650254;14530.854691453373;15473;14753;14776.261186940825;14798;14856.554303370916;14918.77621835695;11340.20618556693;11620.941895290469;11626.320835845534;11715.648530544097;11755.823662644896;11646.825297620373;12314.938425308175;12323.568675096329;12397.318147501974;12406.937965310115 10:19:11 INFO - PROCESS | 14670 | __end_tp_report 10:19:11 INFO - PROCESS | 14670 | __start_cc_report 10:19:11 INFO - PROCESS | 14670 | _x_x_mozilla_cycle_collect,967 10:19:11 INFO - PROCESS | 14670 | __end_cc_report 10:19:11 INFO - PROCESS | 14670 | __startTimestamp1466615951552__endTimestamp 10:19:11 INFO - PROCESS | 14670 | 10:19:11 INFO - PROCESS | 14670 | ------- Summary: start ------- 10:19:11 INFO - PROCESS | 14670 | Number of tests: 6 10:19:11 INFO - PROCESS | 14670 | 10:19:11 INFO - PROCESS | 14670 | [#0] dojo.html Cycles:165 Average:5244.73 Median:5437.70 stddev:593.09 (10.9%) stddev-sans-first:569.25 10:19:11 INFO - PROCESS | 14670 | Values: 3045.0 3083.9 3099.4 3108.8 3108.8 5171.1 5254.3 5257.6 5331.9 5338.1 5262.2 5283.7 5291.8 5298.0 5311.4 4758.6 4798.1 4846.0 4868.3 4965.7 4852.1 4863.4 4889.3 4916.4 4937.8 4659.5 4676.2 4751.8 4782.6 4784.1 4766.9 4769.5 4779.6 4857.3 4898.0 4811.0 4839.5 4840.3 4841.5 4847.0 5146.4 5182.2 5200.2 5247.9 5253.9 5617.9 5623.5 5707.8 5707.9 5708.7 5687.3 5726.0 5726.3 5742.8 5743.9 5123.2 5270.6 5301.2 5314.7 5396.6 5836.9 5855.2 5860.5 5860.9 5864.2 5410.1 5619.8 5632.5 5653.4 5678.3 5565.1 5599.1 5608.0 5704.3 5708.2 5629.8 5639.6 5642.9 5643.5 5645.6 5546.7 5614.7 5614.9 5618.5 5624.6 4153.5 4266.4 4267.3 4280.6 4313.3 3838.6 3848.5 3853.7 3886.8 3887.8 5215.8 5337.1 5350.8 5352.3 5355.6 5620.2 5645.9 5650.1 5680.7 5685.1 5337.4 5364.0 5371.4 5371.8 5374.1 4745.8 4835.6 4921.9 4926.8 4961.6 5797.3 5817.6 5834.7 5844.4 5892.3 5633.2 5637.8 5639.3 5643.5 5649.5 5649.4 5774.5 5793.0 5845.0 5849.8 5569.3 5574.5 5581.5 5617.7 5620.9 5604.1 5648.9 5657.8 5659.2 5669.1 4899.0 5367.5 5465.0 5539.5 5549.0 5467.7 5490.4 5501.8 5502.1 5507.8 5431.1 5436.1 5437.7 5443.3 5493.4 5373.5 5490.9 5510.7 5524.7 5528.6 5421.5 5456.8 5459.5 5462.2 5462.8 10:19:11 INFO - PROCESS | 14670 | 10:19:11 INFO - PROCESS | 14670 | [#1] ext.html Cycles:180 Average:61105.57 Median:227988.69 stddev:121867.98 (53.5%) stddev-sans-first:122125.16 10:19:11 INFO - PROCESS | 14670 | Values: 594.6 622.4 624.6 636.9 640.7 30743.4 31319.2 33809.5 44798.0 46900.8 44843.3 45193.0 45255.3 45295.5 45302.0 8821.7 8953.2 8973.2 8980.0 8992.6 8881.5 8998.9 8999.9 9007.4 9008.5 8982.1 9007.0 9017.1 9022.2 9027.7 8921.8 8979.4 8990.8 8993.1 8996.6 8869.5 8914.5 8934.6 8940.2 8942.8 41575.6 41869.4 42044.6 42060.8 42101.4 3687.4 3705.4 3723.3 3777.2 4061.8 30065.1 32054.8 32381.8 32450.5 32501.8 4186.8 4301.9 4331.0 4370.8 4512.3 369548.0 370064.0 371137.0 372888.0 373156.0 60014.4 60052.4 60131.1 60152.0 60483.7 62490.4 63062.7 63098.0 63610.4 63638.4 16424.2 16573.2 16722.4 16744.3 16745.8 12667.9 12818.4 12849.0 12850.7 12851.1 18859.4 18926.3 19105.5 19124.1 19295.6 6930.5 7096.4 7167.2 7229.7 7282.3 919.3 1078.6 1085.0 1125.9 1130.3 31906.8 32114.6 32229.0 33007.5 33044.5 998.9 1036.6 1072.1 1119.7 1156.6 16734.1 17028.8 17104.1 17106.9 17385.9 562305.0 566189.0 566196.0 566265.0 567367.0 57997.0 58461.4 58552.4 58571.7 58624.1 1196.5 1282.4 1316.6 1327.5 1329.0 32153.4 33283.0 33679.7 33710.3 33898.8 49768.0 49831.0 50244.2 50247.5 50290.0 414636.0 417838.0 418113.0 418959.0 419313.0 24434.1 26391.3 27468.4 27634.0 27814.9 48630.0 48886.3 48924.0 49663.0 49984.0 39828.0 40010.0 40771.8 40994.6 41040.8 40008.4 40460.4 40894.8 40922.8 41249.8 40152.0 40841.4 41023.4 41165.6 41341.4 32759.0 35835.5 36125.3 36325.3 36479.8 27170.3 27472.7 27509.6 27533.2 27636.0 10:19:11 INFO - PROCESS | 14670 | 10:19:11 INFO - PROCESS | 14670 | [#2] jquery.html Cycles:180 Average:29259.72 Median:2305.43 stddev:81989.32 (3556.4%) stddev-sans-first:82190.66 10:19:11 INFO - PROCESS | 14670 | Values: 390.6 396.3 397.2 404.8 417.7 13061.2 18455.3 20016.2 20030.0 20653.5 14661.6 19307.9 19411.7 19522.0 19958.9 5499.5 5720.7 5724.0 5733.9 5754.7 5579.9 5663.8 5684.1 5688.1 5689.7 4154.3 5940.6 6195.8 6235.5 6336.6 6034.3 6252.0 6255.6 6269.1 6323.9 5503.4 5554.2 5570.5 5570.6 5574.4 22631.8 23063.1 23988.8 24086.5 24097.2 2084.4 2309.1 2343.0 2427.8 2808.5 9569.0 10259.9 10268.0 11305.6 15031.0 1909.3 1941.7 1998.4 2011.1 2064.3 73214.6 78621.0 78689.6 79741.6 80875.0 8664.4 9118.5 9285.2 10048.3 10176.6 13024.5 13147.1 13215.2 13229.7 13234.5 7160.7 7475.3 7574.7 7610.6 7668.3 7315.4 7325.1 7525.0 7525.2 7539.1 4026.0 4193.2 4378.2 4548.4 8238.2 3307.9 3432.4 3477.4 3528.9 3631.4 847.5 933.4 1000.8 1028.6 1056.4 18720.8 19005.1 19730.7 19814.2 19948.4 936.2 945.6 963.8 967.5 1006.9 10821.5 11150.8 11163.2 11175.4 11193.8 489120.0 492220.0 498430.0 503194.0 503211.0 92797.0 96321.0 96417.0 96832.5 97380.5 961.3 962.6 980.9 985.2 987.2 17499.2 17641.2 17913.6 17914.5 18213.0 42865.6 43426.0 43553.6 44056.3 44119.3 52927.0 53039.7 54675.7 61905.4 62117.4 7682.1 7856.0 7858.1 8163.4 8469.1 9570.4 13047.3 13712.7 14077.9 14222.6 10769.2 11837.9 12169.5 12220.1 12300.4 12083.9 12132.3 12244.1 12377.4 12484.3 11761.5 12503.2 12651.0 12773.0 12794.4 8584.4 8636.7 8649.3 8722.8 9000.7 11225.7 12212.4 12308.5 12313.9 12694.9 10:19:11 INFO - PROCESS | 14670 | 10:19:11 INFO - PROCESS | 14670 | [#3] mootools.html Cycles:180 Average:5752.41 Median:4871.10 stddev:3370.48 (69.2%) stddev-sans-first:3363.13 10:19:11 INFO - PROCESS | 14670 | Values: 1274.0 1435.2 1466.3 1541.9 1716.6 7491.9 8406.3 8591.0 8606.8 8862.2 8594.9 8632.6 8694.2 8699.2 8703.2 2217.3 2249.8 2251.4 2254.5 2254.6 2197.4 2246.6 2252.5 2255.0 2259.8 2195.3 2202.0 2209.2 2211.3 2225.5 2155.9 2177.2 2181.6 2182.0 2184.0 2206.0 2208.3 2210.8 2213.9 2215.3 8660.6 8687.3 8798.2 8806.7 8813.5 4712.8 4865.8 4868.8 4870.7 4871.5 3250.3 3434.6 3438.6 3511.5 3520.4 1121.3 1165.7 1173.6 1179.3 1195.5 12706.9 12927.5 12937.5 12941.3 12944.8 4381.1 4403.7 4457.6 4493.8 4509.9 9643.9 9650.9 9662.3 9664.5 9667.5 5112.6 5113.4 5115.9 5116.9 5119.5 4079.3 4136.8 4605.6 4678.7 4720.9 3586.4 3599.2 3627.0 3745.9 3865.6 1072.5 1128.9 1132.0 1141.4 1149.0 905.6 961.9 986.2 991.1 994.0 5943.8 5954.8 6046.3 6251.2 6253.0 428.1 434.2 436.8 997.4 1027.0 4088.2 4159.6 4169.1 4169.2 4180.6 11167.1 11500.7 11524.9 11581.0 11583.3 11261.0 11406.7 11527.3 11552.6 11553.8 8475.9 8496.2 8650.6 8651.7 8721.7 6113.4 6155.1 6195.8 6215.5 6341.7 8967.5 9326.0 9335.0 10373.1 10637.8 9378.5 9501.6 9824.8 9846.2 9857.8 6984.2 7513.6 7690.5 7728.7 7938.0 8416.6 8442.1 8469.2 8497.5 8517.9 7786.5 7807.6 7810.8 7917.8 7941.5 7510.6 7656.7 7710.1 7783.1 7788.4 6927.4 6982.7 6996.4 6997.5 6999.4 5284.8 5343.0 5382.1 5393.2 5451.3 4851.1 4887.1 4893.1 5021.1 5089.9 10:19:11 INFO - PROCESS | 14670 | 10:19:11 INFO - PROCESS | 14670 | [#4] prototype.html Cycles:180 Average:4350.81 Median:4860.23 stddev:1240.58 (25.5%) stddev-sans-first:1206.28 10:19:11 INFO - PROCESS | 14670 | Values: 303.0 312.7 320.2 322.1 323.3 4996.5 5117.4 5187.2 5189.7 5195.8 5157.9 5212.0 5226.3 5229.9 5252.7 4074.9 4086.0 4093.8 4095.3 4099.4 3864.7 3870.9 4079.8 4103.2 4122.0 4021.3 4034.7 4085.3 4085.8 4087.4 4012.9 4028.5 4035.4 4042.5 4085.4 3533.2 3597.3 3609.7 3617.4 3624.3 5070.8 5075.5 5089.6 5091.3 5096.8 4640.7 4651.9 4658.9 4661.0 4667.3 5226.7 5356.2 5358.4 5400.8 5422.6 3931.6 3952.3 3953.2 3954.2 3962.3 5571.4 5587.4 5600.3 5666.2 5691.8 4050.5 4051.6 4061.9 4071.1 4093.6 3762.9 3966.6 3967.7 3993.6 4004.6 4583.3 4587.5 4592.6 4597.1 4612.2 5438.2 5455.3 5481.4 5490.6 5510.1 1307.8 1333.9 1344.4 1378.8 1387.6 868.6 873.0 881.8 889.6 890.4 4640.9 4687.5 4693.2 4693.3 4701.2 4929.9 4958.4 4982.3 5001.5 5028.9 4445.9 4678.8 4691.2 4763.9 4782.4 2598.2 2600.9 2608.6 2624.8 2646.0 5066.9 5116.5 5118.9 5129.5 5146.6 4807.8 4897.7 5008.8 5024.8 5055.3 5060.4 5063.9 5064.2 5074.4 5104.3 4911.9 4938.9 4951.8 5018.6 5024.9 4655.9 4952.6 4963.4 4997.3 4998.5 5123.5 5138.2 5143.6 5143.7 5178.5 3651.3 3665.9 3691.9 3699.6 3710.8 4764.0 4907.7 4968.2 4971.8 5073.2 4847.5 4857.5 4858.3 4916.7 4922.0 4821.5 4862.2 4872.2 4898.6 4927.5 4703.6 4728.5 4740.4 4779.4 4972.8 5461.8 5485.6 5508.6 5511.2 5511.8 5393.6 5395.4 5396.8 5400.6 5422.9 10:19:11 INFO - PROCESS | 14670 | 10:19:11 INFO - PROCESS | 14670 | [#5] yui.html Cycles:180 Average:20049.91 Median:4790.90 stddev:27435.27 (572.7%) stddev-sans-first:27473.84 10:19:11 INFO - PROCESS | 14670 | Values: 719.7 753.8 780.8 783.1 825.3 13893.1 14468.9 15206.6 15424.4 15513.5 14152.9 14326.1 14341.4 14366.7 14559.7 665.2 780.3 796.6 805.7 808.0 799.7 800.8 801.9 802.1 802.7 845.3 845.7 845.8 845.8 846.3 697.1 794.1 809.2 810.8 844.6 599.1 601.4 601.6 601.7 601.9 14361.5 14370.1 14376.9 14411.1 14445.3 14256.1 14585.9 14719.4 14796.5 14955.9 12426.6 12819.5 12831.2 12917.4 13105.9 4489.4 4639.7 4676.5 4703.4 4747.8 73898.0 74006.3 74134.0 74279.6 74975.6 11456.4 11526.2 11746.7 11782.1 12123.2 21731.7 21824.0 21910.1 21943.3 21957.3 8314.9 8558.0 8564.1 8615.1 8672.5 4527.8 4615.2 4638.7 4743.2 4834.0 3432.6 3561.6 3568.1 3569.0 3569.0 631.2 634.8 645.2 649.4 649.8 616.5 662.6 672.9 733.8 763.9 9993.8 10395.4 10415.7 10434.9 10494.1 527.3 575.4 627.8 720.2 755.5 4859.0 4955.4 5036.5 5122.5 5163.0 69869.0 84348.0 104504.0 106914.5 106969.0 76742.0 92503.0 93074.0 94049.1 94379.0 58586.0 87240.0 88292.6 89040.6 89418.0 9754.8 9783.7 9834.7 9861.1 9904.5 49497.0 49950.8 50855.2 50884.2 53034.9 68269.0 76256.6 76495.0 77534.0 78708.1 12855.6 13002.7 13166.1 13351.9 14464.4 15139.8 15366.0 15411.2 15617.1 15649.8 14125.3 14158.8 14168.0 14404.6 14956.5 13626.0 13943.2 14148.4 14530.9 15473.0 14753.0 14776.3 14798.0 14856.6 14918.8 11340.2 11620.9 11626.3 11715.6 11755.8 11646.8 12314.9 12323.6 12397.3 12406.9 10:19:11 INFO - PROCESS | 14670 | -------- Summary: end -------- 10:19:11 INFO - PROCESS | 14670 | 10:19:12 INFO - TEST-INFO | 14670: exit 0 10:19:12 INFO - TEST-OK | dromaeo_css | took 1117201ms 10:19:12 INFO - TEST-START | kraken 10:19:12 INFO - operating with platform_type : linux_ 10:19:12 INFO - Initialising browser for kraken test... 10:19:12 INFO - TEST-INFO | started process 14855 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMJTgkc/profile http://localhost:44753/getInfo.html) 10:19:17 INFO - PROCESS | 14855 | __metrics Screen width/height:1600/1200 10:19:17 INFO - PROCESS | 14855 | colorDepth:24 10:19:17 INFO - PROCESS | 14855 | Browser inner width/height: 1024/697 10:19:17 INFO - PROCESS | 14855 | __metrics 10:19:18 INFO - PROCESS | 14855 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:19:19 INFO - PROCESS | 14855 | console.error: PushService: 10:19:19 INFO - PROCESS | 14855 | stateChangeProcessEnqueue: Error transitioning state 10:19:19 INFO - PROCESS | 14855 | UnknownError 10:19:19 INFO - TEST-INFO | 14855: exit 0 10:19:19 INFO - Browser initialized. 10:19:19 INFO - Running cycle 1/1 for kraken test... 10:19:19 INFO - TEST-INFO | started process 14937 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMJTgkc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:19:31 INFO - PROCESS | 14937 | RSS: Main: 174219264 10:19:31 INFO - PROCESS | 14937 | 10:19:34 INFO - PROCESS | 14937 | Cycle 1(1): loaded http://localhost:44753/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44753/tests/kraken/driver.html?testName=audio-beat-detection) 10:19:35 INFO - PROCESS | 14937 | RSS: Main: 232316928 10:19:35 INFO - PROCESS | 14937 | 10:19:37 INFO - PROCESS | 14937 | Cycle 1(1): loaded http://localhost:44753/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44753/tests/kraken/driver.html?testName=audio-dft) 10:19:38 INFO - PROCESS | 14937 | RSS: Main: 217923584 10:19:38 INFO - PROCESS | 14937 | 10:19:41 INFO - PROCESS | 14937 | Cycle 1(1): loaded http://localhost:44753/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44753/tests/kraken/driver.html?testName=audio-fft) 10:19:42 INFO - PROCESS | 14937 | RSS: Main: 286543872 10:19:42 INFO - PROCESS | 14937 | 10:19:44 INFO - PROCESS | 14937 | Cycle 1(1): loaded http://localhost:44753/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44753/tests/kraken/driver.html?testName=audio-oscillator) 10:19:44 INFO - PROCESS | 14937 | RSS: Main: 198053888 10:19:44 INFO - PROCESS | 14937 | 10:19:46 INFO - PROCESS | 14937 | Cycle 1(1): loaded http://localhost:44753/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44753/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:19:47 INFO - PROCESS | 14937 | RSS: Main: 202522624 10:19:47 INFO - PROCESS | 14937 | 10:19:50 INFO - PROCESS | 14937 | Cycle 1(1): loaded http://localhost:44753/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44753/tests/kraken/driver.html?testName=imaging-darkroom) 10:19:51 INFO - PROCESS | 14937 | RSS: Main: 235991040 10:19:51 INFO - PROCESS | 14937 | 10:19:54 INFO - PROCESS | 14937 | Cycle 1(1): loaded http://localhost:44753/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44753/tests/kraken/driver.html?testName=imaging-desaturate) 10:19:55 INFO - PROCESS | 14937 | RSS: Main: 238010368 10:19:55 INFO - PROCESS | 14937 | 10:19:57 INFO - PROCESS | 14937 | Cycle 1(1): loaded http://localhost:44753/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44753/tests/kraken/driver.html?testName=json-parse-financial) 10:19:58 INFO - PROCESS | 14937 | RSS: Main: 237748224 10:19:58 INFO - PROCESS | 14937 | 10:20:00 INFO - PROCESS | 14937 | Cycle 1(1): loaded http://localhost:44753/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44753/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:20:00 INFO - PROCESS | 14937 | RSS: Main: 224784384 10:20:00 INFO - PROCESS | 14937 | 10:20:02 INFO - PROCESS | 14937 | Cycle 1(1): loaded http://localhost:44753/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44753/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:20:03 INFO - PROCESS | 14937 | RSS: Main: 228429824 10:20:03 INFO - PROCESS | 14937 | 10:20:05 INFO - PROCESS | 14937 | Cycle 1(1): loaded http://localhost:44753/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44753/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:20:05 INFO - PROCESS | 14937 | RSS: Main: 236134400 10:20:05 INFO - PROCESS | 14937 | 10:20:08 INFO - PROCESS | 14937 | Cycle 1(1): loaded http://localhost:44753/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44753/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:20:08 INFO - PROCESS | 14937 | RSS: Main: 237887488 10:20:08 INFO - PROCESS | 14937 | 10:20:11 INFO - PROCESS | 14937 | Cycle 1(1): loaded http://localhost:44753/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44753/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:20:12 INFO - PROCESS | 14937 | RSS: Main: 234651648 10:20:12 INFO - PROCESS | 14937 | 10:20:13 INFO - PROCESS | 14937 | Cycle 1(1): loaded http://localhost:44753/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44753/tests/kraken/driver.html?testName=ai-astar) 10:20:14 INFO - PROCESS | 14937 | RSS: Main: 278675456 10:20:14 INFO - PROCESS | 14937 | 10:20:14 INFO - PROCESS | 14937 | __start_tp_report 10:20:14 INFO - PROCESS | 14937 | _x_x_mozilla_page_load 10:20:14 INFO - PROCESS | 14937 | _x_x_mozilla_page_load_details 10:20:14 INFO - PROCESS | 14937 | |i|pagename|runs| 10:20:14 INFO - PROCESS | 14937 | |0;ai-astar;100;110;111;110;111;110;109;109;113;109 10:20:14 INFO - PROCESS | 14937 | |1;audio-beat-detection;159;124;127;185;125;128;152;134;159;125 10:20:14 INFO - PROCESS | 14937 | |2;audio-dft;160;160;160;161;159;162;159;161;160;161 10:20:14 INFO - PROCESS | 14937 | |3;audio-fft;74;74;74;111;74;75;74;74;100;75 10:20:14 INFO - PROCESS | 14937 | |4;audio-oscillator;84;86;112;85;85;85;122;85;85;134 10:20:14 INFO - PROCESS | 14937 | |5;imaging-gaussian-blur;120;116;116;117;116;117;117;116;116;117 10:20:14 INFO - PROCESS | 14937 | |6;imaging-darkroom;146;146;146;145;145;145;146;145;145;145 10:20:14 INFO - PROCESS | 14937 | |7;imaging-desaturate;95;96;96;95;96;96;95;95;96;96 10:20:14 INFO - PROCESS | 14937 | |8;json-parse-financial;52;52;53;54;53;54;53;53;53;53 10:20:14 INFO - PROCESS | 14937 | |9;json-stringify-tinderbox;62;61;61;62;62;61;61;62;62;63 10:20:14 INFO - PROCESS | 14937 | |10;stanford-crypto-aes;82;84;78;78;84;80;80;79;89;78 10:20:14 INFO - PROCESS | 14937 | |11;stanford-crypto-ccm;121;120;121;117;117;118;115;120;139;132 10:20:14 INFO - PROCESS | 14937 | |12;stanford-crypto-pbkdf2;157;156;156;158;156;155;157;157;155;158 10:20:14 INFO - PROCESS | 14937 | |13;stanford-crypto-sha256-iterative;66;63;63;62;63;62;63;63;61;61 10:20:14 INFO - PROCESS | 14937 | __end_tp_report 10:20:14 INFO - PROCESS | 14937 | __start_cc_report 10:20:14 INFO - PROCESS | 14937 | _x_x_mozilla_cycle_collect,1608 10:20:14 INFO - PROCESS | 14937 | __end_cc_report 10:20:14 INFO - PROCESS | 14937 | __startTimestamp1466616014025__endTimestamp 10:20:14 INFO - PROCESS | 14937 | 10:20:14 INFO - PROCESS | 14937 | ------- Summary: start ------- 10:20:14 INFO - PROCESS | 14937 | Number of tests: 14 10:20:14 INFO - PROCESS | 14937 | 10:20:14 INFO - PROCESS | 14937 | [#0] ai-astar Cycles:10 Average:109.20 Median:110.00 stddev:3.46 (3.1%) stddev-sans-first:1.30 10:20:14 INFO - PROCESS | 14937 | Values: 100.0 110.0 111.0 110.0 111.0 110.0 109.0 109.0 113.0 109.0 10:20:14 INFO - PROCESS | 14937 | 10:20:14 INFO - PROCESS | 14937 | [#1] audio-beat-detection Cycles:10 Average:141.80 Median:143.00 stddev:20.85 (14.6%) stddev-sans-first:21.17 10:20:14 INFO - PROCESS | 14937 | Values: 159.0 124.0 127.0 185.0 125.0 128.0 152.0 134.0 159.0 125.0 10:20:14 INFO - PROCESS | 14937 | 10:20:14 INFO - PROCESS | 14937 | [#2] audio-dft Cycles:10 Average:160.30 Median:160.50 stddev:0.95 (0.6%) stddev-sans-first:1.00 10:20:14 INFO - PROCESS | 14937 | Values: 160.0 160.0 160.0 161.0 159.0 162.0 159.0 161.0 160.0 161.0 10:20:14 INFO - PROCESS | 14937 | 10:20:14 INFO - PROCESS | 14937 | [#3] audio-fft Cycles:10 Average:80.50 Median:74.00 stddev:13.44 (18.2%) stddev-sans-first:14.04 10:20:14 INFO - PROCESS | 14937 | Values: 74.0 74.0 74.0 111.0 74.0 75.0 74.0 74.0 100.0 75.0 10:20:14 INFO - PROCESS | 14937 | 10:20:14 INFO - PROCESS | 14937 | [#4] audio-oscillator Cycles:10 Average:96.30 Median:85.00 stddev:18.93 (22.3%) stddev-sans-first:19.54 10:20:14 INFO - PROCESS | 14937 | Values: 84.0 86.0 112.0 85.0 85.0 85.0 122.0 85.0 85.0 134.0 10:20:14 INFO - PROCESS | 14937 | 10:20:14 INFO - PROCESS | 14937 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:1.23 (1.1%) stddev-sans-first:0.53 10:20:14 INFO - PROCESS | 14937 | Values: 120.0 116.0 116.0 117.0 116.0 117.0 117.0 116.0 116.0 117.0 10:20:14 INFO - PROCESS | 14937 | 10:20:14 INFO - PROCESS | 14937 | [#6] imaging-darkroom Cycles:10 Average:145.40 Median:145.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 10:20:14 INFO - PROCESS | 14937 | Values: 146.0 146.0 146.0 145.0 145.0 145.0 146.0 145.0 145.0 145.0 10:20:14 INFO - PROCESS | 14937 | 10:20:14 INFO - PROCESS | 14937 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.52 (0.5%) stddev-sans-first:0.50 10:20:14 INFO - PROCESS | 14937 | Values: 95.0 96.0 96.0 95.0 96.0 96.0 95.0 95.0 96.0 96.0 10:20:14 INFO - PROCESS | 14937 | 10:20:14 INFO - PROCESS | 14937 | [#8] json-parse-financial Cycles:10 Average:53.00 Median:53.00 stddev:0.67 (1.3%) stddev-sans-first:0.60 10:20:14 INFO - PROCESS | 14937 | Values: 52.0 52.0 53.0 54.0 53.0 54.0 53.0 53.0 53.0 53.0 10:20:14 INFO - PROCESS | 14937 | 10:20:14 INFO - PROCESS | 14937 | [#9] json-stringify-tinderbox Cycles:10 Average:61.70 Median:62.00 stddev:0.67 (1.1%) stddev-sans-first:0.71 10:20:14 INFO - PROCESS | 14937 | Values: 62.0 61.0 61.0 62.0 62.0 61.0 61.0 62.0 62.0 63.0 10:20:14 INFO - PROCESS | 14937 | 10:20:14 INFO - PROCESS | 14937 | [#10] stanford-crypto-aes Cycles:10 Average:81.20 Median:81.00 stddev:3.58 (4.4%) stddev-sans-first:3.79 10:20:14 INFO - PROCESS | 14937 | Values: 82.0 84.0 78.0 78.0 84.0 80.0 80.0 79.0 89.0 78.0 10:20:14 INFO - PROCESS | 14937 | 10:20:14 INFO - PROCESS | 14937 | [#11] stanford-crypto-ccm Cycles:10 Average:122.00 Median:120.50 stddev:7.56 (6.3%) stddev-sans-first:8.01 10:20:14 INFO - PROCESS | 14937 | Values: 121.0 120.0 121.0 117.0 117.0 118.0 115.0 120.0 139.0 132.0 10:20:14 INFO - PROCESS | 14937 | 10:20:14 INFO - PROCESS | 14937 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:156.50 Median:157.00 stddev:1.08 (0.7%) stddev-sans-first:1.13 10:20:14 INFO - PROCESS | 14937 | Values: 157.0 156.0 156.0 158.0 156.0 155.0 157.0 157.0 155.0 158.0 10:20:14 INFO - PROCESS | 14937 | 10:20:14 INFO - PROCESS | 14937 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.70 Median:63.00 stddev:1.42 (2.3%) stddev-sans-first:0.87 10:20:14 INFO - PROCESS | 14937 | Values: 66.0 63.0 63.0 62.0 63.0 62.0 63.0 63.0 61.0 61.0 10:20:14 INFO - PROCESS | 14937 | -------- Summary: end -------- 10:20:14 INFO - PROCESS | 14937 | 10:20:14 INFO - TEST-INFO | 14937: exit 0 10:20:15 INFO - TEST-OK | kraken | took 62640ms 10:20:15 INFO - SUITE-END | took 1179s 10:20:15 INFO - Completed test suite (00:19:40) 10:20:15 INFO - javascript benchmark 10:20:15 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3044.9695503044977, 3083.938321233577, 3099.3646302507987, 3108.7668424868134, 3108.849725601526, 5171.0692075426405, 5254.264402983586, 5257.605679574033, 5331.946680533193, 5338.0658384782655, 5262.236975638531, 5283.709395983219, 5291.841244762663, 5298.046351656701, 5311.415744268137, 4758.571728544439, 4798.1123492154065, 4846.0, 4868.318435419044, 4965.726885021322, 4852.102361063215, 4863.416390033201, 4889.291052797343, 4916.43461001984, 4937.80248790048, 4659.464161621423, 4676.18166820805, 4751.762411879409, 4782.569568738831, 4784.11493873631, 4766.904661906742, 4769.499202583714, 4779.593734532569, 4857.2714092886, 4898.0, 4810.975945120252, 4839.467658557556, 4840.346553215306, 4841.540053694894, 4847.006363695434, 5146.433892271847, 5182.170852663593, 5200.24596433515, 5247.921281180786, 5253.921191182136, 5617.943820561783, 5623.465770751813, 5707.77168913243, 5707.885842283131, 5708.65748055118, 5687.289088863892, 5726.0, 5726.3414707308775, 5742.82771516851, 5743.885122297531, 5123.2315152727015, 5270.57835373173, 5301.151815709506, 5314.681119132864, 5396.622236443412, 5836.9124463133085, 5855.238818953509, 5860.472557469848, 5860.882782344414, 5864.2083318752275, 5410.053240682865, 5619.775208991677, 5632.4930756231315, 5653.406392328829, 5678.261825962599, 5565.053940830068, 5599.132134519156, 5608.0, 5704.258446402024, 5708.172315014383, 5629.802956896571, 5639.605227634108, 5642.915356269659, 5643.5203007743985, 5645.576581756384, 5546.667199967934, 5614.747336369873, 5614.9438505615235, 5618.52242559387, 5624.578156638268, 4153.522344930311, 4266.445362102969, 4267.317229243368, 4280.571942805695, 4313.331433627793, 3838.616138386195, 3848.5189351331082, 3853.672437842815, 3886.7862267574988, 3887.8250478728523, 5215.765290561933, 5337.119375303109, 5350.839474815762, 5352.2506849041165, 5355.598330125178, 5620.213170156181, 5645.887082258332, 5650.067738823131, 5680.715964201856, 5685.090385538294, 5337.412884582693, 5363.973180134152, 5371.382291036581, 5371.75827087782, 5374.086405311106, 4745.786439610226, 4835.564799168092, 4921.926171107436, 4926.75366231687, 4961.553460188528, 5797.275340582427, 5817.621854579524, 5834.737436815353, 5844.3571207168025, 5892.322382925932, 5633.2395126657375, 5637.774489020393, 5639.295088113986, 5643.52030077448, 5649.519790817662, 5649.435056494318, 5774.538036957118, 5793.04414771558, 5845.0, 5849.824505264849, 5569.303837020372, 5574.498295153456, 5581.49766521015, 5617.691026993554, 5620.859478512906, 5604.075327571069, 5648.887022259614, 5657.773689052392, 5659.151127330933, 5669.149627555899, 4899.0, 5367.543758780391, 5465.0, 5539.529140023144, 5549.0, 5467.6719396836315, 5490.396056433869, 5501.752421140978, 5502.119660854244, 5507.834764957058, 5431.131019036935, 5436.103042997861, 5437.700926448925, 5443.265159203615, 5493.395726470165, 5373.489518495737, 5490.917636235539, 5510.724463776715, 5524.66851988882, 5528.585356098389, 5421.457854214705, 5456.809011684731, 5459.454054594509, 5462.153366228241, 5462.754176062166], "value": 5205.177688439633, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [594.6491569973715, 622.4335854372521, 624.6158612453339, 636.936306369363, 640.679660169915, 30743.385132297342, 31319.21701957452, 33809.492857607125, 44798.0, 46900.76549617256, 44843.32735008978, 45193.0, 45255.32117018248, 45295.54704452954, 45302.0, 8821.69124080659, 8953.194212520872, 8973.237274831614, 8980.0, 8992.595333210022, 8881.511516866569, 8998.910010899872, 8999.865002024942, 9007.414518056337, 9008.54957252138, 8982.101789820998, 9007.0, 9017.053209413016, 9022.233110185642, 9027.729168124966, 8921.776955576097, 8979.416337938013, 8990.820183596292, 8993.055729148477, 8996.550172491381, 8869.512176830336, 8914.50970196639, 8934.553272336358, 8940.240079593243, 8942.776430589287, 41575.58424415747, 41869.371959420634, 42044.579554204676, 42060.789696051324, 42101.36847947283, 3687.3915803892323, 3705.4441833724886, 3723.2925744108534, 3777.2445510897655, 4061.7969101544804, 30065.098047058622, 32054.839725801456, 32381.83809080963, 32450.513242301386, 32501.83749081263, 4186.811593478301, 4301.935470967906, 4331.0, 4370.781460926941, 4512.300593408027, 369548.0, 370064.0, 371137.0, 372888.0, 373155.99999999726, 60014.39985600176, 60052.39947600556, 60131.09803352953, 60152.0, 60483.69758151269, 62490.437739055975, 63062.68468657719, 63098.0, 63610.36389636137, 63638.36361636417, 16424.1787910604, 16573.17134143288, 16722.414715484898, 16744.330226790793, 16745.832541674426, 12667.93666031664, 12818.423170957329, 12849.0, 12850.742985140245, 12851.100422970303, 18859.434216973514, 18926.3375781847, 19105.522361940784, 19124.139413726414, 19295.614087718448, 6930.549514281555, 7096.432285417154, 7167.211606723256, 7229.7469588564145, 7282.271772822675, 919.2921450483091, 1078.6063086973197, 1084.969279184762, 1125.9155563332783, 1130.3161587239765, 31906.840465797522, 32114.59441107577, 32229.0, 33007.50488742623, 33044.50433243503, 998.8701468809154, 1036.6268143468346, 1072.1476426241156, 1119.7144728094283, 1156.5894107591685, 16734.07558130806, 17028.829711702725, 17104.11545476164, 17106.91446542759, 17385.913070434566, 562305.0, 566189.0, 566196.0, 566265.0, 567367.0, 57997.0, 58461.4153858456, 58552.4144758547, 58571.70714146402, 58624.12063819046, 1196.5333519927235, 1282.3716378974423, 1316.5721140629335, 1327.508821735964, 1329.0497294434526, 32153.356932860745, 33283.0, 33679.66320336765, 33710.325793483506, 33898.83050584731, 49768.0, 49831.0, 50244.24633630572, 50247.49752502428, 50290.0, 414636.0, 417838.0, 418113.0, 418959.0, 419313.0, 24434.14480493174, 26391.34021649474, 27468.429104216324, 27634.0, 27814.86092569524, 48630.0, 48886.26670599873, 48924.0, 49663.0, 49984.0, 39828.0, 40010.0, 40771.79614102029, 40994.59005409908, 41040.79479602583, 40008.3998740025, 40460.39309410303, 40894.79552602218, 40922.79538602288, 41249.79375103105, 40151.99620009523, 40841.38737918874, 41023.38464923088, 41165.58834411618, 41341.37987930243, 32759.0, 35835.462468063524, 36125.27749445049, 36325.27349453049, 36479.817600911825, 27170.32074198161, 27472.725272747015, 27509.62451877358, 27533.17400477989, 27636.0], "value": 20157.266986631243, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [390.6074395232791, 396.3242671245525, 397.197660725335, 404.7510780869765, 417.6700406678724, 13061.24350641788, 18455.26178952842, 20016.19935202592, 20030.0, 20653.483662908435, 14661.633459163526, 19307.903460482677, 19411.70882436761, 19522.023898805037, 19958.90020549895, 5499.450054994509, 5720.713964301789, 5724.026915424388, 5733.885322293551, 5754.7410366533395, 5579.944200558003, 5663.830085097454, 5684.147377893308, 5688.11834165705, 5689.743961521721, 4154.335306350985, 5940.554458415614, 6195.8141255762175, 6235.5011599072195, 6336.5881217720935, 6034.336223015464, 6251.968740156293, 6255.562110652256, 6269.0909818076125, 6323.873522529547, 5503.394626591072, 5554.222408862763, 5570.526505247059, 5570.637908535973, 5574.414686457944, 22631.77368226313, 23063.077476900904, 23988.760112398828, 24086.518269634686, 24097.156599518934, 2084.4163634182455, 2309.099451214028, 2343.015933307998, 2427.7693619106158, 2808.4804311202492, 9568.952155239249, 10259.948700256526, 10268.024537668909, 11305.604303849326, 15031.0, 1909.284018493065, 1941.708743688458, 1998.4404366777326, 2011.095007246745, 2064.298138632872, 73214.63392683056, 78621.0, 78689.60655196688, 79741.60129199317, 80874.99999999942, 8664.350173736995, 9118.452892826452, 9285.210757085588, 10048.296619236584, 10176.643817466353, 13024.47902083925, 13147.14543554685, 13215.207087574776, 13229.73540529184, 13234.470621175045, 7160.749373771997, 7475.289847464483, 7574.659140338587, 7610.581418022062, 7668.309852113337, 7315.4147668186415, 7325.084364454443, 7525.021747172833, 7525.172231054579, 7539.095308562898, 4025.9798701006894, 4193.18232944579, 4378.16814805186, 4548.363229147922, 8238.217369350023, 3307.9007629771145, 3432.3993301172195, 3477.3566890125408, 3528.8588456461453, 3631.418972964313, 847.5211505499373, 933.3839665820526, 1000.7598176437602, 1028.6348346337093, 1056.4136904018344, 18720.81279187218, 19005.14476848545, 19730.717503362237, 19814.20743170257, 19948.401547953294, 936.1574582875467, 945.5981207986579, 963.8313295173317, 967.5162418790604, 1006.9395836249848, 10821.458927053616, 11150.832737508943, 11163.218574699693, 11175.44122793857, 11193.776124477465, 489120.0, 492220.0, 498430.0, 503194.0, 503211.0, 92797.0, 96321.0, 96417.0, 96832.51583742036, 97380.51309743406, 961.3078583419926, 962.6390103711249, 980.9166220871164, 985.1527686189871, 987.1905037868878, 17499.212535435683, 17641.206145723216, 17913.552161195552, 17914.462566122515, 18213.0, 42865.571344287404, 43426.0, 43553.56446435495, 44056.339154913345, 44119.33820992752, 52927.0, 53039.73480132574, 54675.72662136664, 61905.38094619176, 62117.37882621116, 7682.116556596063, 7856.0, 7858.096318923397, 8163.428560000743, 8469.110743371857, 9570.377925434825, 13047.28239946812, 13712.65718357009, 14077.929610351883, 14222.577742225694, 10769.192310576895, 11837.881621183678, 12169.452374642986, 12220.144589878622, 12300.384980751105, 12083.939580302042, 12132.272063676208, 12244.10216416457, 12377.443015064164, 12484.313362764771, 11761.529538818351, 12503.187292825936, 12650.987920966116, 12773.0, 12794.36028198605, 8584.399092063495, 8636.740897773077, 8649.308055355683, 8722.781930451789, 9000.729978100668, 11225.66323010311, 12212.389380531116, 12308.507659693512, 12313.938430307791, 12694.936525317315], "value": 9352.166066851425, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1273.9681507962305, 1435.239323158726, 1466.3474753734586, 1541.9306131224093, 1716.605180808414, 7491.925080749191, 8406.327493800496, 8591.012033616129, 8606.784830379243, 8862.158094980967, 8594.87107693385, 8632.568371581427, 8694.21752042316, 8699.217070463657, 8703.173198546145, 2217.3458829645215, 2249.7862703043265, 2251.448395143192, 2254.4589298568308, 2254.627986382245, 2197.3627647982066, 2246.5619204255177, 2252.4594097416584, 2255.041607316884, 2259.7740225977436, 2195.3304242206123, 2201.966970495444, 2209.237812954528, 2211.3365990202956, 2225.4547635829163, 2155.8814265215406, 2177.172674383732, 2181.5854987552316, 2182.0289970962926, 2183.9890800545977, 2206.0, 2208.2602328220064, 2210.801027907496, 2213.878236696981, 2215.2578886073184, 8660.610272537751, 8687.261582765472, 8798.164174403422, 8806.735797926072, 8813.515256660881, 4712.811487540494, 4865.781039853215, 4868.829590964335, 4870.65905386623, 4871.537203965618, 3250.2849373137874, 3434.587849458081, 3438.6045604755273, 3511.525943997553, 3520.436730123168, 1121.3216004317433, 1165.702745799824, 1173.5775120956448, 1179.345463267886, 1195.4500929572407, 12706.872931270662, 12927.48290068396, 12937.547185848543, 12941.288229147487, 12944.805827912589, 4381.101874115799, 4403.691741578123, 4457.64338852891, 4493.775311234425, 4509.932351014738, 9643.855342169873, 9650.855237171449, 9662.275329350186, 9664.516774161264, 9667.516624168764, 5112.6421150519855, 5113.411957624847, 5115.948840511622, 5116.923246151311, 5119.539241468286, 4079.286124928126, 4136.793160341971, 4605.562471565196, 4678.742669153161, 4720.9141897363115, 3586.3544561978574, 3599.1721903962234, 3626.9818650906577, 3745.9063523412133, 3865.5747867734526, 1072.485207100596, 1128.9491972861076, 1131.960381386664, 1141.4007645985923, 1149.0290704354807, 905.6241659711278, 961.9470929098827, 986.1519093579659, 991.1179050644931, 994.0159242350165, 5943.762249510058, 5954.761809527657, 6046.3349031606485, 6251.156093927261, 6253.0, 428.07322147550826, 434.1685671938266, 436.77069538492543, 997.3915911294105, 1026.9743256418649, 4088.2436749200897, 4159.625633692982, 4169.10364271677, 4169.1661667666585, 4180.644645205191, 11167.106631469464, 11500.654980350602, 11524.94237528807, 11581.0, 11583.305001699757, 11261.0, 11406.657800266004, 11527.250728702607, 11552.59565915189, 11553.768924621461, 8475.872861907077, 8496.150384961455, 8650.610722517502, 8651.6971905983, 8721.738347849574, 6113.358097399887, 6155.107509411021, 6195.845103872439, 6215.502759779117, 6341.746330146927, 8967.50678712651, 9325.953370233105, 9334.953325233331, 10373.118284945864, 10637.787244254916, 9378.531073446164, 9501.57242924084, 9824.754381140528, 9846.163076138322, 9857.802843942938, 6984.196817366068, 7513.624318784148, 7690.538567685957, 7728.729494467667, 7937.960310198643, 8416.579171041301, 8442.113578074213, 8469.195426434479, 8497.490150590984, 8517.914820851713, 7786.532808031537, 7807.609619519115, 7810.765677029698, 7917.802054948673, 7941.523508589503, 7510.624468776648, 7656.69373225087, 7710.074791024888, 7783.066032076187, 7788.376929845485, 6927.376536111774, 6982.685779140053, 6996.405305549085, 6997.510174287751, 6999.440044796303, 5284.7886084556185, 5343.0, 5382.138857782736, 5393.244945707525, 5451.318585176853, 4851.102546028996, 4887.095887260868, 4893.119238537098, 5021.096202683552, 5089.949100508948], "value": 4523.858802852317, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [302.96537325035007, 312.65139369602895, 320.2218608780665, 322.10776150064316, 323.2807004415175, 4996.475370086143, 5117.411497677768, 5187.170052791555, 5189.702574356411, 5195.844124676261, 5157.896842063156, 5212.0, 5226.320578324812, 5229.947700522994, 5252.71110088945, 4074.9405154659853, 4085.9795701021526, 4093.774842383668, 4095.262852686515, 4099.426080348753, 3864.7101467389916, 3870.8645197418095, 4079.77561234132, 4103.199876024177, 4122.0, 4021.27085353298, 4034.7377420467574, 4085.2850751118585, 4085.7957102144924, 4087.4073259377374, 4012.8796136115816, 4028.536718277406, 4035.4148648446103, 4042.4542686737354, 4085.428040074392, 3533.152043509565, 3597.334493118781, 3609.657082577151, 3617.4212126059965, 3624.3294990426593, 5070.771815268285, 5075.467075957008, 5089.592832573385, 5091.26896855071, 5096.79612815487, 4640.744759038252, 4651.86044418668, 4658.930116048262, 4661.0, 4667.299905014275, 5226.686398816083, 5356.196570514415, 5358.365698461967, 5400.83797486076, 5422.566194704415, 3931.6461518463475, 3952.288588054149, 3953.150072734376, 3954.169624378855, 3962.2669806085964, 5571.4150014248735, 5587.413321601214, 5600.299962504687, 5666.178404131378, 5691.772329106872, 4050.4734384529825, 4051.5745846685672, 4061.862678450039, 4071.1247081877536, 4093.63157315843, 3762.9247415051545, 3966.603339666068, 3967.7222594418113, 3993.6405723485027, 4004.5795191505053, 4583.289590113538, 4587.472440669299, 4592.632589392841, 4597.149527337453, 4612.192866248461, 5438.184272359178, 5455.34535855692, 5481.424450432727, 5490.588205884575, 5510.134729940409, 1307.8038294255937, 1333.8666133386585, 1344.435337158396, 1378.7518246715488, 1387.6253411578816, 868.5917618719192, 872.9738107856774, 881.7883707910055, 889.621910687955, 890.3633901760272, 4640.909386294218, 4687.507811679793, 4693.24908014716, 4693.319468677023, 4701.200795864711, 4929.926051109236, 4958.380202474691, 4982.252662100714, 5001.5498605124985, 5028.893643398446, 4445.866624001285, 4678.7660616969015, 4691.225947718588, 4763.927691454229, 4782.402199725035, 2598.2075466982374, 2600.8569528675725, 2608.6217498462615, 2624.7506486883717, 2645.973540264611, 5066.949330506722, 5116.462771409023, 5118.899436621145, 5129.487051294841, 5146.639735218499, 4807.759612019385, 4897.657163998486, 5008.799648014112, 5024.794049428111, 5055.3428054353435, 5060.367454068241, 5063.898722025612, 5064.164412871834, 5074.391073071255, 5104.285400043997, 4911.926321105258, 4938.9259161111895, 4951.751143787596, 5018.573421259088, 5024.949750502448, 4655.883602909955, 4952.579030782424, 4963.379577552806, 4997.275395067768, 4998.525140111684, 5123.513266239701, 5138.229265610188, 5143.6399452039495, 5143.71709555978, 5178.482151784791, 3651.251493443891, 3665.8533658654424, 3691.9261614767015, 3699.6115407881784, 3710.7959062251834, 4764.0, 4907.656464047483, 4968.180250258812, 4971.787554538196, 5073.16292811682, 4847.515248475265, 4857.489963553918, 4858.295547145714, 4916.746229711401, 4921.9507804921495, 4821.5178482152905, 4862.173430516891, 4872.220444728827, 4898.559129678346, 4927.457979622311, 4703.647226458098, 4728.456227533878, 4740.407449068866, 4779.402574678165, 4972.776225069808, 5461.808836690697, 5485.6434331768305, 5508.631288545964, 5511.22842802016, 5511.807086751945, 5393.6224464287125, 5395.379531353945, 5396.7571459283645, 5400.594955378284, 5422.945770542244], "value": 3955.110872802956, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [719.6797425145811, 753.8379248461583, 780.8321210939647, 783.0916137280749, 825.2531459029576, 13893.096948698327, 14468.855311446883, 15206.619834504143, 15424.383024679028, 15513.534593962186, 14152.929235353835, 14326.068805527633, 14341.354639041243, 14366.712665746705, 14559.708805823877, 665.1552528289094, 780.2782426255719, 796.6056801883061, 805.7179987004561, 808.0465051239535, 799.6841247707152, 800.8078061265313, 801.8516574433719, 802.1256830055239, 802.6829402386054, 845.3364109174299, 845.6913226672282, 845.7800971747359, 845.7843249971248, 846.3102571404316, 697.1146643762419, 794.06697130871, 809.2271880354248, 810.8175660476346, 844.6452489954233, 599.1163034524086, 601.4406601860268, 601.5879122800895, 601.714185761764, 601.9488343490808, 14361.49734759289, 14370.065945713495, 14376.856231437761, 14411.135331880121, 14445.349959251755, 14256.144631322153, 14585.854141458556, 14719.411223551046, 14796.482123125747, 14955.850441495555, 12426.627201183888, 12819.487220511168, 12831.230126192459, 12917.418716157796, 13105.934470327682, 4489.393931819228, 4639.721616703008, 4676.462206846222, 4703.3885594872445, 4747.762611869427, 73898.0, 74006.25993740048, 74134.0, 74279.62860185718, 74975.62512187459, 11456.427178641035, 11526.193166478433, 11746.70633234176, 11782.057435405148, 12123.151379403533, 21731.67402488964, 21824.0, 21910.12359505602, 21943.341699749035, 21957.341279761313, 8314.919060522094, 8558.0, 8564.057953625097, 8615.138486151334, 8672.479651220947, 4527.796249168795, 4615.16926953145, 4638.698484598491, 4743.241081426955, 4834.033193361342, 3432.553768010143, 3561.6438356164176, 3568.125809176768, 3568.9650001499276, 3569.0185199070465, 631.1983780598614, 634.80321100459, 645.1806206118204, 649.4285029174297, 649.8148027812051, 616.4575173847076, 662.5693299355457, 672.9394354508117, 733.7725305155419, 763.9236076392427, 9993.80012399748, 10395.376277423378, 10415.739606509898, 10434.895651043544, 10494.055535001733, 527.3408239700375, 575.3728436004775, 627.8336240896166, 720.1538192623751, 755.4975940999174, 4858.975705121452, 4955.430125535538, 5036.471170527115, 5122.487751224848, 5162.9741851291255, 69869.0, 84348.0, 104504.00911799392, 106914.46542767236, 106969.0, 76742.0, 92503.0, 93074.0, 94049.0595094054, 94379.0, 58586.0, 87240.0, 88292.55853720818, 89040.5547972269, 89418.0, 9754.75613109678, 9783.719937666965, 9834.655787047419, 9861.112499875046, 9904.455254961047, 49497.0, 49950.750246248535, 50855.23717144172, 50884.236736449726, 53034.93930121453, 68268.97596536155, 76256.61871690606, 76495.0, 77534.0, 78708.12918708083, 12855.550055748005, 13002.674933126747, 13166.144200626928, 13351.933240333736, 14464.421423142956, 15139.772903406678, 15366.0, 15411.152386618394, 15617.14105724196, 15649.765253520978, 14125.293735312987, 14158.787618185941, 14168.0, 14404.567862964128, 14956.476523321631, 13626.0, 13943.233122177971, 14148.363323650254, 14530.854691453373, 15473.0, 14753.0, 14776.261186940825, 14798.0, 14856.554303370916, 14918.77621835695, 11340.20618556693, 11620.941895290469, 11626.320835845534, 11715.648530544097, 11755.823662644896, 11646.825297620373, 12314.938425308175, 12323.568675096329, 12397.318147501974, 12406.937965310115], "value": 7591.609533194588, "unit": "score"}], "name": "dromaeo_css", "value": 7147.241713764164, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 110.0, 111.0, 110.0, 111.0, 110.0, 109.0, 109.0, 113.0, 109.0], "value": 109.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 124.0, 127.0, 185.0, 125.0, 128.0, 152.0, 134.0, 159.0, 125.0], "value": 141.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 160.0, 161.0, 159.0, 162.0, 159.0, 161.0, 160.0, 161.0], "value": 160.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 74.0, 111.0, 74.0, 75.0, 74.0, 74.0, 100.0, 75.0], "value": 80.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 86.0, 112.0, 85.0, 85.0, 85.0, 122.0, 85.0, 85.0, 134.0], "value": 96.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 116.0, 116.0, 117.0, 116.0, 117.0, 117.0, 116.0, 116.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 145.0, 145.0, 145.0, 146.0, 145.0, 145.0, 145.0], "value": 145.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 96.0, 95.0, 96.0, 96.0, 95.0, 95.0, 96.0, 96.0], "value": 95.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 52.0, 53.0, 54.0, 53.0, 54.0, 53.0, 53.0, 53.0, 53.0], "value": 53.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 61.0, 61.0, 62.0, 62.0, 61.0, 61.0, 62.0, 62.0, 63.0], "value": 61.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 84.0, 78.0, 78.0, 84.0, 80.0, 80.0, 79.0, 89.0, 78.0], "value": 81.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 120.0, 121.0, 117.0, 117.0, 118.0, 115.0, 120.0, 139.0, 132.0], "value": 122.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 156.0, 156.0, 158.0, 156.0, 155.0, 157.0, 157.0, 155.0, 158.0], "value": 156.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 63.0, 63.0, 62.0, 63.0, 62.0, 63.0, 63.0, 61.0, 61.0], "value": 62.7, "unit": "score"}], "name": "kraken", "value": 1483.0, "alertThreshold": 2.0}]} 10:20:15 INFO - Return code: 0 10:20:15 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:20:15 INFO - # TBPL SUCCESS # 10:20:15 INFO - Running post-action listener: _resource_record_post_action 10:20:15 INFO - ##### 10:20:15 INFO - ##### Finished run-tests step (success) 10:20:15 INFO - ##### 10:20:15 INFO - Running post-run listener: _resource_record_post_run 10:20:15 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 4096; Write bytes: 550404096; Read time: 32; Write time: 1547448 10:20:15 INFO - TinderboxPrint: CPU usage
13.5% 10:20:15 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 32 10:20:15 INFO - TinderboxPrint: I/O write bytes / time
550,404,096 / 1,547,448 10:20:15 INFO - TinderboxPrint: CPU idle
8,278.9 (86.5%) 10:20:15 INFO - TinderboxPrint: CPU user
1,219.2 (12.7%) 10:20:15 INFO - TinderboxPrint: Swap in / out
0 / 0 10:20:15 INFO - install - Wall time: 18s; CPU: 17.0%; Read bytes: 0; Write bytes: 213139456; Read time: 0; Write time: 775000 10:20:15 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 4096; Write bytes: 294084608; Read time: 32; Write time: 750708 10:20:15 INFO - Running post-run listener: _upload_blobber_files 10:20:15 INFO - Blob upload gear active. 10:20:15 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:20:15 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 10:20:15 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', 'Mozilla-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:20:15 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 Mozilla-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:20:16 INFO - (blobuploader) - INFO - Open directory for files ... 10:20:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:20:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:20:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:20:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:20:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:20:17 INFO - (blobuploader) - INFO - Done attempting. 10:20:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:20:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:20:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:20:20 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:20:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:20:20 INFO - (blobuploader) - INFO - Done attempting. 10:20:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:20:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:20:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:20:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:20:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:20:21 INFO - (blobuploader) - INFO - Done attempting. 10:20:21 INFO - (blobuploader) - INFO - Iteration through files over. 10:20:21 INFO - Return code: 0 10:20:21 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:20:21 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:20:21 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/1cc01260e938ae06dd8d9c8e6a5fc8c6153db2c3e7498f44302c2a04362d2c72a7c4eb24a9addbecab261340781e5a53567a0f2cf68f4e52a713df5e3ac1ad47", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/cdd7a1287fab4ca984ae73261769e84b0bb2a422604c2681be43bcdaf260a5ce61573e6168c8deb024e887aefaa25fe42f51e7ae2ccc0c4f344d267d9b547dfd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/14711118fddadc8162b3400f63a3877a03a66ac3061b704132577e450e41b43f1997b3a7f0ce7a84f18b06d17b69bd81a9d7247db01cfb1d0046a6024371f67a"} 10:20:21 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:20:21 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:20:21 INFO - Contents: 10:20:21 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/1cc01260e938ae06dd8d9c8e6a5fc8c6153db2c3e7498f44302c2a04362d2c72a7c4eb24a9addbecab261340781e5a53567a0f2cf68f4e52a713df5e3ac1ad47", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/cdd7a1287fab4ca984ae73261769e84b0bb2a422604c2681be43bcdaf260a5ce61573e6168c8deb024e887aefaa25fe42f51e7ae2ccc0c4f344d267d9b547dfd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/14711118fddadc8162b3400f63a3877a03a66ac3061b704132577e450e41b43f1997b3a7f0ce7a84f18b06d17b69bd81a9d7247db01cfb1d0046a6024371f67a"} 10:20:21 INFO - Running post-run listener: copy_logs_to_upload_dir 10:20:21 INFO - Copying logs to upload dir... 10:20:21 INFO - mkdir: /builds/slave/test/build/upload/logs 10:20:21 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1254.421161 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2016-06-22 10:20:21.284890) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-22 10:20:21.288983) ========= 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=8783db0840cc980e80bb0bd400000236-1466613596.232306-769184124 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/1cc01260e938ae06dd8d9c8e6a5fc8c6153db2c3e7498f44302c2a04362d2c72a7c4eb24a9addbecab261340781e5a53567a0f2cf68f4e52a713df5e3ac1ad47", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/cdd7a1287fab4ca984ae73261769e84b0bb2a422604c2681be43bcdaf260a5ce61573e6168c8deb024e887aefaa25fe42f51e7ae2ccc0c4f344d267d9b547dfd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/14711118fddadc8162b3400f63a3877a03a66ac3061b704132577e450e41b43f1997b3a7f0ce7a84f18b06d17b69bd81a9d7247db01cfb1d0046a6024371f67a"} build_url:https://queue.taskcluster.net/v1/task/cx0oPaHhS_OO8wzmZreKwg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011361 build_url: 'https://queue.taskcluster.net/v1/task/cx0oPaHhS_OO8wzmZreKwg/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/Mozilla-Inbound/sha512/1cc01260e938ae06dd8d9c8e6a5fc8c6153db2c3e7498f44302c2a04362d2c72a7c4eb24a9addbecab261340781e5a53567a0f2cf68f4e52a713df5e3ac1ad47", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/cdd7a1287fab4ca984ae73261769e84b0bb2a422604c2681be43bcdaf260a5ce61573e6168c8deb024e887aefaa25fe42f51e7ae2ccc0c4f344d267d9b547dfd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/14711118fddadc8162b3400f63a3877a03a66ac3061b704132577e450e41b43f1997b3a7f0ce7a84f18b06d17b69bd81a9d7247db01cfb1d0046a6024371f67a"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-22 10:20:21.314237) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 10:20:21.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=8783db0840cc980e80bb0bd400000236-1466613596.232306-769184124 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004616 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 10:20:21.396554) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-22 10:20:21.396873) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-22 10:20:21.397168) ========= ========= Total master_lag: 0.21 =========