builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-006 starttime: 1466427888.82 results: success (0) buildid: 20160620045124 builduid: 1842b206cb124bd084fdfe287ce4c5bc revision: 3c5025f98e561a20e24d97c91a9e4e0ec28015ea ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-20 06:04:48.819518) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-20 06:04:48.820033) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-20 06:04:48.820370) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-20 06:04:48.835653) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-20 06:04:48.836143) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=e31afd3c0f0de4e86ebe4d94000001b5-1466427888.291101-1501507299 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-20 06:04:49-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 69.8M=0s 2016-06-20 06:04:49 (69.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.088043 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-20 06:04:48.943844) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-20 06:04:48.945573) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=e31afd3c0f0de4e86ebe4d94000001b5-1466427888.291101-1501507299 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020549 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-20 06:04:49.000482) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-20 06:04:49.001182) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 3c5025f98e561a20e24d97c91a9e4e0ec28015ea --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 3c5025f98e561a20e24d97c91a9e4e0ec28015ea --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=e31afd3c0f0de4e86ebe4d94000001b5-1466427888.291101-1501507299 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-20 06:04:49,261 truncating revision to first 12 chars 2016-06-20 06:04:49,261 Setting DEBUG logging. 2016-06-20 06:04:49,261 attempt 1/10 2016-06-20 06:04:49,261 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/3c5025f98e56?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-20 06:04:50,038 unpacking tar archive at: mozilla-central-3c5025f98e56/testing/mozharness/ program finished with exit code 0 elapsedTime=1.129134 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-20 06:04:50.150626) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-20 06:04:50.151527) ========= script_repo_revision: 3c5025f98e561a20e24d97c91a9e4e0ec28015ea ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-20 06:04:50.152619) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-20 06:04:50.153349) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-20 06:04:50.166413) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-06-20 06:04:50.166742) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=e31afd3c0f0de4e86ebe4d94000001b5-1466427888.291101-1501507299 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:04:50 INFO - MultiFileLogger online at 20160620 06:04:50 in /builds/slave/test 06:04:50 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 06:04:50 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:04:50 INFO - {'append_to_log': False, 06:04:50 INFO - 'base_work_dir': '/builds/slave/test', 06:04:50 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 06:04:50 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:04:50 INFO - 'branch': 'Firefox-Non-PGO', 06:04:50 INFO - 'buildbot_json_path': 'buildprops.json', 06:04:50 INFO - 'config_files': ('talos/linux_config.py',), 06:04:50 INFO - 'default_actions': ('clobber', 06:04:50 INFO - 'read-buildbot-config', 06:04:50 INFO - 'download-and-extract', 06:04:50 INFO - 'populate-webroot', 06:04:50 INFO - 'create-virtualenv', 06:04:50 INFO - 'install', 06:04:50 INFO - 'run-tests'), 06:04:50 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:04:50 INFO - 'download_minidump_stackwalk': True, 06:04:50 INFO - 'download_symbols': 'ondemand', 06:04:50 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:04:50 INFO - 'tooltool.py': '/tools/tooltool.py', 06:04:50 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:04:50 INFO - '/tools/misc-python/virtualenv.py')}, 06:04:50 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:04:50 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:04:50 INFO - 'installer_path': 'installer.exe', 06:04:50 INFO - 'log_level': 'info', 06:04:50 INFO - 'log_name': 'talos', 06:04:50 INFO - 'log_to_console': True, 06:04:50 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:04:50 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:04:50 INFO - 'opt_config_files': (), 06:04:50 INFO - 'pip_index': False, 06:04:50 INFO - 'sps_profile': False, 06:04:50 INFO - 'sps_profile_interval': 0, 06:04:50 INFO - 'suite': 'dromaeojs', 06:04:50 INFO - 'system_bits': '32', 06:04:50 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:04:50 INFO - 'title': 'talos-linux64-ix-006', 06:04:50 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:04:50 INFO - 'use_talos_json': True, 06:04:50 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:04:50 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:04:50 INFO - 'work_dir': 'build'} 06:04:50 INFO - ##### 06:04:50 INFO - ##### Running clobber step. 06:04:50 INFO - ##### 06:04:50 INFO - Running pre-action listener: _resource_record_pre_action 06:04:50 INFO - Running main action method: clobber 06:04:50 INFO - rmtree: /builds/slave/test/build 06:04:50 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:04:51 INFO - Running post-action listener: _resource_record_post_action 06:04:51 INFO - ##### 06:04:51 INFO - ##### Finished clobber step (success) 06:04:51 INFO - ##### 06:04:51 INFO - ##### 06:04:51 INFO - ##### Running read-buildbot-config step. 06:04:51 INFO - ##### 06:04:51 INFO - Running pre-action listener: _resource_record_pre_action 06:04:51 INFO - Running main action method: read_buildbot_config 06:04:51 INFO - Using buildbot properties: 06:04:51 INFO - { 06:04:51 INFO - "project": "", 06:04:51 INFO - "product": "firefox", 06:04:51 INFO - "script_repo_revision": "production", 06:04:51 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 06:04:51 INFO - "repository": "", 06:04:51 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 06:04:51 INFO - "buildid": "20160620045124", 06:04:51 INFO - "pgo_build": "False", 06:04:51 INFO - "basedir": "/builds/slave/test", 06:04:51 INFO - "buildnumber": 121, 06:04:51 INFO - "slavename": "talos-linux64-ix-006", 06:04:51 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 06:04:51 INFO - "platform": "ubuntu64_hw", 06:04:51 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 06:04:51 INFO - "branch": "mozilla-central", 06:04:51 INFO - "repo_path": "mozilla-central", 06:04:51 INFO - "revision": "3c5025f98e561a20e24d97c91a9e4e0ec28015ea", 06:04:51 INFO - "stage_platform": "linux64", 06:04:51 INFO - "builduid": "1842b206cb124bd084fdfe287ce4c5bc", 06:04:51 INFO - "slavebuilddir": "test" 06:04:51 INFO - } 06:04:51 INFO - Found installer url https://queue.taskcluster.net/v1/task/Gy7SPqtARWSrgBLlWNGeDg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 06:04:51 INFO - Running post-action listener: _resource_record_post_action 06:04:51 INFO - ##### 06:04:51 INFO - ##### Finished read-buildbot-config step (success) 06:04:51 INFO - ##### 06:04:51 INFO - ##### 06:04:51 INFO - ##### Running download-and-extract step. 06:04:51 INFO - ##### 06:04:51 INFO - Running pre-action listener: _resource_record_pre_action 06:04:51 INFO - Running main action method: download_and_extract 06:04:51 INFO - mkdir: /builds/slave/test/build/tests 06:04:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:04:51 INFO - https://queue.taskcluster.net/v1/task/Gy7SPqtARWSrgBLlWNGeDg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 06:04:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gy7SPqtARWSrgBLlWNGeDg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 06:04:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gy7SPqtARWSrgBLlWNGeDg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 06:04:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gy7SPqtARWSrgBLlWNGeDg/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 06:04:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gy7SPqtARWSrgBLlWNGeDg/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 06:04:52 INFO - Downloaded 1361 bytes. 06:04:52 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 06:04:52 INFO - Using the following test package requirements: 06:04:52 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 06:04:52 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:04:52 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 06:04:52 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:04:52 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 06:04:52 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:04:52 INFO - u'jsshell-linux-x86_64.zip'], 06:04:52 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:04:52 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 06:04:52 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 06:04:52 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:04:52 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 06:04:52 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:04:52 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 06:04:52 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:04:52 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 06:04:52 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:04:52 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 06:04:52 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:04:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:04:52 INFO - https://queue.taskcluster.net/v1/task/Gy7SPqtARWSrgBLlWNGeDg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:04:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gy7SPqtARWSrgBLlWNGeDg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 06:04:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gy7SPqtARWSrgBLlWNGeDg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 06:04:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gy7SPqtARWSrgBLlWNGeDg/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 06:04:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gy7SPqtARWSrgBLlWNGeDg/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 06:04:53 INFO - Downloaded 22654924 bytes. 06:04:53 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'] 06:04:53 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 06:04:54 INFO - Return code: 0 06:04:54 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 06:04:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:04:54 INFO - https://queue.taskcluster.net/v1/task/Gy7SPqtARWSrgBLlWNGeDg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:04:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gy7SPqtARWSrgBLlWNGeDg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 06:04:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gy7SPqtARWSrgBLlWNGeDg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 06:04:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gy7SPqtARWSrgBLlWNGeDg/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 06:04:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gy7SPqtARWSrgBLlWNGeDg/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 06:04:56 INFO - Downloaded 22654924 bytes. 06:04:56 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'] 06:04:56 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 06:04:57 INFO - Return code: 0 06:04:57 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')]} 06:04:57 INFO - https://queue.taskcluster.net/v1/task/Gy7SPqtARWSrgBLlWNGeDg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 06:04:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gy7SPqtARWSrgBLlWNGeDg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 06:04:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gy7SPqtARWSrgBLlWNGeDg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 06:04:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gy7SPqtARWSrgBLlWNGeDg/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 06:04:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gy7SPqtARWSrgBLlWNGeDg/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 06:04:58 INFO - Downloaded 14405384 bytes. 06:04:58 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'] 06:04:58 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 06:04:59 INFO - Return code: 0 06:04:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:04:59 INFO - https://queue.taskcluster.net/v1/task/Gy7SPqtARWSrgBLlWNGeDg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 06:04:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gy7SPqtARWSrgBLlWNGeDg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 06:04:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gy7SPqtARWSrgBLlWNGeDg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 06:04:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gy7SPqtARWSrgBLlWNGeDg/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 06:04:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gy7SPqtARWSrgBLlWNGeDg/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 06:05:00 INFO - Downloaded 56228410 bytes. 06:05:00 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Gy7SPqtARWSrgBLlWNGeDg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 06:05:00 INFO - mkdir: /builds/slave/test/properties 06:05:00 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:05:00 INFO - Writing to file /builds/slave/test/properties/build_url 06:05:00 INFO - Contents: 06:05:00 INFO - build_url:https://queue.taskcluster.net/v1/task/Gy7SPqtARWSrgBLlWNGeDg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 06:05:01 INFO - Running post-action listener: _resource_record_post_action 06:05:01 INFO - Running post-action listener: set_extra_try_arguments 06:05:01 INFO - ##### 06:05:01 INFO - ##### Finished download-and-extract step (success) 06:05:01 INFO - ##### 06:05:01 INFO - ##### 06:05:01 INFO - ##### Running populate-webroot step. 06:05:01 INFO - ##### 06:05:01 INFO - Running pre-action listener: _resource_record_pre_action 06:05:01 INFO - Running main action method: populate_webroot 06:05:01 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:05:01 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:05:01 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:05:01 INFO - '--tppagecycles', 06:05:01 INFO - '7'], 06:05:01 INFO - 'tests': ['tsvgm']}}, 06:05:01 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:05:01 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:05:01 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:05:01 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:05:01 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:05:01 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:05:01 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:05:01 INFO - 'talos_options': ['--disable-e10s'], 06:05:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:05:01 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:05:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:05:01 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:05:01 INFO - 'talos_options': ['--disable-e10s'], 06:05:01 INFO - 'tests': ['damp', 'tps']}, 06:05:01 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:05:01 INFO - 'tests': ['damp', 'tps']}, 06:05:01 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:05:01 INFO - 'tests': ['dromaeo_dom']}, 06:05:01 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:05:01 INFO - 'g4': {'talos_options': ['--disable-e10s'], 06:05:01 INFO - 'tests': ['basic_compositor_video']}, 06:05:01 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 06:05:01 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:05:01 INFO - 'tests': ['a11yr', 06:05:01 INFO - 'ts_paint', 06:05:01 INFO - 'tpaint', 06:05:01 INFO - 'sessionrestore', 06:05:01 INFO - 'sessionrestore_no_auto_restore', 06:05:01 INFO - 'tabpaint']}, 06:05:01 INFO - 'other-e10s': {'tests': ['a11yr', 06:05:01 INFO - 'ts_paint', 06:05:01 INFO - 'tpaint', 06:05:01 INFO - 'sessionrestore', 06:05:01 INFO - 'sessionrestore_no_auto_restore', 06:05:01 INFO - 'tabpaint']}, 06:05:01 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:05:01 INFO - 'ts_paint', 06:05:01 INFO - 'tpaint', 06:05:01 INFO - 'sessionrestore', 06:05:01 INFO - 'sessionrestore_no_auto_restore', 06:05:01 INFO - 'tabpaint']}, 06:05:01 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:05:01 INFO - 'ts_paint', 06:05:01 INFO - 'tpaint', 06:05:01 INFO - 'sessionrestore', 06:05:01 INFO - 'sessionrestore_no_auto_restore', 06:05:01 INFO - 'tabpaint']}, 06:05:01 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:05:01 INFO - 'tests': ['a11yr', 06:05:01 INFO - 'ts_paint', 06:05:01 INFO - 'tpaint', 06:05:01 INFO - 'sessionrestore', 06:05:01 INFO - 'sessionrestore_no_auto_restore', 06:05:01 INFO - 'tabpaint']}, 06:05:01 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:05:01 INFO - 'tests': ['a11yr', 06:05:01 INFO - 'ts_paint', 06:05:01 INFO - 'tpaint', 06:05:01 INFO - 'sessionrestore', 06:05:01 INFO - 'sessionrestore_no_auto_restore', 06:05:01 INFO - 'tabpaint']}, 06:05:01 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:05:01 INFO - 'tests': ['tsvgx', 06:05:01 INFO - 'tsvgr_opacity', 06:05:01 INFO - 'tart', 06:05:01 INFO - 'tscrollx', 06:05:01 INFO - 'cart']}, 06:05:01 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:05:01 INFO - 'tsvgr_opacity', 06:05:01 INFO - 'tart', 06:05:01 INFO - 'tscrollx', 06:05:01 INFO - 'cart']}, 06:05:01 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:05:01 INFO - 'talos_options': ['--disable-e10s'], 06:05:01 INFO - 'tests': ['tp5o']}, 06:05:01 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:05:01 INFO - 'tests': ['tp5o']}, 06:05:01 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:05:01 INFO - 'talos_options': ['--disable-e10s', 06:05:01 INFO - '--xperf_path', 06:05:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:05:01 INFO - 'tests': ['tp5n']}, 06:05:01 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:05:01 INFO - 'talos_options': ['--xperf_path', 06:05:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:05:01 INFO - 'tests': ['tp5n']}}, 06:05:01 INFO - 'talos.zip': {'path': '', 06:05:01 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:05:01 INFO - Running post-action listener: _resource_record_post_action 06:05:01 INFO - ##### 06:05:01 INFO - ##### Finished populate-webroot step (success) 06:05:01 INFO - ##### 06:05:01 INFO - ##### 06:05:01 INFO - ##### Running create-virtualenv step. 06:05:01 INFO - ##### 06:05:01 INFO - Running pre-action listener: _resource_record_pre_action 06:05:01 INFO - Running main action method: create_virtualenv 06:05:01 INFO - Creating virtualenv /builds/slave/test/build/venv 06:05:01 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 06:05:01 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:05:01 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:05:01 INFO - Using real prefix '/usr' 06:05:01 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:05:01 INFO - Installing distribute.............................................................................................................................................................................................done. 06:05:03 INFO - Installing pip.................done. 06:05:03 INFO - Return code: 0 06:05:03 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:05:03 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')]} 06:05:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:05:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:05:03 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')]} 06:05:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:05:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:05:03 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 0x7fbda5c7cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18a88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1975020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a072e0>, '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 0x1973140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19735d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1466427888.291101-1501507299', '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 06:05:03 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 06:05:03 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 06:05:03 INFO - Using env: {'DISPLAY': ':0', 06:05:03 INFO - 'HOME': '/home/cltbld', 06:05:03 INFO - 'LANG': 'en_US.UTF-8', 06:05:03 INFO - 'LANGUAGE': 'en_US:en', 06:05:03 INFO - 'LOGNAME': 'cltbld', 06:05:03 INFO - 'MAIL': '/var/mail/cltbld', 06:05:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:05:03 INFO - 'MOZ_NO_REMOTE': '1', 06:05:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:05:03 INFO - 'NO_EM_RESTART': '1', 06:05:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:05:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:05:03 INFO - 'PWD': '/builds/slave/test', 06:05:03 INFO - 'SHELL': '/bin/bash', 06:05:03 INFO - 'SHLVL': '1', 06:05:03 INFO - 'TERM': 'linux', 06:05:03 INFO - 'TMOUT': '86400', 06:05:03 INFO - 'USER': 'cltbld', 06:05:03 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1466427888.291101-1501507299', 06:05:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:05:03 INFO - '_': '/tools/buildbot/bin/python'} 06:05:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:05:04 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 06:05:04 INFO - Cleaning up... 06:05:04 INFO - Return code: 0 06:05:04 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:05: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')]} 06:05:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:05:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:05: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')]} 06:05:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:05:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:05:04 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 0x7fbda5c7cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18a88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1975020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a072e0>, '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 0x1973140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19735d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1466427888.291101-1501507299', '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 06:05:04 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 06:05:04 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 06:05:04 INFO - Using env: {'DISPLAY': ':0', 06:05:04 INFO - 'HOME': '/home/cltbld', 06:05:04 INFO - 'LANG': 'en_US.UTF-8', 06:05:04 INFO - 'LANGUAGE': 'en_US:en', 06:05:04 INFO - 'LOGNAME': 'cltbld', 06:05:04 INFO - 'MAIL': '/var/mail/cltbld', 06:05:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:05:04 INFO - 'MOZ_NO_REMOTE': '1', 06:05:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:05:04 INFO - 'NO_EM_RESTART': '1', 06:05:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:05:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:05:04 INFO - 'PWD': '/builds/slave/test', 06:05:04 INFO - 'SHELL': '/bin/bash', 06:05:04 INFO - 'SHLVL': '1', 06:05:04 INFO - 'TERM': 'linux', 06:05:04 INFO - 'TMOUT': '86400', 06:05:04 INFO - 'USER': 'cltbld', 06:05:04 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1466427888.291101-1501507299', 06:05:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:05:04 INFO - '_': '/tools/buildbot/bin/python'} 06:05:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:05:04 INFO - Downloading/unpacking psutil>=3.1.1 06:05:04 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 06:05:04 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 06:05:04 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 06:05:04 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 06:05:04 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 06:05:04 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 06:05:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:05:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:05:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:05:06 INFO - Installing collected packages: psutil 06:05:06 INFO - Running setup.py install for psutil 06:05:06 INFO - building 'psutil._psutil_linux' extension 06:05:06 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 06:05:06 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 06:05:06 INFO - building 'psutil._psutil_posix' extension 06:05:06 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 06:05:06 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 06:05:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:05:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:05:06 INFO - Successfully installed psutil 06:05:06 INFO - Cleaning up... 06:05:06 INFO - Return code: 0 06:05:06 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:05:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:05:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:05:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:05:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:05:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:05:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:05:06 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 0x7fbda5c7cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18a88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1975020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a072e0>, '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 0x1973140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19735d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1466427888.291101-1501507299', '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 06:05:06 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 06:05:06 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 06:05:06 INFO - Using env: {'DISPLAY': ':0', 06:05:06 INFO - 'HOME': '/home/cltbld', 06:05:06 INFO - 'LANG': 'en_US.UTF-8', 06:05:06 INFO - 'LANGUAGE': 'en_US:en', 06:05:06 INFO - 'LOGNAME': 'cltbld', 06:05:06 INFO - 'MAIL': '/var/mail/cltbld', 06:05:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:05:06 INFO - 'MOZ_NO_REMOTE': '1', 06:05:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:05:06 INFO - 'NO_EM_RESTART': '1', 06:05:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:05:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:05:06 INFO - 'PWD': '/builds/slave/test', 06:05:06 INFO - 'SHELL': '/bin/bash', 06:05:06 INFO - 'SHLVL': '1', 06:05:06 INFO - 'TERM': 'linux', 06:05:06 INFO - 'TMOUT': '86400', 06:05:06 INFO - 'USER': 'cltbld', 06:05:06 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1466427888.291101-1501507299', 06:05:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:05:06 INFO - '_': '/tools/buildbot/bin/python'} 06:05:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:05:07 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:05:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:05:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:05:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:05:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:05:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:05:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:05:09 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:05:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:05:09 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:05:09 INFO - Installing collected packages: mozsystemmonitor 06:05:09 INFO - Running setup.py install for mozsystemmonitor 06:05:09 INFO - Successfully installed mozsystemmonitor 06:05:09 INFO - Cleaning up... 06:05:09 INFO - Return code: 0 06:05:09 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:05:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:05:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:05:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:05:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:05:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:05:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:05:09 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 0x7fbda5c7cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18a88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1975020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a072e0>, '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 0x1973140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19735d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1466427888.291101-1501507299', '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 06:05:09 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 06:05:09 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 06:05:09 INFO - Using env: {'DISPLAY': ':0', 06:05:09 INFO - 'HOME': '/home/cltbld', 06:05:09 INFO - 'LANG': 'en_US.UTF-8', 06:05:09 INFO - 'LANGUAGE': 'en_US:en', 06:05:09 INFO - 'LOGNAME': 'cltbld', 06:05:09 INFO - 'MAIL': '/var/mail/cltbld', 06:05:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:05:09 INFO - 'MOZ_NO_REMOTE': '1', 06:05:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:05:09 INFO - 'NO_EM_RESTART': '1', 06:05:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:05:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:05:09 INFO - 'PWD': '/builds/slave/test', 06:05:09 INFO - 'SHELL': '/bin/bash', 06:05:09 INFO - 'SHLVL': '1', 06:05:09 INFO - 'TERM': 'linux', 06:05:09 INFO - 'TMOUT': '86400', 06:05:09 INFO - 'USER': 'cltbld', 06:05:09 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1466427888.291101-1501507299', 06:05:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:05:09 INFO - '_': '/tools/buildbot/bin/python'} 06:05:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:05:09 INFO - Downloading/unpacking jsonschema==2.5.1 06:05: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 06:05: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 06:05: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 06:05: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 06:05: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 06:05: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 06:05:11 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:05:11 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:05:11 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 06:05:11 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 06:05:11 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 06:05:11 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 06:05:11 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 06:05:11 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 06:05:11 INFO - Downloading functools32-3.2.3-2.tar.gz 06:05:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:05:11 INFO - warning: no files found matching '*.txt' 06:05:11 INFO - no previously-included directories found matching 'build' 06:05:11 INFO - no previously-included directories found matching 'dist' 06:05:11 INFO - no previously-included directories found matching '.git*' 06:05:11 INFO - Installing collected packages: jsonschema, functools32 06:05:11 INFO - Running setup.py install for functools32 06:05:12 INFO - warning: no files found matching '*.txt' 06:05:12 INFO - no previously-included directories found matching 'build' 06:05:12 INFO - no previously-included directories found matching 'dist' 06:05:12 INFO - no previously-included directories found matching '.git*' 06:05:12 INFO - Successfully installed jsonschema functools32 06:05:12 INFO - Cleaning up... 06:05:12 INFO - Return code: 0 06:05:12 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:05: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')]} 06:05:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:05:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:05: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')]} 06:05:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:05:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:05: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', '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 0x7fbda5c7cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18a88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1975020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a072e0>, '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 0x1973140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19735d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1466427888.291101-1501507299', '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 06:05: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 06:05: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 blobuploader==1.2.4 06:05:12 INFO - Using env: {'DISPLAY': ':0', 06:05:12 INFO - 'HOME': '/home/cltbld', 06:05:12 INFO - 'LANG': 'en_US.UTF-8', 06:05:12 INFO - 'LANGUAGE': 'en_US:en', 06:05:12 INFO - 'LOGNAME': 'cltbld', 06:05:12 INFO - 'MAIL': '/var/mail/cltbld', 06:05:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:05:12 INFO - 'MOZ_NO_REMOTE': '1', 06:05:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:05:12 INFO - 'NO_EM_RESTART': '1', 06:05:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:05:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:05:12 INFO - 'PWD': '/builds/slave/test', 06:05:12 INFO - 'SHELL': '/bin/bash', 06:05:12 INFO - 'SHLVL': '1', 06:05:12 INFO - 'TERM': 'linux', 06:05:12 INFO - 'TMOUT': '86400', 06:05:12 INFO - 'USER': 'cltbld', 06:05:12 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1466427888.291101-1501507299', 06:05:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:05:12 INFO - '_': '/tools/buildbot/bin/python'} 06:05:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:05:12 INFO - Downloading/unpacking blobuploader==1.2.4 06:05: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 06:05: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 06:05: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 06:05: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 06:05: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 06:05: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 06:05:14 INFO - Downloading blobuploader-1.2.4.tar.gz 06:05:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:05:14 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:05: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 06:05: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 06:05: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 06:05: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 06:05: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 06:05: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 06:05:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:05:14 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:05: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 06:05: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 06:05: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 06:05: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 06:05: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 06:05: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 06:05:14 INFO - Downloading docopt-0.6.1.tar.gz 06:05:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:05:14 INFO - Installing collected packages: blobuploader, requests, docopt 06:05:14 INFO - Running setup.py install for blobuploader 06:05:15 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:05:15 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:05:15 INFO - Running setup.py install for requests 06:05:15 INFO - Running setup.py install for docopt 06:05:15 INFO - Successfully installed blobuploader requests docopt 06:05:15 INFO - Cleaning up... 06:05:15 INFO - Return code: 0 06:05:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:05:15 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')]} 06:05:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:05:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:05:15 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')]} 06:05:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:05:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:05:15 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 0x7fbda5c7cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18a88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1975020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a072e0>, '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 0x1973140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19735d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1466427888.291101-1501507299', '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 06:05:15 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 06:05:15 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 06:05:15 INFO - Using env: {'DISPLAY': ':0', 06:05:15 INFO - 'HOME': '/home/cltbld', 06:05:15 INFO - 'LANG': 'en_US.UTF-8', 06:05:15 INFO - 'LANGUAGE': 'en_US:en', 06:05:15 INFO - 'LOGNAME': 'cltbld', 06:05:15 INFO - 'MAIL': '/var/mail/cltbld', 06:05:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:05:15 INFO - 'MOZ_NO_REMOTE': '1', 06:05:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:05:15 INFO - 'NO_EM_RESTART': '1', 06:05:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:05:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:05:15 INFO - 'PWD': '/builds/slave/test', 06:05:15 INFO - 'SHELL': '/bin/bash', 06:05:15 INFO - 'SHLVL': '1', 06:05:15 INFO - 'TERM': 'linux', 06:05:15 INFO - 'TMOUT': '86400', 06:05:15 INFO - 'USER': 'cltbld', 06:05:15 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1466427888.291101-1501507299', 06:05:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:05:15 INFO - '_': '/tools/buildbot/bin/python'} 06:05:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:05:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:05:15 INFO - Running setup.py (path:/tmp/pip-vo9d6t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:05:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:05:15 INFO - Running setup.py (path:/tmp/pip-h1eyT3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:05:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:05:15 INFO - Running setup.py (path:/tmp/pip-iaOhfY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:05:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:05:16 INFO - Running setup.py (path:/tmp/pip-CwPFtN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:05:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:05:16 INFO - Running setup.py (path:/tmp/pip-F3NVp3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:05:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:05:16 INFO - Running setup.py (path:/tmp/pip-PcKoqc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:05:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:05:16 INFO - Running setup.py (path:/tmp/pip-s_VqOj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:05:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:05:16 INFO - Running setup.py (path:/tmp/pip-E05t6D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:05:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:05:16 INFO - Running setup.py (path:/tmp/pip-LizcvQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:05:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:05:16 INFO - Running setup.py (path:/tmp/pip-ivQpxr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:05:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:05:16 INFO - Running setup.py (path:/tmp/pip-a_WO8Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:05:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:05:16 INFO - Running setup.py (path:/tmp/pip-NPIAJX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:05:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:05:16 INFO - Running setup.py (path:/tmp/pip-N6mGUU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:05:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:05:16 INFO - Running setup.py (path:/tmp/pip-Qe_LP0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:05:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:05:16 INFO - Running setup.py (path:/tmp/pip-CkT9mD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:05:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:05:16 INFO - Running setup.py (path:/tmp/pip-__9iD5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:05:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:05:16 INFO - Running setup.py (path:/tmp/pip-52w0JZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:05:17 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:05:17 INFO - Running setup.py install for manifestparser 06:05:17 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:05:17 INFO - Running setup.py install for mozcrash 06:05:17 INFO - Running setup.py install for mozdebug 06:05:17 INFO - Running setup.py install for mozdevice 06:05:17 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:05:17 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:05:17 INFO - Running setup.py install for mozfile 06:05:17 INFO - Running setup.py install for mozhttpd 06:05:17 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:05:17 INFO - Running setup.py install for mozinfo 06:05:17 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:05:17 INFO - Running setup.py install for mozInstall 06:05:17 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:05:17 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:05:17 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:05:17 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:05:17 INFO - Running setup.py install for mozleak 06:05:17 INFO - Running setup.py install for mozlog 06:05:18 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:05:18 INFO - Running setup.py install for moznetwork 06:05:18 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:05:18 INFO - Running setup.py install for mozprocess 06:05:18 INFO - Running setup.py install for mozprofile 06:05:18 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:05:18 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:05:18 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:05:18 INFO - Running setup.py install for mozrunner 06:05:18 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:05:18 INFO - Running setup.py install for mozscreenshot 06:05:18 INFO - Running setup.py install for moztest 06:05:18 INFO - Running setup.py install for mozversion 06:05:18 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:05:18 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:05:18 INFO - Cleaning up... 06:05:18 INFO - Return code: 0 06:05:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:05:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:05:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:05:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:05:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:05:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:05:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:05:18 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 0x7fbda5c7cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18a88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1975020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a072e0>, '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 0x1973140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19735d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1466427888.291101-1501507299', '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 06:05:18 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 06:05:18 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 06:05:18 INFO - Using env: {'DISPLAY': ':0', 06:05:18 INFO - 'HOME': '/home/cltbld', 06:05:18 INFO - 'LANG': 'en_US.UTF-8', 06:05:18 INFO - 'LANGUAGE': 'en_US:en', 06:05:18 INFO - 'LOGNAME': 'cltbld', 06:05:18 INFO - 'MAIL': '/var/mail/cltbld', 06:05:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:05:18 INFO - 'MOZ_NO_REMOTE': '1', 06:05:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:05:18 INFO - 'NO_EM_RESTART': '1', 06:05:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:05:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:05:18 INFO - 'PWD': '/builds/slave/test', 06:05:18 INFO - 'SHELL': '/bin/bash', 06:05:18 INFO - 'SHLVL': '1', 06:05:18 INFO - 'TERM': 'linux', 06:05:18 INFO - 'TMOUT': '86400', 06:05:18 INFO - 'USER': 'cltbld', 06:05:18 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1466427888.291101-1501507299', 06:05:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:05:18 INFO - '_': '/tools/buildbot/bin/python'} 06:05:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:05:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:05:19 INFO - Running setup.py (path:/tmp/pip-fr6yvm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:05:19 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)) 06:05:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:05:19 INFO - Running setup.py (path:/tmp/pip-wGLMMN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:05:19 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)) 06:05:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:05:19 INFO - Running setup.py (path:/tmp/pip-8wYhuY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:05:19 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)) 06:05:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:05:19 INFO - Running setup.py (path:/tmp/pip-27lSfr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:05:19 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)) 06:05:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:05:19 INFO - Running setup.py (path:/tmp/pip-R54NQl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:05:19 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)) 06:05:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:05:19 INFO - Running setup.py (path:/tmp/pip-xZ0TE3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:05:19 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)) 06:05:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:05:19 INFO - Running setup.py (path:/tmp/pip-EfsGgi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:05:19 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)) 06:05:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:05:19 INFO - Running setup.py (path:/tmp/pip-wdcItd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:05:19 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)) 06:05:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:05:19 INFO - Running setup.py (path:/tmp/pip-6SPXXq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:05:19 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)) 06:05:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:05:19 INFO - Running setup.py (path:/tmp/pip-v3y6m8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:05:19 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)) 06:05:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:05:19 INFO - Running setup.py (path:/tmp/pip-a7rc4Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:05:19 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)) 06:05:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:05:19 INFO - Running setup.py (path:/tmp/pip-Irt0c1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:05:19 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)) 06:05:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:05:19 INFO - Running setup.py (path:/tmp/pip-trIA1X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:05:19 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)) 06:05:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:05:19 INFO - Running setup.py (path:/tmp/pip-ryREIZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:05:20 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)) 06:05:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:05:20 INFO - Running setup.py (path:/tmp/pip-Q4PyYm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:05:20 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)) 06:05:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:05:20 INFO - Running setup.py (path:/tmp/pip-Sv8GK_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:05:20 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)) 06:05:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:05:20 INFO - Running setup.py (path:/tmp/pip-NnYhvL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:05:20 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)) 06:05:20 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)) 06:05:20 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)) 06:05:20 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)) 06:05:20 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)) 06:05:20 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)) 06:05:20 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:05:20 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 06:05:20 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 06:05:20 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 06:05:20 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 06:05:20 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 06:05:20 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 06:05:22 INFO - Downloading blessings-1.6.tar.gz 06:05:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:05:22 INFO - Installing collected packages: blessings 06:05:22 INFO - Running setup.py install for blessings 06:05:22 INFO - Successfully installed blessings 06:05:22 INFO - Cleaning up... 06:05:22 INFO - Return code: 0 06:05:22 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:05:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:05:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:05:22 INFO - Reading from file tmpfile_stdout 06:05:22 INFO - Current package versions: 06:05:22 INFO - argparse == 1.2.1 06:05:22 INFO - blessings == 1.6 06:05:22 INFO - blobuploader == 1.2.4 06:05:22 INFO - docopt == 0.6.1 06:05:22 INFO - functools32 == 3.2.3-2 06:05:22 INFO - jsonschema == 2.5.1 06:05:22 INFO - manifestparser == 1.1 06:05:22 INFO - mozInstall == 1.12 06:05:22 INFO - mozcrash == 0.17 06:05:22 INFO - mozdebug == 0.1 06:05:22 INFO - mozdevice == 0.48 06:05:22 INFO - mozfile == 1.2 06:05:22 INFO - mozhttpd == 0.7 06:05:22 INFO - mozinfo == 0.9 06:05:22 INFO - mozleak == 0.1 06:05:22 INFO - mozlog == 3.2 06:05:22 INFO - moznetwork == 0.27 06:05:22 INFO - mozprocess == 0.22 06:05:22 INFO - mozprofile == 0.28 06:05:22 INFO - mozrunner == 6.11 06:05:22 INFO - mozscreenshot == 0.1 06:05:22 INFO - mozsystemmonitor == 0.3 06:05:22 INFO - moztest == 0.7 06:05:22 INFO - mozversion == 1.4 06:05:22 INFO - psutil == 3.1.1 06:05:22 INFO - requests == 1.2.3 06:05:22 INFO - wsgiref == 0.1.2 06:05:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:05:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:05:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:05:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:05:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:05:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:05:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:05:22 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 0x7fbda5c7cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18a88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1975020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a072e0>, '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 0x1973140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19735d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1466427888.291101-1501507299', '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 06:05:22 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 06:05:22 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 06:05:22 INFO - Using env: {'DISPLAY': ':0', 06:05:22 INFO - 'HOME': '/home/cltbld', 06:05:22 INFO - 'LANG': 'en_US.UTF-8', 06:05:22 INFO - 'LANGUAGE': 'en_US:en', 06:05:22 INFO - 'LOGNAME': 'cltbld', 06:05:22 INFO - 'MAIL': '/var/mail/cltbld', 06:05:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:05:22 INFO - 'MOZ_NO_REMOTE': '1', 06:05:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:05:22 INFO - 'NO_EM_RESTART': '1', 06:05:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:05:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:05:22 INFO - 'PWD': '/builds/slave/test', 06:05:22 INFO - 'SHELL': '/bin/bash', 06:05:22 INFO - 'SHLVL': '1', 06:05:22 INFO - 'TERM': 'linux', 06:05:22 INFO - 'TMOUT': '86400', 06:05:22 INFO - 'USER': 'cltbld', 06:05:22 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1466427888.291101-1501507299', 06:05:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:05:22 INFO - '_': '/tools/buildbot/bin/python'} 06:05:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:05:22 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)) 06:05:22 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)) 06:05:22 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)) 06:05:22 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)) 06:05:22 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)) 06:05:22 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)) 06:05:22 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)) 06:05:22 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)) 06:05:22 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)) 06:05:22 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)) 06:05:22 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)) 06:05:22 INFO - Cleaning up... 06:05:22 INFO - Return code: 0 06:05:22 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:05:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:05:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:05:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:05:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:05:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:05:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:05:22 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 0x7fbda5c7cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18a88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1975020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a072e0>, '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 0x1973140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19735d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1466427888.291101-1501507299', '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 06:05:22 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 06:05:22 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 06:05:22 INFO - Using env: {'DISPLAY': ':0', 06:05:22 INFO - 'HOME': '/home/cltbld', 06:05:22 INFO - 'LANG': 'en_US.UTF-8', 06:05:22 INFO - 'LANGUAGE': 'en_US:en', 06:05:22 INFO - 'LOGNAME': 'cltbld', 06:05:22 INFO - 'MAIL': '/var/mail/cltbld', 06:05:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:05:22 INFO - 'MOZ_NO_REMOTE': '1', 06:05:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:05:22 INFO - 'NO_EM_RESTART': '1', 06:05:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:05:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:05:22 INFO - 'PWD': '/builds/slave/test', 06:05:22 INFO - 'SHELL': '/bin/bash', 06:05:22 INFO - 'SHLVL': '1', 06:05:22 INFO - 'TERM': 'linux', 06:05:22 INFO - 'TMOUT': '86400', 06:05:22 INFO - 'USER': 'cltbld', 06:05:22 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1466427888.291101-1501507299', 06:05:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:05:22 INFO - '_': '/tools/buildbot/bin/python'} 06:05:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:05:23 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:05:23 INFO - Cleaning up... 06:05:23 INFO - Return code: 0 06:05:23 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 06:05:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:05:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:05:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:05:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:05:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:05:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:05:23 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 0x7fbda5c7cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18a88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1975020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a072e0>, '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 0x1973140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19735d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1466427888.291101-1501507299', '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 06:05:23 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 06:05:23 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 06:05:23 INFO - Using env: {'DISPLAY': ':0', 06:05:23 INFO - 'HOME': '/home/cltbld', 06:05:23 INFO - 'LANG': 'en_US.UTF-8', 06:05:23 INFO - 'LANGUAGE': 'en_US:en', 06:05:23 INFO - 'LOGNAME': 'cltbld', 06:05:23 INFO - 'MAIL': '/var/mail/cltbld', 06:05:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:05:23 INFO - 'MOZ_NO_REMOTE': '1', 06:05:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:05:23 INFO - 'NO_EM_RESTART': '1', 06:05:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:05:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:05:23 INFO - 'PWD': '/builds/slave/test', 06:05:23 INFO - 'SHELL': '/bin/bash', 06:05:23 INFO - 'SHLVL': '1', 06:05:23 INFO - 'TERM': 'linux', 06:05:23 INFO - 'TMOUT': '86400', 06:05:23 INFO - 'USER': 'cltbld', 06:05:23 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1466427888.291101-1501507299', 06:05:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:05:23 INFO - '_': '/tools/buildbot/bin/python'} 06:05:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:05:23 INFO - Downloading/unpacking flake8 06:05:23 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 06:05:23 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 06:05:23 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 06:05:23 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 06:05:23 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 06:05:23 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 06:05:25 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 06:05:25 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 06:05:25 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 06:05:25 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 06:05:25 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 06:05:25 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 06:05:25 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 06:05:25 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 06:05:25 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 06:05:25 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 06:05:25 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 06:05:25 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 06:05:25 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 06:05:25 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 06:05:25 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 06:05:25 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 06:05:25 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 06:05:25 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 06:05:25 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 06:05:25 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 06:05:25 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 06:05:25 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 06:05:25 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 06:05:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 06:05:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:05:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:05:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:05:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:05:25 INFO - no previously-included directories found matching 'docs/_build' 06:05:26 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 06:05:26 INFO - Running setup.py install for pep8 06:05:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:05:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:05:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:05:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:05:26 INFO - no previously-included directories found matching 'docs/_build' 06:05:26 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 06:05:26 INFO - Successfully installed flake8 mccabe pyflakes pep8 06:05:26 INFO - Cleaning up... 06:05:26 INFO - Return code: 0 06:05:26 INFO - Running post-action listener: _resource_record_post_action 06:05:26 INFO - Running post-action listener: _start_resource_monitoring 06:05:26 INFO - Starting resource monitoring. 06:05:26 INFO - ##### 06:05:26 INFO - ##### Finished create-virtualenv step (success) 06:05:26 INFO - ##### 06:05:26 INFO - ##### 06:05:26 INFO - ##### Running install step. 06:05:26 INFO - ##### 06:05:26 INFO - Running pre-action listener: _resource_record_pre_action 06:05:26 INFO - Running main action method: install 06:05:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:05:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:05:26 INFO - Reading from file tmpfile_stdout 06:05:26 INFO - Detecting whether we're running mozinstall >=1.0... 06:05:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:05:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:05:26 INFO - Reading from file tmpfile_stdout 06:05:26 INFO - Output received: 06:05:26 INFO - Usage: mozinstall [options] installer 06:05:26 INFO - Options: 06:05:26 INFO - -h, --help show this help message and exit 06:05:26 INFO - -d DEST, --destination=DEST 06:05:26 INFO - Directory to install application into. [default: 06:05:26 INFO - "/builds/slave/test"] 06:05:26 INFO - --app=APP Application being installed. [default: firefox] 06:05:26 INFO - mkdir: /builds/slave/test/build/application 06:05:26 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'] 06:05:26 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 06:05:42 INFO - Reading from file tmpfile_stdout 06:05:42 INFO - Output received: 06:05:42 INFO - /builds/slave/test/build/application/firefox/firefox 06:05:42 INFO - Running post-action listener: _resource_record_post_action 06:05:42 INFO - ##### 06:05:42 INFO - ##### Finished install step (success) 06:05:42 INFO - ##### 06:05:42 INFO - ##### 06:05:42 INFO - ##### Running run-tests step. 06:05:42 INFO - ##### 06:05:42 INFO - Running pre-action listener: _resource_record_pre_action 06:05:42 INFO - Running main action method: run_tests 06:05:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:05:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:05:42 INFO - Python 2.7.3 06:05:42 INFO - Return code: 0 06:05:42 INFO - grabbing minidump binary from tooltool 06:05:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:05:42 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 0x1a072e0>, '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 0x1973140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19735d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:05:42 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 06:05:42 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 06:05:42 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 06:05:42 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:05:42 INFO - Return code: 0 06:05:42 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:05:42 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:05:42 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:05:42 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:05:42 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:05:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 06:05:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 06:05:43 INFO - Return code: 0 06:05:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Gy7SPqtARWSrgBLlWNGeDg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-006', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 06:05:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Gy7SPqtARWSrgBLlWNGeDg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-006 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 06:05:43 INFO - Using env: {'DISPLAY': ':0', 06:05:43 INFO - 'HOME': '/home/cltbld', 06:05:43 INFO - 'LANG': 'en_US.UTF-8', 06:05:43 INFO - 'LANGUAGE': 'en_US:en', 06:05:43 INFO - 'LOGNAME': 'cltbld', 06:05:43 INFO - 'MAIL': '/var/mail/cltbld', 06:05:43 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:05:43 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:05:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:05:43 INFO - 'MOZ_NO_REMOTE': '1', 06:05:43 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:05:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:05:43 INFO - 'NO_EM_RESTART': '1', 06:05:43 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:05:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:05:43 INFO - 'PWD': '/builds/slave/test', 06:05:43 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:05:43 INFO - 'SHELL': '/bin/bash', 06:05:43 INFO - 'SHLVL': '1', 06:05:43 INFO - 'TERM': 'linux', 06:05:43 INFO - 'TMOUT': '86400', 06:05:43 INFO - 'USER': 'cltbld', 06:05:43 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1466427888.291101-1501507299', 06:05:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:05:43 INFO - '_': '/tools/buildbot/bin/python'} 06:05:43 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Gy7SPqtARWSrgBLlWNGeDg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-006', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 06:05:44 INFO - mozversion application_buildid: 20160620045124 06:05:44 INFO - mozversion application_changeset: 3c5025f98e561a20e24d97c91a9e4e0ec28015ea 06:05:44 INFO - mozversion application_display_name: Nightly 06:05:44 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:05:44 INFO - mozversion application_name: Firefox 06:05:44 INFO - mozversion application_remotingname: firefox 06:05:44 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 06:05:44 INFO - mozversion application_vendor: Mozilla 06:05:44 INFO - mozversion application_version: 50.0a1 06:05:44 INFO - mozversion platform_buildid: 20160620045124 06:05:44 INFO - mozversion platform_changeset: 3c5025f98e561a20e24d97c91a9e4e0ec28015ea 06:05:44 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 06:05:44 INFO - mozversion platform_version: 50.0a1 06:05:44 INFO - using testdate: 1466427944 06:05:44 INFO - actual date: 1466427944 06:05:44 INFO - starting webserver on 'localhost:47240' 06:05:44 INFO - SUITE-START | Running 2 tests 06:05:44 INFO - TEST-START | dromaeo_css 06:05:44 INFO - operating with platform_type : linux_ 06:05:44 INFO - Initialising browser for dromaeo_css test... 06:05:44 INFO - TEST-INFO | started process 24012 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_Mg1nd/profile http://localhost:47240/getInfo.html) 06:05:48 INFO - PROCESS | 24012 | __metrics Screen width/height:1600/1200 06:05:48 INFO - PROCESS | 24012 | colorDepth:24 06:05:48 INFO - PROCESS | 24012 | Browser inner width/height: 1024/697 06:05:48 INFO - PROCESS | 24012 | __metrics 06:05:49 INFO - PROCESS | 24012 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:05:50 INFO - TEST-INFO | 24012: exit 0 06:05:50 INFO - Browser initialized. 06:05:50 INFO - Running cycle 1/1 for dromaeo_css test... 06:05:50 INFO - TEST-INFO | started process 24093 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_Mg1nd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:06:02 INFO - PROCESS | 24093 | RSS: Main: 175927296 06:06:02 INFO - PROCESS | 24093 | 06:06:53 INFO - PROCESS | 24093 | 1466428013371 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] 06:09:06 INFO - PROCESS | 24093 | Cycle 1(1): loaded http://localhost:47240/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47240/tests/dromaeo/cssquery-ext.html) 06:09:07 INFO - PROCESS | 24093 | RSS: Main: 289509376 06:09:07 INFO - PROCESS | 24093 | 06:12:10 INFO - PROCESS | 24093 | Cycle 1(1): loaded http://localhost:47240/tests/dromaeo/cssquery-ext.html (next: http://localhost:47240/tests/dromaeo/cssquery-jquery.html) 06:12:10 INFO - PROCESS | 24093 | RSS: Main: 256507904 06:12:10 INFO - PROCESS | 24093 | 06:15:12 INFO - PROCESS | 24093 | Cycle 1(1): loaded http://localhost:47240/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47240/tests/dromaeo/cssquery-mootools.html) 06:15:13 INFO - PROCESS | 24093 | RSS: Main: 259960832 06:15:13 INFO - PROCESS | 24093 | 06:18:15 INFO - PROCESS | 24093 | Cycle 1(1): loaded http://localhost:47240/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47240/tests/dromaeo/cssquery-prototype.html) 06:18:16 INFO - PROCESS | 24093 | RSS: Main: 257908736 06:18:16 INFO - PROCESS | 24093 | 06:21:19 INFO - PROCESS | 24093 | Cycle 1(1): loaded http://localhost:47240/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47240/tests/dromaeo/cssquery-yui.html) 06:21:19 INFO - PROCESS | 24093 | RSS: Main: 238379008 06:21:19 INFO - PROCESS | 24093 | 06:24:22 INFO - PROCESS | 24093 | Cycle 1(1): loaded http://localhost:47240/tests/dromaeo/cssquery-yui.html (next: http://localhost:47240/tests/dromaeo/cssquery-dojo.html) 06:24:23 INFO - PROCESS | 24093 | RSS: Main: 291438592 06:24:23 INFO - PROCESS | 24093 | 06:24:23 INFO - PROCESS | 24093 | __start_tp_report 06:24:23 INFO - PROCESS | 24093 | _x_x_mozilla_page_load 06:24:23 INFO - PROCESS | 24093 | _x_x_mozilla_page_load_details 06:24:23 INFO - PROCESS | 24093 | |i|pagename|runs| 06:24:23 INFO - PROCESS | 24093 | |0;dojo.html;2623.147477069953;2628.6845578530574;2670.3991601889566;2679.102500662278;2693.097812232902;4575.679702420824;4623.329617205503;4666.976665116678;4708.199606066968;4765.213739732944;4597.333386658941;4610.561996610325;4689.085628302482;4722.881927951803;4728.456227533835;4086.1827634473075;4214.494260688714;4309.612134907858;4336;4458.576435238647;4367.213901497729;4399.03221291317;4409.492908315537;4419.558044195587;4448.065906159711;4228.9788551057045;4279.251131052053;4279.614834664864;4391.473023237232;4415.315626077963;4175.290200665894;4180.16396720654;4182.184474027566;4212.326027835532;4258.446401967755;4192.958070419288;4197.790110494463;4206.390073439365;4240.491141063061;4245.10852720929;4592.127495775825;4663.836765713218;4734.218853889104;4739.123262196505;4772.928406073912;5085.516875896784;5102.387713474407;5134.435212126663;5145.434002259786;5151.845444636667;5154.716490593016;5162.148245539482;5183.896322073538;5187.273781670569;5195.428502864682;4643.674942754009;4723.716577005391;4746.264329029006;4788.784504697297;4848.272759086095;5249.711265880337;5291.603129765206;5293.0472514946905;5293.073712100367;5293.973530132324;4904.681195722266;5077.060743762416;5090.414602320707;5091;5091.87270318245;5001.624878134155;5045.495450454925;5051.191809310492;5062.620303477254;5125.256837758504;5006.724630145304;5016.2224855147515;5017.498250174954;5023.8492845214705;5075.213341932006;4851.830185943475;4986.950130498722;4997.750112494361;5000.3249561309485;5005.34930459038;4151.232022075926;4194.979025104855;4213.6839737019845;4225.704200705921;4234.301340278819;3713.313037088147;3721.4417837324077;3722.8696995605565;3745.8127093645207;3759.436084587334;4249.575042495726;4377.409049778303;4407.294832826732;4412.84555040572;4424.756638384855;5029.874253143627;5143.5113664201845;5151.845444636667;5162.6128040397125;5164.741762911839;4420.425344705232;4421.557844215553;4442.644588432918;4452.532484089189;4468.419105516327;4453.332000199931;4501.932471012938;4583.702059366131;4594.931076033862;4624.722516649012;4823.348847905629;4834.8791280218275;4907.55831975124;4910.631702622246;4910.8772280693265;5125.538701516882;5134.666246693953;5135.127028405254;5141.742912854267;5189.143791274398;4727.952720472889;4814.6870453420415;4847.321375007572;4866.464688884291;4907.3620429343955;4982.62630302736;5013.122703526796;5024.045431368028;5057.115004874206;5078.4667609900425;5067.341245638044;5071.771770270273;5078.949210507995;5079.619028572798;5124.923126153036;4797.952020479751;4885.975570122127;4914.533119353656;4938.38270216223;4940.110780059624;4941.209406494943;4944.431390390151;4969.3291405659775;4971.552560269593;5012.373453318335;4809.927851082167;4855.344528488608;4902.411710594752;4941.481144479922;4943.703377797344;4850.878728031827;4893.681910675937;4965.255211718271;5042.319286896369;5043;4822.083804077214;4836.733979631154;4839.854804355875;4892.2661600760175;4901.9264711028645 06:24:23 INFO - PROCESS | 24093 | |1;ext.html;546.3921046340879;572.4590262202221;585.4292065236394;591.7869566955898;599.2838557923282;26165.345866353327;26667;38388.040298992506;38970;39307.21385572287;36928;41416.792916035374;41423.378649320286;41570.37644435336;41581.376279355834;7843.490173138742;7989.400794940403;7994.6002699864775;7995.360371170293;8002.119766825645;7456.291652293024;10042.648507302209;10298.794024119514;10308.896911030906;10644.733881652943;10322.380657160556;10402.583896644124;10478.423686697228;10488.475576221197;10490.898455662122;10324.277300588961;10326.328788628714;10355.06804387605;10415.791684166274;10432.32189907661;10267.691969240936;10334.586616535329;10335.379877207317;10335.483225838678;10344.275900686955;38409.807950960065;38645.42031869496;38650;38719.8064009681;38743.225135497414;3086.2130156810094;3130.2956834712236;3148.7481001519823;3236.385086833494;3361.1359348624815;29615;29947.700522994928;30296;30754.692453075408;31460.056198314087;2970.77719171063;2981.8658160382834;3001.9249518762203;3023.3046399328277;3051.5727798108283;234755;235324;235735;235750;236242.99999999828;52768.73615631897;53039.20441193385;53041.7347913258;53104.73447632737;53114.734426327625;56179;56253.43746562482;56259.71870140623;56270;56398.436015639316;14087.859121408655;14431.278436078153;14437.35031923566;14438.494652687106;14445.85554144445;9119.498427586414;9564.856527152098;10612;10780.40707761065;10782.568697252022;16220.270087846075;16830;16839.663206735797;16908.661826763397;17052.48842534726;6020.397960204032;6099.9390006099375;6169.84575385619;6190.535709821781;6318.4313411793155;817.4318848400304;894.2622336572224;928.8560273157672;936.9063093690577;993.0615568288043;27638;28085.438291234062;28215;28678.42643147167;28791.712082879323;958.5638534466801;1002.2983911262146;1036.828923227659;1055.9683209503573;1066.7546464313095;14822.407103715947;14833.406663733545;14957.102573845605;15173.544793656209;15344.616384590474;344923;346773;347417;347632;348048;48128.27807582889;49099.75450122798;49144.50855491399;49162.26256606154;49175.26237106446;1045.72288343589;1173.096715529038;1211.2611307102836;1215.1797536662893;1220.2495465288785;28048.29879253035;28904.277393065342;29050.837966481104;29345.85327073351;29358.266043349086;41910.37134442925;42176.57823421727;42448.36327455029;42490.5750942499;42531.57468425276;289788;290231.0976890204;290949;291388;292417;30660.080197594107;31642.208944776565;35281.647183527835;37097.814510927274;37251.813740931124;40769.796151020244;40935.59064409318;41212.58787412087;41303.7934810324;42019.57980420157;34927.47608785921;35365.82317088398;35711.28577428489;35921;35952;35654.28691426105;35866.82066589651;36077;36177.45733813942;36300;35088.82455587706;35426.29147417089;35597.644023559435;35614;36064.27871442504;31219.219519511284;32546;32581.837090814395;32593.511097333085;33008;24561.385965350295;24719.43722922166;24890.626640600767;25152;25213.495730085662 06:24:23 INFO - PROCESS | 24093 | |2;jquery.html;372.58270736774836;372.94405839124136;377.51866370377763;383.6336298834613;384.0648022066269;15657.608559786011;16887.24007419666;17726.202320895558;17741.645167096667;17894.5526361841;16237.106959117244;16607.169641517936;17403.564910877234;17445.040522771244;17470;5027.673201241908;5179.119549676564;5187.092258854705;5218.2172674099;5224.033553792541;3752.212035472554;3904.511936007999;5692.203091567184;5999.85000374992;6005.729742161613;5978.910316345258;5994.920914235436;6039.214902062726;6052.757889684407;6060.848478788022;5842.53259739222;5969.432903874125;5988.550858685594;5996.4902983246475;5999.340072592011;3321.485169798661;3499.562554680665;3500.859965601373;3541.4333706606817;4888;20970.685439718418;20984.26555070565;21171.153153873827;21350.35948921535;21369.786302136934;1919.5393105654682;1953.4823271832975;2002.0790436399275;2089.8955052247325;2423.6849209602815;12618.621441356774;13283.86716132836;13498.865011349859;13666.453341866314;13743.312834358341;1671.9247633856505;1729.7751292331916;1731.7056100462826;1793.2916497983354;2040.357287454447;64296.678516607586;66206.66896665534;73411.63294183549;74390.62804685996;78145.21854781437;15410.537683869501;15446.0732356059;15470.845291547166;15601;15660;28209.43581128366;28498.287542811595;28542.857285713853;28544.42911141807;28559.14408559169;8847.46915185078;8870.73387798367;9015.77460563478;9021.32340074497;9032.774180645405;7356.485046046832;7379.741709040158;7502.549847009197;7516.661750221253;7560.054993125859;8172.956760809798;8179.713710020121;8201.630926608317;8354.248117669438;8490.193431623986;2636.5517861963513;3199.264169241041;3312.6521715220038;3413.4026545354463;3457.636948120411;848.6520526584071;910.01263628962;918.7749001494676;960.8846938367441;975.3465178330393;16334.673306533803;16424.946881639797;16899.324027039027;17028.318867245172;17322;866.467122719523;892.7812685891868;910.6493999809989;920.7099763574453;935.0929598289648;9342.112499312554;9383.577739001761;9722.319437639439;9740.17208537268;9893.950530247446;382596;391022;407800.7659770212;413031;413573;74300.62849685717;77488.61255693686;79772.20227797765;80018.5999070001;82869;909.5725009245645;921.6221349246777;952.79991201847;960.2462067277154;963.1428029054148;15636;15714.371425143323;15771.44799931997;15989.520314390587;16152.434664786677;27875.07311732239;34984.650153498136;36537.634623654485;36610.26779464343;38316.425253621775;48227.75886120547;51922.740386297824;52323.21515177352;52567.73716131395;52636.47363526469;7760.654033741123;7901;7946.205379462239;8099.14958929304;8114.06688230861;11319.151063670093;11948;12233.327167005544;12388.256704597752;12404.25574465535;9627.711168664951;9997.650082247086;10299.309362691452;10532.947335263581;10748.677539673823;10494.632687855888;10777.946110269711;10994;11013.889861101286;11129.443527823738;10792.352458852494;10851;11010.229283950046;11048.281861678965;11277.887221128012;7732.7680169595005;7805.765827025199;7921.722739704082;8064.112947575644;8134.633941472766;9445.622175112918;9866.062724041205;9888.752781180528;10064.748381290527;10479.371237725762 06:24:23 INFO - PROCESS | 24093 | |3;mootools.html;1253.8056601226801;1374.8693874081962;1397.210576024546;1488.5162322245267;1676.874234432417;6544.443722283606;7557;7717.575533345671;7797.6491057902385;8060.677572897077;7815.101263354716;7850.332721718646;7908.3673306135515;7915.327197188246;7928.0882698489695;2188.7482939461925;2188.879611621356;2204.2505548113636;2223.132978138527;2224.0325458425636;2138.818200452956;2180.6292930201826;2208.8122509586706;2211.4581927427803;2212.889355532225;2142.4322554523064;2143.967840482394;2150.0432307623114;2151.0965394534333;2194.8024677779;2107.4309936317186;2109.472631842047;2110.0399318310133;2112.535242246703;2114.8413868959888;2053.5482193917314;2102.4008157675144;2118.131566057909;2123.6283650361124;2125.0755921174336;7824.37405007598;7891.171427000198;7891.368690504746;7892.329152022085;7910.129885712567;4326.199653064194;4494.595486406207;4518.977405112986;4541.069080838421;4546.590806827368;2802.8738706758245;2882.409106133238;2939.3386488040233;2957.3641667041475;2959.689232630564;887.4719541872576;889.715291106846;889.9822003559957;892.6250974590688;896.7802888292345;10406.687799366031;10475.319104258198;10488.947555262175;10513.211509136769;10521.158307335394;3886.70849686269;3968.940465893014;4025.7383270087353;4031.637152656275;4037.9394309085387;8297.792555186168;8321.542315172723;8332.208440198172;8344.374171937008;8346.958265208757;4506.414166158444;4526.705764125321;4526.7283962961665;4535.9773201133785;4539.795709193094;3593.8921832345072;3875.2249550090096;4214.515330736943;4285.46431696038;4300.376445415397;3385.7968521888765;3426.057834095594;3436.261203841186;3495.07380544156;3525.8765943191866;1002.6089824968268;1010.0555980158575;1025.5795123999274;1028.804527139841;1029.9433531155707;591.4140938832684;779.3803925878826;800.4196957206095;821.6261600971544;838.362844238371;5093.898122037538;5172.689638621695;5192.350956130484;5244.396894357122;5289.761960711778;797.6646923968251;849.5794581682106;862.4307956748515;863.1239292118505;900.5002223765742;3559.2525569630666;3579.7673151245085;3587.2466781975554;3591.9281614367565;3598.5142005829402;9497.477638729937;9829.066238707312;9839.80320393588;9856.408615483095;9868.21054315653;9656.37233579815;9671.081247281498;9753;9768.560414781352;9770.902290977141;7331.596762178025;7468.365188958891;7502.812429689301;7508.737194198176;7508.774736758015;4973.577245933991;5145.819896303611;5156.071907056766;5222.399424066281;5251.028559716465;8985.101489850962;9103.408278461879;9117.817643647222;9205.401648892801;9222;8758.255548278214;9308;9336.346455748304;9363.953180234055;9376.249900008119;5679.062954612608;6069.757209711562;6192.380761923771;6211.720472578654;6364.331745166691;7540.8491830164185;7552.697892084475;7611.809704757426;7612.238776122344;7618.123915749759;6875.759348422781;7043.964780176067;7054.717811287696;7106.147262328347;7169.390601798906;6793.082933803873;6839.589624622538;6894.310568943066;6987.7204911802955;6998.370146686822;6393.073004414427;6551.639659818565;6567.507436942344;6575.638339891352;6585.407313341822;4600.516945720785;4688.507706690748;4745.098431298043;4761.880952976203;4819.518048195152;4851.80592776285;4881.731504767272;4888.682235654671;4907.312976183266;4921.950780492292 06:24:23 INFO - PROCESS | 24093 | |4;prototype.html;288.8281472523848;289.6133661561815;298.1606776922962;299.55665614889955;303.8769298434135;4669.696469729465;4819.228923372261;4870.707757534546;4894.755262236888;4905.4113506379235;4680.438347398317;4815.8796030099265;4849.296851956464;4862.2706594010915;4866.343043689101;3750.887473375803;3756.417755247941;3760.1986520042537;3773.6415040571237;3797.468354430382;3638.6907112895437;3666.3034023535574;3779.829907654162;3794.4308353746883;3807.2956503047026;3713.4801127842125;3745.0824547985644;3748.156664750423;3759.6052414496494;3762.0970966967866;3747.9625203748024;3753.39945608704;3766.736328457009;3781.130340021783;3786.6024067472795;3325.5201435361273;3326.750493712957;3333.2166940769143;3343.866245350183;3345.866165353383;4661.906761864778;4727.574518293336;4748.667593268473;4759.619230461555;4761.547652972962;4340.52254252032;4352.194843953847;4354.238008348526;4355.7822108894425;4391.73649581023;5084.237364395371;5101.51535604117;5108.923366149511;5127.717975511346;5149.974250128763;3555.768875023115;3619.5294611700574;3640.654137856926;3662.304162209172;3668.101315177772;5278.551323137538;5313.734313284359;5314.0169068722025;5315.867103322409;5345.759440825133;3749.49381833449;3754.2303827715255;3781.149241420658;3787.5644300905196;3792.905177370533;3497.4753786931656;3843.6925045996254;3844.6539811417106;3848.3650197717625;3851.9037024074064;4215.494140703136;4243.618074373321;4260.659147268273;4271.807768650418;4276.35854621803;4853.9029219415415;4970.365706175733;5054.444011158769;5093.141003533684;5141.434442211354;1248.843894513186;1265.7721610110084;1269.5302737987004;1273.5224290890917;1274.5156840400773;803.8264134363777;815.5962798414822;827.2472050434076;835.8643665434872;838.781916701662;4019.477467929209;4081.326656071056;4083.9387409188885;4119.773412462343;4130.483689538808;4575.9771201143785;4585.28928016158;4674.3172457915125;4685.531446855287;4709.1994360958715;4019.191363886263;4058.6347228748964;4063.4152680454645;4091.284025295561;4121.175764846983;2336.97663023371;2474.2329877737957;2477.603583426643;2487.502499500107;2496.9375765606005;4398.868033958986;4408.382826404306;4415.690901636919;4420.7126536775;4453.55464453552;4713.293006049052;4719.513353293702;4776.880577985508;4778.37881075458;4795.736234507136;4402.3176407656865;4439.556044395599;4610.654200934943;5037.798488060436;5055.721935293521;5259.474052594863;5278.700811992505;5296.258523806593;5297.17893726473;5315.202719592092;5190.766415511386;5197.298364720715;5199.376074871039;5210.1142805723875;5233.371995360581;4814.325994360863;5043.5460808527405;5074.340335756328;5095.26118712792;5097.235414687826;3663.9267214655024;3691.3540130477595;3693.1874987502706;3730.645588669072;3737.8039027510936;5154.458781828004;5409.350877894678;5419.482544887438;5432.18517222404;5440.53755430777;5092.923606145837;5125.564327032095;5126.615503837302;5144.6398752087;5189.792408303777;5096.770645321044;5111.3355263815465;5117.769700363418;5128.128233194782;5174.586033117266;4827.348307978378;5050.898982020265;5060.443351231435;5076.847694569169;5079.288899554139;5024.593113928106;5113.079645663816;5168.431472538093;5183.844484665466;5195.025890161714;5020.146575082318;5029.572486338702;5038.496150385079;5038.647294689483;5088.465711100429 06:24:23 INFO - PROCESS | 24093 | |5;yui.html;570.8744076303212;627.9843003924901;652.4030512081446;661.6559389117662;672.5863593889758;12422.440990155443;13158.276294803782;13346.132501387403;13387.39756710948;13491;11404.486798094085;11443.084553235742;11503.769924601504;12597.244165350085;12640.494380224804;622.6606499457783;642.7589653879795;783.2793829676697;792.4492477727953;792.9008873890764;760.8934749135126;786.1862971824163;787.3504358903898;787.8069872881152;792.7780221537979;831.629924683516;835.4152093534519;835.8829763833069;836.1721895323616;836.4646626159263;646.240667216024;808.7007807111347;827.1769589258696;828.2380210206594;835.4987007795335;612.6446660936646;612.770211170811;613.0099888679795;613.1691557938973;614.2107392001302;12553.121281510297;12680.80978785319;12681.365931703378;12694.047946403964;12699.619011429671;12143.271403715806;12683.17559358648;12739.398765677808;12778.297193654345;12983.35083245834;11294;11630.767384652345;11717.133440698837;11816.704582385422;12019.699507512294;4174.937375939363;4188.979055104735;4203.894902627429;4216;4269.509006464265;57150.42849571493;57448;58531.41468585345;59057.11414328789;59224;10228.488575571191;10355.378677279386;10430.634927777492;10440.947795261127;10450.58917046189;18966.43100706981;19136.521586960436;19159.8084019158;19190.61618767617;19419.902900485406;6823.93176068233;6840.828979275558;6882.793516194522;6928.376446119873;6960.443164546824;3724.6275372462537;3770.7549009314307;3799.2591444668024;3829.6936245100883;3846.769193848378;2674.7860171186258;2775.6252905857855;2779.7915156363356;2781.485425196345;2783.6381270434713;480.8052738640856;481.8482178113883;493.043495618499;497.5546885537424;498.16805934090155;438.3030980740574;454.78852333664344;492.74869816393897;599.6462087368474;602.8131279303342;7372.889406658905;7394.704211831574;7610.39116870649;8094.757157285291;8257.174282571816;491.071874157842;497.7909278103205;510.9693418394908;550.9972450137724;590.858139245236;3806.752561083576;3816.44661524083;3821.4267859820693;3905.7851818150275;3918.1967696622123;84442.57778711067;85078;86579;86814.56592716996;87451;74938;76005.23994759981;76302.23697762951;79678.20321796824;80344;67779.3222067773;68329.3167068323;68661.31338686649;69518.65240673764;70380;6855.725770969106;6935.861282774417;6975.837490377796;7095.9645201773665;7108.07595012645;30324.84837575798;34421.82789086139;39934.60065399309;40736.1852762949;41248.38127428151;39101.6089839098;50856.237156441945;52889.47110528845;57099;59484.70257648857;8246.876296855671;8403.159684031549;8453.746387608382;8674.392792504465;8762.956185219033;10161.441120738431;10232.48837558134;10288.382697038202;10316.329438586468;10451.477426128511;7930.762077137695;11155.609553665583;11597.362145081765;11782.351970641354;11795;10973.615923442641;11336.6032188873;11462.14033947474;11933.880661193623;12331.69170770738;10733.302335348177;10970;11487;11515.884841151481;11603.6518904433;9155.404898681565;9295.767605809639;9470.715878523655;9481.241500679791;9683.273754468302;9458.43249405038;9515;9539.57071931751;9725.825118729308;9750.609975600897 06:24:23 INFO - PROCESS | 24093 | __end_tp_report 06:24:23 INFO - PROCESS | 24093 | __start_cc_report 06:24:23 INFO - PROCESS | 24093 | _x_x_mozilla_cycle_collect,1142 06:24:23 INFO - PROCESS | 24093 | __end_cc_report 06:24:23 INFO - PROCESS | 24093 | __startTimestamp1466429063040__endTimestamp 06:24:23 INFO - PROCESS | 24093 | 06:24:23 INFO - PROCESS | 24093 | ------- Summary: start ------- 06:24:23 INFO - PROCESS | 24093 | Number of tests: 6 06:24:23 INFO - PROCESS | 24093 | 06:24:23 INFO - PROCESS | 24093 | [#0] dojo.html Cycles:165 Average:4683.03 Median:4839.85 stddev:512.58 (10.6%) stddev-sans-first:488.02 06:24:23 INFO - PROCESS | 24093 | Values: 2623.1 2628.7 2670.4 2679.1 2693.1 4575.7 4623.3 4667.0 4708.2 4765.2 4597.3 4610.6 4689.1 4722.9 4728.5 4086.2 4214.5 4309.6 4336.0 4458.6 4367.2 4399.0 4409.5 4419.6 4448.1 4229.0 4279.3 4279.6 4391.5 4415.3 4175.3 4180.2 4182.2 4212.3 4258.4 4193.0 4197.8 4206.4 4240.5 4245.1 4592.1 4663.8 4734.2 4739.1 4772.9 5085.5 5102.4 5134.4 5145.4 5151.8 5154.7 5162.1 5183.9 5187.3 5195.4 4643.7 4723.7 4746.3 4788.8 4848.3 5249.7 5291.6 5293.0 5293.1 5294.0 4904.7 5077.1 5090.4 5091.0 5091.9 5001.6 5045.5 5051.2 5062.6 5125.3 5006.7 5016.2 5017.5 5023.8 5075.2 4851.8 4987.0 4997.8 5000.3 5005.3 4151.2 4195.0 4213.7 4225.7 4234.3 3713.3 3721.4 3722.9 3745.8 3759.4 4249.6 4377.4 4407.3 4412.8 4424.8 5029.9 5143.5 5151.8 5162.6 5164.7 4420.4 4421.6 4442.6 4452.5 4468.4 4453.3 4501.9 4583.7 4594.9 4624.7 4823.3 4834.9 4907.6 4910.6 4910.9 5125.5 5134.7 5135.1 5141.7 5189.1 4728.0 4814.7 4847.3 4866.5 4907.4 4982.6 5013.1 5024.0 5057.1 5078.5 5067.3 5071.8 5078.9 5079.6 5124.9 4798.0 4886.0 4914.5 4938.4 4940.1 4941.2 4944.4 4969.3 4971.6 5012.4 4809.9 4855.3 4902.4 4941.5 4943.7 4850.9 4893.7 4965.3 5042.3 5043.0 4822.1 4836.7 4839.9 4892.3 4901.9 06:24:23 INFO - PROCESS | 24093 | 06:24:23 INFO - PROCESS | 24093 | [#1] ext.html Cycles:180 Average:45446.70 Median:32563.92 stddev:77130.41 (236.9%) stddev-sans-first:77273.11 06:24:23 INFO - PROCESS | 24093 | Values: 546.4 572.5 585.4 591.8 599.3 26165.3 26667.0 38388.0 38970.0 39307.2 36928.0 41416.8 41423.4 41570.4 41581.4 7843.5 7989.4 7994.6 7995.4 8002.1 7456.3 10042.6 10298.8 10308.9 10644.7 10322.4 10402.6 10478.4 10488.5 10490.9 10324.3 10326.3 10355.1 10415.8 10432.3 10267.7 10334.6 10335.4 10335.5 10344.3 38409.8 38645.4 38650.0 38719.8 38743.2 3086.2 3130.3 3148.7 3236.4 3361.1 29615.0 29947.7 30296.0 30754.7 31460.1 2970.8 2981.9 3001.9 3023.3 3051.6 234755.0 235324.0 235735.0 235750.0 236243.0 52768.7 53039.2 53041.7 53104.7 53114.7 56179.0 56253.4 56259.7 56270.0 56398.4 14087.9 14431.3 14437.4 14438.5 14445.9 9119.5 9564.9 10612.0 10780.4 10782.6 16220.3 16830.0 16839.7 16908.7 17052.5 6020.4 6099.9 6169.8 6190.5 6318.4 817.4 894.3 928.9 936.9 993.1 27638.0 28085.4 28215.0 28678.4 28791.7 958.6 1002.3 1036.8 1056.0 1066.8 14822.4 14833.4 14957.1 15173.5 15344.6 344923.0 346773.0 347417.0 347632.0 348048.0 48128.3 49099.8 49144.5 49162.3 49175.3 1045.7 1173.1 1211.3 1215.2 1220.2 28048.3 28904.3 29050.8 29345.9 29358.3 41910.4 42176.6 42448.4 42490.6 42531.6 289788.0 290231.1 290949.0 291388.0 292417.0 30660.1 31642.2 35281.6 37097.8 37251.8 40769.8 40935.6 41212.6 41303.8 42019.6 34927.5 35365.8 35711.3 35921.0 35952.0 35654.3 35866.8 36077.0 36177.5 36300.0 35088.8 35426.3 35597.6 35614.0 36064.3 31219.2 32546.0 32581.8 32593.5 33008.0 24561.4 24719.4 24890.6 25152.0 25213.5 06:24:23 INFO - PROCESS | 24093 | 06:24:23 INFO - PROCESS | 24093 | [#2] jquery.html Cycles:180 Average:25669.69 Median:2144.29 stddev:66206.42 (3087.6%) stddev-sans-first:66364.90 06:24:23 INFO - PROCESS | 24093 | Values: 372.6 372.9 377.5 383.6 384.1 15657.6 16887.2 17726.2 17741.6 17894.6 16237.1 16607.2 17403.6 17445.0 17470.0 5027.7 5179.1 5187.1 5218.2 5224.0 3752.2 3904.5 5692.2 5999.9 6005.7 5978.9 5994.9 6039.2 6052.8 6060.8 5842.5 5969.4 5988.6 5996.5 5999.3 3321.5 3499.6 3500.9 3541.4 4888.0 20970.7 20984.3 21171.2 21350.4 21369.8 1919.5 1953.5 2002.1 2089.9 2423.7 12618.6 13283.9 13498.9 13666.5 13743.3 1671.9 1729.8 1731.7 1793.3 2040.4 64296.7 66206.7 73411.6 74390.6 78145.2 15410.5 15446.1 15470.8 15601.0 15660.0 28209.4 28498.3 28542.9 28544.4 28559.1 8847.5 8870.7 9015.8 9021.3 9032.8 7356.5 7379.7 7502.5 7516.7 7560.1 8173.0 8179.7 8201.6 8354.2 8490.2 2636.6 3199.3 3312.7 3413.4 3457.6 848.7 910.0 918.8 960.9 975.3 16334.7 16424.9 16899.3 17028.3 17322.0 866.5 892.8 910.6 920.7 935.1 9342.1 9383.6 9722.3 9740.2 9894.0 382596.0 391022.0 407800.8 413031.0 413573.0 74300.6 77488.6 79772.2 80018.6 82869.0 909.6 921.6 952.8 960.2 963.1 15636.0 15714.4 15771.4 15989.5 16152.4 27875.1 34984.7 36537.6 36610.3 38316.4 48227.8 51922.7 52323.2 52567.7 52636.5 7760.7 7901.0 7946.2 8099.1 8114.1 11319.2 11948.0 12233.3 12388.3 12404.3 9627.7 9997.7 10299.3 10532.9 10748.7 10494.6 10777.9 10994.0 11013.9 11129.4 10792.4 10851.0 11010.2 11048.3 11277.9 7732.8 7805.8 7921.7 8064.1 8134.6 9445.6 9866.1 9888.8 10064.7 10479.4 06:24:23 INFO - PROCESS | 24093 | 06:24:23 INFO - PROCESS | 24093 | [#3] mootools.html Cycles:180 Average:5119.78 Median:5207.38 stddev:2898.77 (55.7%) stddev-sans-first:2892.34 06:24:23 INFO - PROCESS | 24093 | Values: 1253.8 1374.9 1397.2 1488.5 1676.9 6544.4 7557.0 7717.6 7797.6 8060.7 7815.1 7850.3 7908.4 7915.3 7928.1 2188.7 2188.9 2204.3 2223.1 2224.0 2138.8 2180.6 2208.8 2211.5 2212.9 2142.4 2144.0 2150.0 2151.1 2194.8 2107.4 2109.5 2110.0 2112.5 2114.8 2053.5 2102.4 2118.1 2123.6 2125.1 7824.4 7891.2 7891.4 7892.3 7910.1 4326.2 4494.6 4519.0 4541.1 4546.6 2802.9 2882.4 2939.3 2957.4 2959.7 887.5 889.7 890.0 892.6 896.8 10406.7 10475.3 10488.9 10513.2 10521.2 3886.7 3968.9 4025.7 4031.6 4037.9 8297.8 8321.5 8332.2 8344.4 8347.0 4506.4 4526.7 4526.7 4536.0 4539.8 3593.9 3875.2 4214.5 4285.5 4300.4 3385.8 3426.1 3436.3 3495.1 3525.9 1002.6 1010.1 1025.6 1028.8 1029.9 591.4 779.4 800.4 821.6 838.4 5093.9 5172.7 5192.4 5244.4 5289.8 797.7 849.6 862.4 863.1 900.5 3559.3 3579.8 3587.2 3591.9 3598.5 9497.5 9829.1 9839.8 9856.4 9868.2 9656.4 9671.1 9753.0 9768.6 9770.9 7331.6 7468.4 7502.8 7508.7 7508.8 4973.6 5145.8 5156.1 5222.4 5251.0 8985.1 9103.4 9117.8 9205.4 9222.0 8758.3 9308.0 9336.3 9364.0 9376.2 5679.1 6069.8 6192.4 6211.7 6364.3 7540.8 7552.7 7611.8 7612.2 7618.1 6875.8 7044.0 7054.7 7106.1 7169.4 6793.1 6839.6 6894.3 6987.7 6998.4 6393.1 6551.6 6567.5 6575.6 6585.4 4600.5 4688.5 4745.1 4761.9 4819.5 4851.8 4881.7 4888.7 4907.3 4922.0 06:24:23 INFO - PROCESS | 24093 | 06:24:23 INFO - PROCESS | 24093 | [#4] prototype.html Cycles:180 Average:4154.46 Median:4665.80 stddev:1225.96 (26.3%) stddev-sans-first:1194.57 06:24:23 INFO - PROCESS | 24093 | Values: 288.8 289.6 298.2 299.6 303.9 4669.7 4819.2 4870.7 4894.8 4905.4 4680.4 4815.9 4849.3 4862.3 4866.3 3750.9 3756.4 3760.2 3773.6 3797.5 3638.7 3666.3 3779.8 3794.4 3807.3 3713.5 3745.1 3748.2 3759.6 3762.1 3748.0 3753.4 3766.7 3781.1 3786.6 3325.5 3326.8 3333.2 3343.9 3345.9 4661.9 4727.6 4748.7 4759.6 4761.5 4340.5 4352.2 4354.2 4355.8 4391.7 5084.2 5101.5 5108.9 5127.7 5150.0 3555.8 3619.5 3640.7 3662.3 3668.1 5278.6 5313.7 5314.0 5315.9 5345.8 3749.5 3754.2 3781.1 3787.6 3792.9 3497.5 3843.7 3844.7 3848.4 3851.9 4215.5 4243.6 4260.7 4271.8 4276.4 4853.9 4970.4 5054.4 5093.1 5141.4 1248.8 1265.8 1269.5 1273.5 1274.5 803.8 815.6 827.2 835.9 838.8 4019.5 4081.3 4083.9 4119.8 4130.5 4576.0 4585.3 4674.3 4685.5 4709.2 4019.2 4058.6 4063.4 4091.3 4121.2 2337.0 2474.2 2477.6 2487.5 2496.9 4398.9 4408.4 4415.7 4420.7 4453.6 4713.3 4719.5 4776.9 4778.4 4795.7 4402.3 4439.6 4610.7 5037.8 5055.7 5259.5 5278.7 5296.3 5297.2 5315.2 5190.8 5197.3 5199.4 5210.1 5233.4 4814.3 5043.5 5074.3 5095.3 5097.2 3663.9 3691.4 3693.2 3730.6 3737.8 5154.5 5409.4 5419.5 5432.2 5440.5 5092.9 5125.6 5126.6 5144.6 5189.8 5096.8 5111.3 5117.8 5128.1 5174.6 4827.3 5050.9 5060.4 5076.8 5079.3 5024.6 5113.1 5168.4 5183.8 5195.0 5020.1 5029.6 5038.5 5038.6 5088.5 06:24:23 INFO - PROCESS | 24093 | 06:24:23 INFO - PROCESS | 24093 | [#5] yui.html Cycles:180 Average:16258.91 Median:25683.60 stddev:22674.75 (88.3%) stddev-sans-first:22707.76 06:24:23 INFO - PROCESS | 24093 | Values: 570.9 628.0 652.4 661.7 672.6 12422.4 13158.3 13346.1 13387.4 13491.0 11404.5 11443.1 11503.8 12597.2 12640.5 622.7 642.8 783.3 792.4 792.9 760.9 786.2 787.4 787.8 792.8 831.6 835.4 835.9 836.2 836.5 646.2 808.7 827.2 828.2 835.5 612.6 612.8 613.0 613.2 614.2 12553.1 12680.8 12681.4 12694.0 12699.6 12143.3 12683.2 12739.4 12778.3 12983.4 11294.0 11630.8 11717.1 11816.7 12019.7 4174.9 4189.0 4203.9 4216.0 4269.5 57150.4 57448.0 58531.4 59057.1 59224.0 10228.5 10355.4 10430.6 10440.9 10450.6 18966.4 19136.5 19159.8 19190.6 19419.9 6823.9 6840.8 6882.8 6928.4 6960.4 3724.6 3770.8 3799.3 3829.7 3846.8 2674.8 2775.6 2779.8 2781.5 2783.6 480.8 481.8 493.0 497.6 498.2 438.3 454.8 492.7 599.6 602.8 7372.9 7394.7 7610.4 8094.8 8257.2 491.1 497.8 511.0 551.0 590.9 3806.8 3816.4 3821.4 3905.8 3918.2 84442.6 85078.0 86579.0 86814.6 87451.0 74938.0 76005.2 76302.2 79678.2 80344.0 67779.3 68329.3 68661.3 69518.7 70380.0 6855.7 6935.9 6975.8 7096.0 7108.1 30324.8 34421.8 39934.6 40736.2 41248.4 39101.6 50856.2 52889.5 57099.0 59484.7 8246.9 8403.2 8453.7 8674.4 8763.0 10161.4 10232.5 10288.4 10316.3 10451.5 7930.8 11155.6 11597.4 11782.4 11795.0 10973.6 11336.6 11462.1 11933.9 12331.7 10733.3 10970.0 11487.0 11515.9 11603.7 9155.4 9295.8 9470.7 9481.2 9683.3 9458.4 9515.0 9539.6 9725.8 9750.6 06:24:23 INFO - PROCESS | 24093 | -------- Summary: end -------- 06:24:23 INFO - PROCESS | 24093 | 06:24:23 INFO - TEST-INFO | 24093: exit 0 06:24:23 INFO - TEST-OK | dromaeo_css | took 1119771ms 06:24:23 INFO - TEST-START | kraken 06:24:23 INFO - operating with platform_type : linux_ 06:24:23 INFO - Initialising browser for kraken test... 06:24:23 INFO - TEST-INFO | started process 24275 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnrhngY/profile http://localhost:47240/getInfo.html) 06:24:28 INFO - PROCESS | 24275 | __metrics Screen width/height:1600/1200 06:24:28 INFO - PROCESS | 24275 | colorDepth:24 06:24:28 INFO - PROCESS | 24275 | Browser inner width/height: 1024/697 06:24:28 INFO - PROCESS | 24275 | __metrics 06:24:29 INFO - PROCESS | 24275 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:24:30 INFO - TEST-INFO | 24275: exit 0 06:24:30 INFO - Browser initialized. 06:24:30 INFO - Running cycle 1/1 for kraken test... 06:24:30 INFO - TEST-INFO | started process 24354 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnrhngY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:24:42 INFO - PROCESS | 24354 | RSS: Main: 175456256 06:24:42 INFO - PROCESS | 24354 | 06:24:45 INFO - PROCESS | 24354 | Cycle 1(1): loaded http://localhost:47240/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47240/tests/kraken/driver.html?testName=audio-beat-detection) 06:24:46 INFO - PROCESS | 24354 | RSS: Main: 234180608 06:24:46 INFO - PROCESS | 24354 | 06:24:48 INFO - PROCESS | 24354 | Cycle 1(1): loaded http://localhost:47240/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47240/tests/kraken/driver.html?testName=audio-dft) 06:24:49 INFO - PROCESS | 24354 | RSS: Main: 221827072 06:24:49 INFO - PROCESS | 24354 | 06:24:52 INFO - PROCESS | 24354 | Cycle 1(1): loaded http://localhost:47240/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47240/tests/kraken/driver.html?testName=audio-fft) 06:24:53 INFO - PROCESS | 24354 | RSS: Main: 288358400 06:24:53 INFO - PROCESS | 24354 | 06:24:55 INFO - PROCESS | 24354 | Cycle 1(1): loaded http://localhost:47240/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47240/tests/kraken/driver.html?testName=audio-oscillator) 06:24:56 INFO - PROCESS | 24354 | RSS: Main: 198905856 06:24:56 INFO - PROCESS | 24354 | 06:24:58 INFO - PROCESS | 24354 | Cycle 1(1): loaded http://localhost:47240/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47240/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:24:58 INFO - PROCESS | 24354 | RSS: Main: 202997760 06:24:58 INFO - PROCESS | 24354 | 06:25:02 INFO - PROCESS | 24354 | Cycle 1(1): loaded http://localhost:47240/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47240/tests/kraken/driver.html?testName=imaging-darkroom) 06:25:02 INFO - PROCESS | 24354 | RSS: Main: 239136768 06:25:02 INFO - PROCESS | 24354 | 06:25:06 INFO - PROCESS | 24354 | Cycle 1(1): loaded http://localhost:47240/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47240/tests/kraken/driver.html?testName=imaging-desaturate) 06:25:06 INFO - PROCESS | 24354 | RSS: Main: 234778624 06:25:06 INFO - PROCESS | 24354 | 06:25:09 INFO - PROCESS | 24354 | Cycle 1(1): loaded http://localhost:47240/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47240/tests/kraken/driver.html?testName=json-parse-financial) 06:25:10 INFO - PROCESS | 24354 | RSS: Main: 237957120 06:25:10 INFO - PROCESS | 24354 | 06:25:12 INFO - PROCESS | 24354 | Cycle 1(1): loaded http://localhost:47240/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47240/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:25:12 INFO - PROCESS | 24354 | RSS: Main: 225677312 06:25:12 INFO - PROCESS | 24354 | 06:25:14 INFO - PROCESS | 24354 | Cycle 1(1): loaded http://localhost:47240/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47240/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:25:15 INFO - PROCESS | 24354 | RSS: Main: 231002112 06:25:15 INFO - PROCESS | 24354 | 06:25:17 INFO - PROCESS | 24354 | Cycle 1(1): loaded http://localhost:47240/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47240/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:25:18 INFO - PROCESS | 24354 | RSS: Main: 239673344 06:25:18 INFO - PROCESS | 24354 | 06:25:20 INFO - PROCESS | 24354 | Cycle 1(1): loaded http://localhost:47240/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47240/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:25:21 INFO - PROCESS | 24354 | RSS: Main: 242348032 06:25:21 INFO - PROCESS | 24354 | 06:25:24 INFO - PROCESS | 24354 | Cycle 1(1): loaded http://localhost:47240/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47240/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:25:25 INFO - PROCESS | 24354 | RSS: Main: 241307648 06:25:25 INFO - PROCESS | 24354 | 06:25:26 INFO - PROCESS | 24354 | Cycle 1(1): loaded http://localhost:47240/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47240/tests/kraken/driver.html?testName=ai-astar) 06:25:27 INFO - PROCESS | 24354 | RSS: Main: 283901952 06:25:27 INFO - PROCESS | 24354 | 06:25:27 INFO - PROCESS | 24354 | __start_tp_report 06:25:27 INFO - PROCESS | 24354 | _x_x_mozilla_page_load 06:25:27 INFO - PROCESS | 24354 | _x_x_mozilla_page_load_details 06:25:27 INFO - PROCESS | 24354 | |i|pagename|runs| 06:25:27 INFO - PROCESS | 24354 | |0;ai-astar;113;107;113;113;114;115;112;112;112;111 06:25:27 INFO - PROCESS | 24354 | |1;audio-beat-detection;158;131;137;186;131;132;153;130;189;131 06:25:27 INFO - PROCESS | 24354 | |2;audio-dft;160;159;161;161;162;162;161;161;163;161 06:25:27 INFO - PROCESS | 24354 | |3;audio-fft;75;75;76;127;77;78;76;80;97;75 06:25:27 INFO - PROCESS | 24354 | |4;audio-oscillator;85;87;115;90;88;86;113;84;85;129 06:25:27 INFO - PROCESS | 24354 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;119;117 06:25:27 INFO - PROCESS | 24354 | |6;imaging-darkroom;147;147;147;145;146;147;146;146;146;146 06:25:27 INFO - PROCESS | 24354 | |7;imaging-desaturate;95;95;95;95;96;95;96;96;95;95 06:25:27 INFO - PROCESS | 24354 | |8;json-parse-financial;65;65;65;64;65;65;64;64;64;65 06:25:27 INFO - PROCESS | 24354 | |9;json-stringify-tinderbox;65;64;64;64;65;64;65;65;65;66 06:25:27 INFO - PROCESS | 24354 | |10;stanford-crypto-aes;83;95;83;84;85;84;84;85;122;84 06:25:27 INFO - PROCESS | 24354 | |11;stanford-crypto-ccm;130;132;140;128;133;129;142;145;135;140 06:25:27 INFO - PROCESS | 24354 | |12;stanford-crypto-pbkdf2;170;171;171;175;173;176;171;171;169;168 06:25:27 INFO - PROCESS | 24354 | |13;stanford-crypto-sha256-iterative;68;78;67;67;67;66;68;66;67;65 06:25:27 INFO - PROCESS | 24354 | __end_tp_report 06:25:27 INFO - PROCESS | 24354 | __start_cc_report 06:25:27 INFO - PROCESS | 24354 | _x_x_mozilla_cycle_collect,1875 06:25:27 INFO - PROCESS | 24354 | __end_cc_report 06:25:27 INFO - PROCESS | 24354 | __startTimestamp1466429127010__endTimestamp 06:25:27 INFO - PROCESS | 24354 | 06:25:27 INFO - PROCESS | 24354 | ------- Summary: start ------- 06:25:27 INFO - PROCESS | 24354 | Number of tests: 14 06:25:27 INFO - PROCESS | 24354 | 06:25:27 INFO - PROCESS | 24354 | [#0] ai-astar Cycles:10 Average:112.20 Median:113.00 stddev:2.15 (1.9%) stddev-sans-first:2.26 06:25:27 INFO - PROCESS | 24354 | Values: 113.0 107.0 113.0 113.0 114.0 115.0 112.0 112.0 112.0 111.0 06:25:27 INFO - PROCESS | 24354 | 06:25:27 INFO - PROCESS | 24354 | [#1] audio-beat-detection Cycles:10 Average:147.80 Median:145.00 stddev:23.14 (16.0%) stddev-sans-first:24.24 06:25:27 INFO - PROCESS | 24354 | Values: 158.0 131.0 137.0 186.0 131.0 132.0 153.0 130.0 189.0 131.0 06:25:27 INFO - PROCESS | 24354 | 06:25:27 INFO - PROCESS | 24354 | [#2] audio-dft Cycles:10 Average:161.10 Median:161.00 stddev:1.10 (0.7%) stddev-sans-first:1.09 06:25:27 INFO - PROCESS | 24354 | Values: 160.0 159.0 161.0 161.0 162.0 162.0 161.0 161.0 163.0 161.0 06:25:27 INFO - PROCESS | 24354 | 06:25:27 INFO - PROCESS | 24354 | [#3] audio-fft Cycles:10 Average:83.60 Median:76.50 stddev:16.63 (21.7%) stddev-sans-first:17.34 06:25:27 INFO - PROCESS | 24354 | Values: 75.0 75.0 76.0 127.0 77.0 78.0 76.0 80.0 97.0 75.0 06:25:27 INFO - PROCESS | 24354 | 06:25:27 INFO - PROCESS | 24354 | [#4] audio-oscillator Cycles:10 Average:96.20 Median:85.50 stddev:16.35 (19.1%) stddev-sans-first:16.83 06:25:27 INFO - PROCESS | 24354 | Values: 85.0 87.0 115.0 90.0 88.0 86.0 113.0 84.0 85.0 129.0 06:25:27 INFO - PROCESS | 24354 | 06:25:27 INFO - PROCESS | 24354 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.67 06:25:27 INFO - PROCESS | 24354 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 119.0 117.0 06:25:27 INFO - PROCESS | 24354 | 06:25:27 INFO - PROCESS | 24354 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.50 stddev:0.67 (0.5%) stddev-sans-first:0.67 06:25:27 INFO - PROCESS | 24354 | Values: 147.0 147.0 147.0 145.0 146.0 147.0 146.0 146.0 146.0 146.0 06:25:27 INFO - PROCESS | 24354 | 06:25:27 INFO - PROCESS | 24354 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 06:25:27 INFO - PROCESS | 24354 | Values: 95.0 95.0 95.0 95.0 96.0 95.0 96.0 96.0 95.0 95.0 06:25:27 INFO - PROCESS | 24354 | 06:25:27 INFO - PROCESS | 24354 | [#8] json-parse-financial Cycles:10 Average:64.60 Median:65.00 stddev:0.52 (0.8%) stddev-sans-first:0.53 06:25:27 INFO - PROCESS | 24354 | Values: 65.0 65.0 65.0 64.0 65.0 65.0 64.0 64.0 64.0 65.0 06:25:27 INFO - PROCESS | 24354 | 06:25:27 INFO - PROCESS | 24354 | [#9] json-stringify-tinderbox Cycles:10 Average:64.70 Median:65.00 stddev:0.67 (1.0%) stddev-sans-first:0.71 06:25:27 INFO - PROCESS | 24354 | Values: 65.0 64.0 64.0 64.0 65.0 64.0 65.0 65.0 65.0 66.0 06:25:27 INFO - PROCESS | 24354 | 06:25:27 INFO - PROCESS | 24354 | [#10] stanford-crypto-aes Cycles:10 Average:88.90 Median:84.00 stddev:12.15 (14.5%) stddev-sans-first:12.70 06:25:27 INFO - PROCESS | 24354 | Values: 83.0 95.0 83.0 84.0 85.0 84.0 84.0 85.0 122.0 84.0 06:25:27 INFO - PROCESS | 24354 | 06:25:27 INFO - PROCESS | 24354 | [#11] stanford-crypto-ccm Cycles:10 Average:135.40 Median:137.50 stddev:5.97 (4.3%) stddev-sans-first:6.00 06:25:27 INFO - PROCESS | 24354 | Values: 130.0 132.0 140.0 128.0 133.0 129.0 142.0 145.0 135.0 140.0 06:25:27 INFO - PROCESS | 24354 | 06:25:27 INFO - PROCESS | 24354 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.50 Median:171.00 stddev:2.51 (1.5%) stddev-sans-first:2.60 06:25:27 INFO - PROCESS | 24354 | Values: 170.0 171.0 171.0 175.0 173.0 176.0 171.0 171.0 169.0 168.0 06:25:27 INFO - PROCESS | 24354 | 06:25:27 INFO - PROCESS | 24354 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.90 Median:67.00 stddev:3.67 (5.5%) stddev-sans-first:3.89 06:25:27 INFO - PROCESS | 24354 | Values: 68.0 78.0 67.0 67.0 67.0 66.0 68.0 66.0 67.0 65.0 06:25:27 INFO - PROCESS | 24354 | -------- Summary: end -------- 06:25:27 INFO - PROCESS | 24354 | 06:25:28 INFO - TEST-INFO | 24354: exit 0 06:25:28 INFO - TEST-OK | kraken | took 64295ms 06:25:28 INFO - SUITE-END | took 1184s 06:25:28 INFO - Completed test suite (00:19:44) 06:25:28 INFO - javascript benchmark 06:25:28 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2623.147477069953, 2628.6845578530574, 2670.3991601889566, 2679.102500662278, 2693.097812232902, 4575.679702420824, 4623.329617205503, 4666.976665116678, 4708.199606066968, 4765.213739732944, 4597.333386658941, 4610.561996610325, 4689.085628302482, 4722.881927951803, 4728.456227533835, 4086.1827634473075, 4214.494260688714, 4309.612134907858, 4336.0, 4458.576435238647, 4367.213901497729, 4399.03221291317, 4409.492908315537, 4419.558044195587, 4448.065906159711, 4228.9788551057045, 4279.251131052053, 4279.614834664864, 4391.473023237232, 4415.315626077963, 4175.290200665894, 4180.16396720654, 4182.184474027566, 4212.326027835532, 4258.446401967755, 4192.958070419288, 4197.790110494463, 4206.390073439365, 4240.491141063061, 4245.10852720929, 4592.127495775825, 4663.836765713218, 4734.218853889104, 4739.123262196505, 4772.928406073912, 5085.516875896784, 5102.387713474407, 5134.435212126663, 5145.434002259786, 5151.845444636667, 5154.716490593016, 5162.148245539482, 5183.896322073538, 5187.273781670569, 5195.428502864682, 4643.674942754009, 4723.716577005391, 4746.264329029006, 4788.784504697297, 4848.272759086095, 5249.711265880337, 5291.603129765206, 5293.0472514946905, 5293.073712100367, 5293.973530132324, 4904.681195722266, 5077.060743762416, 5090.414602320707, 5091.0, 5091.87270318245, 5001.624878134155, 5045.495450454925, 5051.191809310492, 5062.620303477254, 5125.256837758504, 5006.724630145304, 5016.2224855147515, 5017.498250174954, 5023.8492845214705, 5075.213341932006, 4851.830185943475, 4986.950130498722, 4997.750112494361, 5000.3249561309485, 5005.34930459038, 4151.232022075926, 4194.979025104855, 4213.6839737019845, 4225.704200705921, 4234.301340278819, 3713.313037088147, 3721.4417837324077, 3722.8696995605565, 3745.8127093645207, 3759.436084587334, 4249.575042495726, 4377.409049778303, 4407.294832826732, 4412.84555040572, 4424.756638384855, 5029.874253143627, 5143.5113664201845, 5151.845444636667, 5162.6128040397125, 5164.741762911839, 4420.425344705232, 4421.557844215553, 4442.644588432918, 4452.532484089189, 4468.419105516327, 4453.332000199931, 4501.932471012938, 4583.702059366131, 4594.931076033862, 4624.722516649012, 4823.348847905629, 4834.8791280218275, 4907.55831975124, 4910.631702622246, 4910.8772280693265, 5125.538701516882, 5134.666246693953, 5135.127028405254, 5141.742912854267, 5189.143791274398, 4727.952720472889, 4814.6870453420415, 4847.321375007572, 4866.464688884291, 4907.3620429343955, 4982.62630302736, 5013.122703526796, 5024.045431368028, 5057.115004874206, 5078.4667609900425, 5067.341245638044, 5071.771770270273, 5078.949210507995, 5079.619028572798, 5124.923126153036, 4797.952020479751, 4885.975570122127, 4914.533119353656, 4938.38270216223, 4940.110780059624, 4941.209406494943, 4944.431390390151, 4969.3291405659775, 4971.552560269593, 5012.373453318335, 4809.927851082167, 4855.344528488608, 4902.411710594752, 4941.481144479922, 4943.703377797344, 4850.878728031827, 4893.681910675937, 4965.255211718271, 5042.319286896369, 5043.0, 4822.083804077214, 4836.733979631154, 4839.854804355875, 4892.2661600760175, 4901.9264711028645], "value": 4649.517049848488, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [546.3921046340879, 572.4590262202221, 585.4292065236394, 591.7869566955898, 599.2838557923282, 26165.345866353327, 26667.0, 38388.040298992506, 38970.0, 39307.21385572287, 36928.0, 41416.792916035374, 41423.378649320286, 41570.37644435336, 41581.376279355834, 7843.490173138742, 7989.400794940403, 7994.6002699864775, 7995.360371170293, 8002.119766825645, 7456.291652293024, 10042.648507302209, 10298.794024119514, 10308.896911030906, 10644.733881652943, 10322.380657160556, 10402.583896644124, 10478.423686697228, 10488.475576221197, 10490.898455662122, 10324.277300588961, 10326.328788628714, 10355.06804387605, 10415.791684166274, 10432.32189907661, 10267.691969240936, 10334.586616535329, 10335.379877207317, 10335.483225838678, 10344.275900686955, 38409.807950960065, 38645.42031869496, 38650.0, 38719.8064009681, 38743.225135497414, 3086.2130156810094, 3130.2956834712236, 3148.7481001519823, 3236.385086833494, 3361.1359348624815, 29615.0, 29947.700522994928, 30296.0, 30754.692453075408, 31460.056198314087, 2970.77719171063, 2981.8658160382834, 3001.9249518762203, 3023.3046399328277, 3051.5727798108283, 234755.0, 235324.0, 235735.0, 235750.0, 236242.99999999828, 52768.73615631897, 53039.20441193385, 53041.7347913258, 53104.73447632737, 53114.734426327625, 56179.0, 56253.43746562482, 56259.71870140623, 56270.0, 56398.436015639316, 14087.859121408655, 14431.278436078153, 14437.35031923566, 14438.494652687106, 14445.85554144445, 9119.498427586414, 9564.856527152098, 10612.0, 10780.40707761065, 10782.568697252022, 16220.270087846075, 16830.0, 16839.663206735797, 16908.661826763397, 17052.48842534726, 6020.397960204032, 6099.9390006099375, 6169.84575385619, 6190.535709821781, 6318.4313411793155, 817.4318848400304, 894.2622336572224, 928.8560273157672, 936.9063093690577, 993.0615568288043, 27638.0, 28085.438291234062, 28215.0, 28678.42643147167, 28791.712082879323, 958.5638534466801, 1002.2983911262146, 1036.828923227659, 1055.9683209503573, 1066.7546464313095, 14822.407103715947, 14833.406663733545, 14957.102573845605, 15173.544793656209, 15344.616384590474, 344923.0, 346773.0, 347417.0, 347632.0, 348048.0, 48128.27807582889, 49099.75450122798, 49144.50855491399, 49162.26256606154, 49175.26237106446, 1045.72288343589, 1173.096715529038, 1211.2611307102836, 1215.1797536662893, 1220.2495465288785, 28048.29879253035, 28904.277393065342, 29050.837966481104, 29345.85327073351, 29358.266043349086, 41910.37134442925, 42176.57823421727, 42448.36327455029, 42490.5750942499, 42531.57468425276, 289788.0, 290231.0976890204, 290949.0, 291388.0, 292417.0, 30660.080197594107, 31642.208944776565, 35281.647183527835, 37097.814510927274, 37251.813740931124, 40769.796151020244, 40935.59064409318, 41212.58787412087, 41303.7934810324, 42019.57980420157, 34927.47608785921, 35365.82317088398, 35711.28577428489, 35921.0, 35952.0, 35654.28691426105, 35866.82066589651, 36077.0, 36177.45733813942, 36300.0, 35088.82455587706, 35426.29147417089, 35597.644023559435, 35614.0, 36064.27871442504, 31219.219519511284, 32546.0, 32581.837090814395, 32593.511097333085, 33008.0, 24561.385965350295, 24719.43722922166, 24890.626640600767, 25152.0, 25213.495730085662], "value": 17882.575215618486, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [372.58270736774836, 372.94405839124136, 377.51866370377763, 383.6336298834613, 384.0648022066269, 15657.608559786011, 16887.24007419666, 17726.202320895558, 17741.645167096667, 17894.5526361841, 16237.106959117244, 16607.169641517936, 17403.564910877234, 17445.040522771244, 17470.0, 5027.673201241908, 5179.119549676564, 5187.092258854705, 5218.2172674099, 5224.033553792541, 3752.212035472554, 3904.511936007999, 5692.203091567184, 5999.85000374992, 6005.729742161613, 5978.910316345258, 5994.920914235436, 6039.214902062726, 6052.757889684407, 6060.848478788022, 5842.53259739222, 5969.432903874125, 5988.550858685594, 5996.4902983246475, 5999.340072592011, 3321.485169798661, 3499.562554680665, 3500.859965601373, 3541.4333706606817, 4888.0, 20970.685439718418, 20984.26555070565, 21171.153153873827, 21350.35948921535, 21369.786302136934, 1919.5393105654682, 1953.4823271832975, 2002.0790436399275, 2089.8955052247325, 2423.6849209602815, 12618.621441356774, 13283.86716132836, 13498.865011349859, 13666.453341866314, 13743.312834358341, 1671.9247633856505, 1729.7751292331916, 1731.7056100462826, 1793.2916497983354, 2040.357287454447, 64296.678516607586, 66206.66896665534, 73411.63294183549, 74390.62804685996, 78145.21854781437, 15410.537683869501, 15446.0732356059, 15470.845291547166, 15601.0, 15660.0, 28209.43581128366, 28498.287542811595, 28542.857285713853, 28544.42911141807, 28559.14408559169, 8847.46915185078, 8870.73387798367, 9015.77460563478, 9021.32340074497, 9032.774180645405, 7356.485046046832, 7379.741709040158, 7502.549847009197, 7516.661750221253, 7560.054993125859, 8172.956760809798, 8179.713710020121, 8201.630926608317, 8354.248117669438, 8490.193431623986, 2636.5517861963513, 3199.264169241041, 3312.6521715220038, 3413.4026545354463, 3457.636948120411, 848.6520526584071, 910.01263628962, 918.7749001494676, 960.8846938367441, 975.3465178330393, 16334.673306533803, 16424.946881639797, 16899.324027039027, 17028.318867245172, 17322.0, 866.467122719523, 892.7812685891868, 910.6493999809989, 920.7099763574453, 935.0929598289648, 9342.112499312554, 9383.577739001761, 9722.319437639439, 9740.17208537268, 9893.950530247446, 382596.0, 391022.0, 407800.7659770212, 413031.0, 413573.0, 74300.62849685717, 77488.61255693686, 79772.20227797765, 80018.5999070001, 82869.0, 909.5725009245645, 921.6221349246777, 952.79991201847, 960.2462067277154, 963.1428029054148, 15636.0, 15714.371425143323, 15771.44799931997, 15989.520314390587, 16152.434664786677, 27875.07311732239, 34984.650153498136, 36537.634623654485, 36610.26779464343, 38316.425253621775, 48227.75886120547, 51922.740386297824, 52323.21515177352, 52567.73716131395, 52636.47363526469, 7760.654033741123, 7901.0, 7946.205379462239, 8099.14958929304, 8114.06688230861, 11319.151063670093, 11948.0, 12233.327167005544, 12388.256704597752, 12404.25574465535, 9627.711168664951, 9997.650082247086, 10299.309362691452, 10532.947335263581, 10748.677539673823, 10494.632687855888, 10777.946110269711, 10994.0, 11013.889861101286, 11129.443527823738, 10792.352458852494, 10851.0, 11010.229283950046, 11048.281861678965, 11277.887221128012, 7732.7680169595005, 7805.765827025199, 7921.722739704082, 8064.112947575644, 8134.633941472766, 9445.622175112918, 9866.062724041205, 9888.752781180528, 10064.748381290527, 10479.371237725762], "value": 9022.267388581216, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1253.8056601226801, 1374.8693874081962, 1397.210576024546, 1488.5162322245267, 1676.874234432417, 6544.443722283606, 7557.0, 7717.575533345671, 7797.6491057902385, 8060.677572897077, 7815.101263354716, 7850.332721718646, 7908.3673306135515, 7915.327197188246, 7928.0882698489695, 2188.7482939461925, 2188.879611621356, 2204.2505548113636, 2223.132978138527, 2224.0325458425636, 2138.818200452956, 2180.6292930201826, 2208.8122509586706, 2211.4581927427803, 2212.889355532225, 2142.4322554523064, 2143.967840482394, 2150.0432307623114, 2151.0965394534333, 2194.8024677779, 2107.4309936317186, 2109.472631842047, 2110.0399318310133, 2112.535242246703, 2114.8413868959888, 2053.5482193917314, 2102.4008157675144, 2118.131566057909, 2123.6283650361124, 2125.0755921174336, 7824.37405007598, 7891.171427000198, 7891.368690504746, 7892.329152022085, 7910.129885712567, 4326.199653064194, 4494.595486406207, 4518.977405112986, 4541.069080838421, 4546.590806827368, 2802.8738706758245, 2882.409106133238, 2939.3386488040233, 2957.3641667041475, 2959.689232630564, 887.4719541872576, 889.715291106846, 889.9822003559957, 892.6250974590688, 896.7802888292345, 10406.687799366031, 10475.319104258198, 10488.947555262175, 10513.211509136769, 10521.158307335394, 3886.70849686269, 3968.940465893014, 4025.7383270087353, 4031.637152656275, 4037.9394309085387, 8297.792555186168, 8321.542315172723, 8332.208440198172, 8344.374171937008, 8346.958265208757, 4506.414166158444, 4526.705764125321, 4526.7283962961665, 4535.9773201133785, 4539.795709193094, 3593.8921832345072, 3875.2249550090096, 4214.515330736943, 4285.46431696038, 4300.376445415397, 3385.7968521888765, 3426.057834095594, 3436.261203841186, 3495.07380544156, 3525.8765943191866, 1002.6089824968268, 1010.0555980158575, 1025.5795123999274, 1028.804527139841, 1029.9433531155707, 591.4140938832684, 779.3803925878826, 800.4196957206095, 821.6261600971544, 838.362844238371, 5093.898122037538, 5172.689638621695, 5192.350956130484, 5244.396894357122, 5289.761960711778, 797.6646923968251, 849.5794581682106, 862.4307956748515, 863.1239292118505, 900.5002223765742, 3559.2525569630666, 3579.7673151245085, 3587.2466781975554, 3591.9281614367565, 3598.5142005829402, 9497.477638729937, 9829.066238707312, 9839.80320393588, 9856.408615483095, 9868.21054315653, 9656.37233579815, 9671.081247281498, 9753.0, 9768.560414781352, 9770.902290977141, 7331.596762178025, 7468.365188958891, 7502.812429689301, 7508.737194198176, 7508.774736758015, 4973.577245933991, 5145.819896303611, 5156.071907056766, 5222.399424066281, 5251.028559716465, 8985.101489850962, 9103.408278461879, 9117.817643647222, 9205.401648892801, 9222.0, 8758.255548278214, 9308.0, 9336.346455748304, 9363.953180234055, 9376.249900008119, 5679.062954612608, 6069.757209711562, 6192.380761923771, 6211.720472578654, 6364.331745166691, 7540.8491830164185, 7552.697892084475, 7611.809704757426, 7612.238776122344, 7618.123915749759, 6875.759348422781, 7043.964780176067, 7054.717811287696, 7106.147262328347, 7169.390601798906, 6793.082933803873, 6839.589624622538, 6894.310568943066, 6987.7204911802955, 6998.370146686822, 6393.073004414427, 6551.639659818565, 6567.507436942344, 6575.638339891352, 6585.407313341822, 4600.516945720785, 4688.507706690748, 4745.098431298043, 4761.880952976203, 4819.518048195152, 4851.80592776285, 4881.731504767272, 4888.682235654671, 4907.312976183266, 4921.950780492292], "value": 4089.2854145272436, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [288.8281472523848, 289.6133661561815, 298.1606776922962, 299.55665614889955, 303.8769298434135, 4669.696469729465, 4819.228923372261, 4870.707757534546, 4894.755262236888, 4905.4113506379235, 4680.438347398317, 4815.8796030099265, 4849.296851956464, 4862.2706594010915, 4866.343043689101, 3750.887473375803, 3756.417755247941, 3760.1986520042537, 3773.6415040571237, 3797.468354430382, 3638.6907112895437, 3666.3034023535574, 3779.829907654162, 3794.4308353746883, 3807.2956503047026, 3713.4801127842125, 3745.0824547985644, 3748.156664750423, 3759.6052414496494, 3762.0970966967866, 3747.9625203748024, 3753.39945608704, 3766.736328457009, 3781.130340021783, 3786.6024067472795, 3325.5201435361273, 3326.750493712957, 3333.2166940769143, 3343.866245350183, 3345.866165353383, 4661.906761864778, 4727.574518293336, 4748.667593268473, 4759.619230461555, 4761.547652972962, 4340.52254252032, 4352.194843953847, 4354.238008348526, 4355.7822108894425, 4391.73649581023, 5084.237364395371, 5101.51535604117, 5108.923366149511, 5127.717975511346, 5149.974250128763, 3555.768875023115, 3619.5294611700574, 3640.654137856926, 3662.304162209172, 3668.101315177772, 5278.551323137538, 5313.734313284359, 5314.0169068722025, 5315.867103322409, 5345.759440825133, 3749.49381833449, 3754.2303827715255, 3781.149241420658, 3787.5644300905196, 3792.905177370533, 3497.4753786931656, 3843.6925045996254, 3844.6539811417106, 3848.3650197717625, 3851.9037024074064, 4215.494140703136, 4243.618074373321, 4260.659147268273, 4271.807768650418, 4276.35854621803, 4853.9029219415415, 4970.365706175733, 5054.444011158769, 5093.141003533684, 5141.434442211354, 1248.843894513186, 1265.7721610110084, 1269.5302737987004, 1273.5224290890917, 1274.5156840400773, 803.8264134363777, 815.5962798414822, 827.2472050434076, 835.8643665434872, 838.781916701662, 4019.477467929209, 4081.326656071056, 4083.9387409188885, 4119.773412462343, 4130.483689538808, 4575.9771201143785, 4585.28928016158, 4674.3172457915125, 4685.531446855287, 4709.1994360958715, 4019.191363886263, 4058.6347228748964, 4063.4152680454645, 4091.284025295561, 4121.175764846983, 2336.97663023371, 2474.2329877737957, 2477.603583426643, 2487.502499500107, 2496.9375765606005, 4398.868033958986, 4408.382826404306, 4415.690901636919, 4420.7126536775, 4453.55464453552, 4713.293006049052, 4719.513353293702, 4776.880577985508, 4778.37881075458, 4795.736234507136, 4402.3176407656865, 4439.556044395599, 4610.654200934943, 5037.798488060436, 5055.721935293521, 5259.474052594863, 5278.700811992505, 5296.258523806593, 5297.17893726473, 5315.202719592092, 5190.766415511386, 5197.298364720715, 5199.376074871039, 5210.1142805723875, 5233.371995360581, 4814.325994360863, 5043.5460808527405, 5074.340335756328, 5095.26118712792, 5097.235414687826, 3663.9267214655024, 3691.3540130477595, 3693.1874987502706, 3730.645588669072, 3737.8039027510936, 5154.458781828004, 5409.350877894678, 5419.482544887438, 5432.18517222404, 5440.53755430777, 5092.923606145837, 5125.564327032095, 5126.615503837302, 5144.6398752087, 5189.792408303777, 5096.770645321044, 5111.3355263815465, 5117.769700363418, 5128.128233194782, 5174.586033117266, 4827.348307978378, 5050.898982020265, 5060.443351231435, 5076.847694569169, 5079.288899554139, 5024.593113928106, 5113.079645663816, 5168.431472538093, 5183.844484665466, 5195.025890161714, 5020.146575082318, 5029.572486338702, 5038.496150385079, 5038.647294689483, 5088.465711100429], "value": 3763.0162879440895, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [570.8744076303212, 627.9843003924901, 652.4030512081446, 661.6559389117662, 672.5863593889758, 12422.440990155443, 13158.276294803782, 13346.132501387403, 13387.39756710948, 13491.0, 11404.486798094085, 11443.084553235742, 11503.769924601504, 12597.244165350085, 12640.494380224804, 622.6606499457783, 642.7589653879795, 783.2793829676697, 792.4492477727953, 792.9008873890764, 760.8934749135126, 786.1862971824163, 787.3504358903898, 787.8069872881152, 792.7780221537979, 831.629924683516, 835.4152093534519, 835.8829763833069, 836.1721895323616, 836.4646626159263, 646.240667216024, 808.7007807111347, 827.1769589258696, 828.2380210206594, 835.4987007795335, 612.6446660936646, 612.770211170811, 613.0099888679795, 613.1691557938973, 614.2107392001302, 12553.121281510297, 12680.80978785319, 12681.365931703378, 12694.047946403964, 12699.619011429671, 12143.271403715806, 12683.17559358648, 12739.398765677808, 12778.297193654345, 12983.35083245834, 11294.0, 11630.767384652345, 11717.133440698837, 11816.704582385422, 12019.699507512294, 4174.937375939363, 4188.979055104735, 4203.894902627429, 4216.0, 4269.509006464265, 57150.42849571493, 57448.0, 58531.41468585345, 59057.11414328789, 59224.0, 10228.488575571191, 10355.378677279386, 10430.634927777492, 10440.947795261127, 10450.58917046189, 18966.43100706981, 19136.521586960436, 19159.8084019158, 19190.61618767617, 19419.902900485406, 6823.93176068233, 6840.828979275558, 6882.793516194522, 6928.376446119873, 6960.443164546824, 3724.6275372462537, 3770.7549009314307, 3799.2591444668024, 3829.6936245100883, 3846.769193848378, 2674.7860171186258, 2775.6252905857855, 2779.7915156363356, 2781.485425196345, 2783.6381270434713, 480.8052738640856, 481.8482178113883, 493.043495618499, 497.5546885537424, 498.16805934090155, 438.3030980740574, 454.78852333664344, 492.74869816393897, 599.6462087368474, 602.8131279303342, 7372.889406658905, 7394.704211831574, 7610.39116870649, 8094.757157285291, 8257.174282571816, 491.071874157842, 497.7909278103205, 510.9693418394908, 550.9972450137724, 590.858139245236, 3806.752561083576, 3816.44661524083, 3821.4267859820693, 3905.7851818150275, 3918.1967696622123, 84442.57778711067, 85078.0, 86579.0, 86814.56592716996, 87451.0, 74938.0, 76005.23994759981, 76302.23697762951, 79678.20321796824, 80344.0, 67779.3222067773, 68329.3167068323, 68661.31338686649, 69518.65240673764, 70380.0, 6855.725770969106, 6935.861282774417, 6975.837490377796, 7095.9645201773665, 7108.07595012645, 30324.84837575798, 34421.82789086139, 39934.60065399309, 40736.1852762949, 41248.38127428151, 39101.6089839098, 50856.237156441945, 52889.47110528845, 57099.0, 59484.70257648857, 8246.876296855671, 8403.159684031549, 8453.746387608382, 8674.392792504465, 8762.956185219033, 10161.441120738431, 10232.48837558134, 10288.382697038202, 10316.329438586468, 10451.477426128511, 7930.762077137695, 11155.609553665583, 11597.362145081765, 11782.351970641354, 11795.0, 10973.615923442641, 11336.6032188873, 11462.14033947474, 11933.880661193623, 12331.69170770738, 10733.302335348177, 10970.0, 11487.0, 11515.884841151481, 11603.6518904433, 9155.404898681565, 9295.767605809639, 9470.715878523655, 9481.241500679791, 9683.273754468302, 9458.43249405038, 9515.0, 9539.57071931751, 9725.825118729308, 9750.609975600897], "value": 6242.54978111268, "unit": "score"}], "name": "dromaeo_css", "value": 6450.975110245155, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 107.0, 113.0, 113.0, 114.0, 115.0, 112.0, 112.0, 112.0, 111.0], "value": 112.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 131.0, 137.0, 186.0, 131.0, 132.0, 153.0, 130.0, 189.0, 131.0], "value": 147.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 159.0, 161.0, 161.0, 162.0, 162.0, 161.0, 161.0, 163.0, 161.0], "value": 161.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 127.0, 77.0, 78.0, 76.0, 80.0, 97.0, 75.0], "value": 83.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 87.0, 115.0, 90.0, 88.0, 86.0, 113.0, 84.0, 85.0, 129.0], "value": 96.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 119.0, 117.0], "value": 117.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 145.0, 146.0, 147.0, 146.0, 146.0, 146.0, 146.0], "value": 146.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 96.0, 96.0, 95.0, 95.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 64.0, 65.0, 65.0, 64.0, 64.0, 64.0, 65.0], "value": 64.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 64.0, 64.0, 65.0, 64.0, 65.0, 65.0, 65.0, 66.0], "value": 64.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 95.0, 83.0, 84.0, 85.0, 84.0, 84.0, 85.0, 122.0, 84.0], "value": 88.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 132.0, 140.0, 128.0, 133.0, 129.0, 142.0, 145.0, 135.0, 140.0], "value": 135.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 171.0, 171.0, 175.0, 173.0, 176.0, 171.0, 171.0, 169.0, 168.0], "value": 171.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 78.0, 67.0, 67.0, 67.0, 66.0, 68.0, 66.0, 67.0, 65.0], "value": 67.9, "unit": "score"}], "name": "kraken", "value": 1552.7000000000003, "alertThreshold": 2.0}]} 06:25:28 INFO - Return code: 0 06:25:28 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:25:28 INFO - # TBPL SUCCESS # 06:25:28 INFO - Running post-action listener: _resource_record_post_action 06:25:28 INFO - ##### 06:25:28 INFO - ##### Finished run-tests step (success) 06:25:28 INFO - ##### 06:25:28 INFO - Running post-run listener: _resource_record_post_run 06:25:28 INFO - Total resource usage - Wall time: 1201s; CPU: 13.0%; Read bytes: 4096; Write bytes: 550727680; Read time: 8; Write time: 415964 06:25:28 INFO - TinderboxPrint: CPU usage
13.2% 06:25:28 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 06:25:28 INFO - TinderboxPrint: I/O write bytes / time
550,727,680 / 415,964 06:25:28 INFO - TinderboxPrint: CPU idle
8,319.3 (86.8%) 06:25:28 INFO - TinderboxPrint: CPU user
1,216.5 (12.7%) 06:25:28 INFO - TinderboxPrint: Swap in / out
0 / 0 06:25:28 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 215556096; Read time: 0; Write time: 206548 06:25:28 INFO - run-tests - Wall time: 1185s; CPU: 13.0%; Read bytes: 4096; Write bytes: 288043008; Read time: 8; Write time: 181648 06:25:28 INFO - Running post-run listener: _upload_blobber_files 06:25:28 INFO - Blob upload gear active. 06:25:28 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:25:28 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 06:25:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:25:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:25:29 INFO - (blobuploader) - INFO - Open directory for files ... 06:25:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:25:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:25:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:25:33 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:25:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:25:33 INFO - (blobuploader) - INFO - Done attempting. 06:25:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:25:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:25:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:25:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:25:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:25:33 INFO - (blobuploader) - INFO - Done attempting. 06:25:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:25:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:25:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:25:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:25:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:25:36 INFO - (blobuploader) - INFO - Done attempting. 06:25:36 INFO - (blobuploader) - INFO - Iteration through files over. 06:25:36 INFO - Return code: 0 06:25:36 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:25:36 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:25:36 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/88602c9bcc58b32f819ca2329fd92b5918534fb8df1a73d3aecbb586ce205f0774f32e05cab9ae2fbc574995eb5367d2d95d182568c6717a7e9049b9c6c4d7d3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f84925881b99903c7258b2a4552956faaa32ba6dee3e6c604d30eb13bd6d43deef01bb2fdf5f75edbd3cb4da2c066d4fec43a374d88dadd7ea7f1e447d077481", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/01d7a20dcb9148ceeec3f808cfe14f73c6cde8ea94c903b430ca453512e20a9ab84b2bbc1e0d8c03a45cab8a5f4fc8fa24aa5aa521e2862313480512360fbf38"} 06:25:36 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:25:36 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:25:36 INFO - Contents: 06:25:36 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/88602c9bcc58b32f819ca2329fd92b5918534fb8df1a73d3aecbb586ce205f0774f32e05cab9ae2fbc574995eb5367d2d95d182568c6717a7e9049b9c6c4d7d3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f84925881b99903c7258b2a4552956faaa32ba6dee3e6c604d30eb13bd6d43deef01bb2fdf5f75edbd3cb4da2c066d4fec43a374d88dadd7ea7f1e447d077481", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/01d7a20dcb9148ceeec3f808cfe14f73c6cde8ea94c903b430ca453512e20a9ab84b2bbc1e0d8c03a45cab8a5f4fc8fa24aa5aa521e2862313480512360fbf38"} 06:25:36 INFO - Running post-run listener: copy_logs_to_upload_dir 06:25:36 INFO - Copying logs to upload dir... 06:25:36 INFO - mkdir: /builds/slave/test/build/upload/logs 06:25:36 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1245.735901 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-06-20 06:25:35.916632) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-20 06:25:35.920055) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=e31afd3c0f0de4e86ebe4d94000001b5-1466427888.291101-1501507299 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/88602c9bcc58b32f819ca2329fd92b5918534fb8df1a73d3aecbb586ce205f0774f32e05cab9ae2fbc574995eb5367d2d95d182568c6717a7e9049b9c6c4d7d3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f84925881b99903c7258b2a4552956faaa32ba6dee3e6c604d30eb13bd6d43deef01bb2fdf5f75edbd3cb4da2c066d4fec43a374d88dadd7ea7f1e447d077481", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/01d7a20dcb9148ceeec3f808cfe14f73c6cde8ea94c903b430ca453512e20a9ab84b2bbc1e0d8c03a45cab8a5f4fc8fa24aa5aa521e2862313480512360fbf38"} build_url:https://queue.taskcluster.net/v1/task/Gy7SPqtARWSrgBLlWNGeDg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011373 build_url: 'https://queue.taskcluster.net/v1/task/Gy7SPqtARWSrgBLlWNGeDg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/88602c9bcc58b32f819ca2329fd92b5918534fb8df1a73d3aecbb586ce205f0774f32e05cab9ae2fbc574995eb5367d2d95d182568c6717a7e9049b9c6c4d7d3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f84925881b99903c7258b2a4552956faaa32ba6dee3e6c604d30eb13bd6d43deef01bb2fdf5f75edbd3cb4da2c066d4fec43a374d88dadd7ea7f1e447d077481", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/01d7a20dcb9148ceeec3f808cfe14f73c6cde8ea94c903b430ca453512e20a9ab84b2bbc1e0d8c03a45cab8a5f4fc8fa24aa5aa521e2862313480512360fbf38"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-20 06:25:35.946150) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-20 06:25:35.946521) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=e31afd3c0f0de4e86ebe4d94000001b5-1466427888.291101-1501507299 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004456 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-20 06:25:36.031349) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-20 06:25:36.031791) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-20 06:25:36.032134) ========= ========= Total master_lag: 0.18 =========