builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-057 starttime: 1461797673.18 results: success (0) buildid: 20160427133047 builduid: d1d8ac3037e742f98c462d5cfa123c1a revision: 119f55446e975341b3d09cd4036dc39a3b59ec82 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-27 15:54:33.177935) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-27 15:54:33.178407) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-27 15:54:33.178752) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-27 15:54:33.231422) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 15:54:33.232035) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1461797247.23138-1945067221 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-27 15:54:33-- 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% 223M=0s 2016-04-27 15:54:33 (223 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.130471 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 15:54:33.380209) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 15:54:33.380532) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1461797247.23138-1945067221 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014772 ========= master_lag: 0.07 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 15:54:33.466223) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 15:54:33.466723) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 119f55446e975341b3d09cd4036dc39a3b59ec82 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 119f55446e975341b3d09cd4036dc39a3b59ec82 --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=934fc3100db09dcb9af4d4b6000001ab-1461797247.23138-1945067221 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-27 15:54:33,564 truncating revision to first 12 chars 2016-04-27 15:54:33,564 Setting DEBUG logging. 2016-04-27 15:54:33,564 attempt 1/10 2016-04-27 15:54:33,564 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/119f55446e97?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-27 15:54:33,817 unpacking tar archive at: mozilla-inbound-119f55446e97/testing/mozharness/ program finished with exit code 0 elapsedTime=0.533309 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 15:54:34.016923) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-27 15:54:34.017495) ========= script_repo_revision: 119f55446e975341b3d09cd4036dc39a3b59ec82 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-27 15:54:34.018211) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-27 15:54:34.018721) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-27 15:54:34.062809) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 26 mins, 40 secs) (at 2016-04-27 15:54:34.063239) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=934fc3100db09dcb9af4d4b6000001ab-1461797247.23138-1945067221 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:54:34 INFO - MultiFileLogger online at 20160427 15:54:34 in /builds/slave/test 15:54:34 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 15:54:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:54:34 INFO - {'append_to_log': False, 15:54:34 INFO - 'base_work_dir': '/builds/slave/test', 15:54:34 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 15:54:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:54:34 INFO - 'branch': 'Mozilla-Inbound', 15:54:34 INFO - 'buildbot_json_path': 'buildprops.json', 15:54:34 INFO - 'config_files': ('talos/linux_config.py',), 15:54:34 INFO - 'default_actions': ('clobber', 15:54:34 INFO - 'read-buildbot-config', 15:54:34 INFO - 'download-and-extract', 15:54:34 INFO - 'populate-webroot', 15:54:34 INFO - 'create-virtualenv', 15:54:34 INFO - 'install', 15:54:34 INFO - 'run-tests'), 15:54:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:54:34 INFO - 'download_minidump_stackwalk': True, 15:54:34 INFO - 'download_symbols': 'ondemand', 15:54:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:54:34 INFO - 'tooltool.py': '/tools/tooltool.py', 15:54:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:54:34 INFO - '/tools/misc-python/virtualenv.py')}, 15:54:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:54:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:54:34 INFO - 'installer_path': 'installer.exe', 15:54:34 INFO - 'log_level': 'info', 15:54:34 INFO - 'log_name': 'talos', 15:54:34 INFO - 'log_to_console': True, 15:54:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:54:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:54:34 INFO - 'opt_config_files': (), 15:54:34 INFO - 'pip_index': False, 15:54:34 INFO - 'sps_profile': False, 15:54:34 INFO - 'sps_profile_interval': 0, 15:54:34 INFO - 'suite': 'dromaeojs-e10s', 15:54:34 INFO - 'system_bits': '32', 15:54:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:54:34 INFO - 'title': 'talos-linux64-ix-057', 15:54:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:54:34 INFO - 'use_talos_json': True, 15:54:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:54:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:54:34 INFO - 'work_dir': 'build'} 15:54:34 INFO - ##### 15:54:34 INFO - ##### Running clobber step. 15:54:34 INFO - ##### 15:54:34 INFO - Running pre-action listener: _resource_record_pre_action 15:54:34 INFO - Running main action method: clobber 15:54:34 INFO - rmtree: /builds/slave/test/build 15:54:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:54:34 INFO - Running post-action listener: _resource_record_post_action 15:54:34 INFO - ##### 15:54:34 INFO - ##### Running read-buildbot-config step. 15:54:34 INFO - ##### 15:54:34 INFO - Running pre-action listener: _resource_record_pre_action 15:54:34 INFO - Running main action method: read_buildbot_config 15:54:34 INFO - Using buildbot properties: 15:54:34 INFO - { 15:54:34 INFO - "project": "", 15:54:34 INFO - "product": "firefox", 15:54:34 INFO - "script_repo_revision": "production", 15:54:34 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 15:54:34 INFO - "repository": "", 15:54:34 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 15:54:34 INFO - "buildid": "20160427133047", 15:54:34 INFO - "pgo_build": "True", 15:54:34 INFO - "basedir": "/builds/slave/test", 15:54:34 INFO - "buildnumber": 581, 15:54:34 INFO - "slavename": "talos-linux64-ix-057", 15:54:34 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 15:54:34 INFO - "platform": "ubuntu64_hw", 15:54:34 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 15:54:34 INFO - "branch": "mozilla-inbound", 15:54:34 INFO - "repo_path": "integration/mozilla-inbound", 15:54:34 INFO - "revision": "119f55446e975341b3d09cd4036dc39a3b59ec82", 15:54:34 INFO - "stage_platform": "linux64-pgo", 15:54:34 INFO - "builduid": "d1d8ac3037e742f98c462d5cfa123c1a", 15:54:34 INFO - "slavebuilddir": "test" 15:54:34 INFO - } 15:54:34 INFO - Found installer url https://queue.taskcluster.net/v1/task/IhU5KjaCR_SW_Bgi5qJ3wA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 15:54:34 INFO - Running post-action listener: _resource_record_post_action 15:54:34 INFO - ##### 15:54:34 INFO - ##### Running download-and-extract step. 15:54:34 INFO - ##### 15:54:34 INFO - Running pre-action listener: _resource_record_pre_action 15:54:34 INFO - Running main action method: download_and_extract 15:54:34 INFO - mkdir: /builds/slave/test/build/tests 15:54:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:54:34 INFO - https://queue.taskcluster.net/v1/task/IhU5KjaCR_SW_Bgi5qJ3wA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 15:54:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IhU5KjaCR_SW_Bgi5qJ3wA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 15:54:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IhU5KjaCR_SW_Bgi5qJ3wA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 15:54:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IhU5KjaCR_SW_Bgi5qJ3wA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 15:54:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IhU5KjaCR_SW_Bgi5qJ3wA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 15:54:40 INFO - Downloaded 1361 bytes. 15:54:40 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 15:54:40 INFO - Using the following test package requirements: 15:54:40 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 15:54:40 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 15:54:40 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 15:54:40 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 15:54:40 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 15:54:40 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 15:54:40 INFO - u'jsshell-linux-x86_64.zip'], 15:54:40 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 15:54:40 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 15:54:40 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 15:54:40 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 15:54:40 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 15:54:40 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 15:54:40 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 15:54:40 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 15:54:40 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 15:54:40 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 15:54:40 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 15:54:40 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:54:40 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')]} 15:54:40 INFO - https://queue.taskcluster.net/v1/task/IhU5KjaCR_SW_Bgi5qJ3wA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:54:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IhU5KjaCR_SW_Bgi5qJ3wA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 15:54:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IhU5KjaCR_SW_Bgi5qJ3wA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 15:54:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IhU5KjaCR_SW_Bgi5qJ3wA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 15:54:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IhU5KjaCR_SW_Bgi5qJ3wA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:54:42 INFO - Downloaded 23866939 bytes. 15:54:42 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:54:42 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 15:54:44 INFO - Return code: 0 15:54:44 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 15:54:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:54:44 INFO - https://queue.taskcluster.net/v1/task/IhU5KjaCR_SW_Bgi5qJ3wA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:54:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IhU5KjaCR_SW_Bgi5qJ3wA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 15:54:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IhU5KjaCR_SW_Bgi5qJ3wA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 15:54:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IhU5KjaCR_SW_Bgi5qJ3wA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 15:54:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IhU5KjaCR_SW_Bgi5qJ3wA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:56:01 INFO - Downloaded 23866939 bytes. 15:56:01 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:56:01 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 15:56:02 INFO - Return code: 0 15:56:02 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')]} 15:56:02 INFO - https://queue.taskcluster.net/v1/task/IhU5KjaCR_SW_Bgi5qJ3wA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 15:56:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IhU5KjaCR_SW_Bgi5qJ3wA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 15:56:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IhU5KjaCR_SW_Bgi5qJ3wA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 15:56:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IhU5KjaCR_SW_Bgi5qJ3wA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 15:56:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IhU5KjaCR_SW_Bgi5qJ3wA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 16:00:50 INFO - Downloaded 10840145 bytes. 16:00:50 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:00:50 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 16:00:50 INFO - Return code: 0 16:00:50 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')]} 16:00:50 INFO - https://queue.taskcluster.net/v1/task/IhU5KjaCR_SW_Bgi5qJ3wA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 16:00:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IhU5KjaCR_SW_Bgi5qJ3wA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 16:00:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IhU5KjaCR_SW_Bgi5qJ3wA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 16:00:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IhU5KjaCR_SW_Bgi5qJ3wA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 16:00:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IhU5KjaCR_SW_Bgi5qJ3wA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 16:00:57 INFO - Downloaded 58382849 bytes. 16:00:57 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/IhU5KjaCR_SW_Bgi5qJ3wA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 16:00:57 INFO - mkdir: /builds/slave/test/properties 16:00:57 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:00:57 INFO - Writing to file /builds/slave/test/properties/build_url 16:00:57 INFO - Contents: 16:00:57 INFO - build_url:https://queue.taskcluster.net/v1/task/IhU5KjaCR_SW_Bgi5qJ3wA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 16:00:58 INFO - Running post-action listener: _resource_record_post_action 16:00:58 INFO - Running post-action listener: set_extra_try_arguments 16:00:58 INFO - ##### 16:00:58 INFO - ##### Running populate-webroot step. 16:00:58 INFO - ##### 16:00:58 INFO - Running pre-action listener: _resource_record_pre_action 16:00:58 INFO - Running main action method: populate_webroot 16:00:58 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:00:58 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:00:58 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:00:58 INFO - '--tppagecycles', 16:00:58 INFO - '7'], 16:00:58 INFO - 'tests': ['tsvgm']}}, 16:00:58 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:00:58 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:00:58 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:00:58 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:00:58 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:00:58 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:00:58 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:00:58 INFO - 'talos_options': ['--disable-e10s'], 16:00:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:00:58 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:00:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:00:58 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:00:58 INFO - 'talos_options': ['--disable-e10s'], 16:00:58 INFO - 'tests': ['damp', 'tps']}, 16:00:58 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:00:58 INFO - 'tests': ['damp', 'tps']}, 16:00:58 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:00:58 INFO - 'tests': ['dromaeo_dom']}, 16:00:58 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:00:58 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:00:58 INFO - 'tests': ['a11yr', 16:00:58 INFO - 'ts_paint', 16:00:58 INFO - 'tpaint', 16:00:58 INFO - 'sessionrestore', 16:00:58 INFO - 'sessionrestore_no_auto_restore', 16:00:58 INFO - 'tabpaint']}, 16:00:58 INFO - 'other-e10s': {'tests': ['a11yr', 16:00:58 INFO - 'ts_paint', 16:00:58 INFO - 'tpaint', 16:00:58 INFO - 'sessionrestore', 16:00:58 INFO - 'sessionrestore_no_auto_restore', 16:00:58 INFO - 'tabpaint']}, 16:00:58 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:00:58 INFO - 'ts_paint', 16:00:58 INFO - 'tpaint', 16:00:58 INFO - 'sessionrestore', 16:00:58 INFO - 'sessionrestore_no_auto_restore', 16:00:58 INFO - 'tabpaint']}, 16:00:58 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:00:58 INFO - 'ts_paint', 16:00:58 INFO - 'tpaint', 16:00:58 INFO - 'sessionrestore', 16:00:58 INFO - 'sessionrestore_no_auto_restore', 16:00:58 INFO - 'tabpaint']}, 16:00:58 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:00:58 INFO - 'tests': ['a11yr', 16:00:58 INFO - 'ts_paint', 16:00:58 INFO - 'tpaint', 16:00:58 INFO - 'sessionrestore', 16:00:58 INFO - 'sessionrestore_no_auto_restore', 16:00:58 INFO - 'tabpaint']}, 16:00:58 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:00:58 INFO - 'tests': ['a11yr', 16:00:58 INFO - 'ts_paint', 16:00:58 INFO - 'tpaint', 16:00:58 INFO - 'sessionrestore', 16:00:58 INFO - 'sessionrestore_no_auto_restore', 16:00:58 INFO - 'tabpaint']}, 16:00:58 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:00:58 INFO - 'tests': ['tsvgx', 16:00:58 INFO - 'tsvgr_opacity', 16:00:58 INFO - 'tart', 16:00:58 INFO - 'tscrollx', 16:00:58 INFO - 'cart']}, 16:00:58 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:00:58 INFO - 'tsvgr_opacity', 16:00:58 INFO - 'tart', 16:00:58 INFO - 'tscrollx', 16:00:58 INFO - 'cart']}, 16:00:58 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:00:58 INFO - 'talos_options': ['--disable-e10s'], 16:00:58 INFO - 'tests': ['tp5o']}, 16:00:58 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:00:58 INFO - 'tests': ['tp5o']}, 16:00:58 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:00:58 INFO - 'talos_options': ['--disable-e10s', 16:00:58 INFO - '--xperf_path', 16:00:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:00:58 INFO - 'tests': ['tp5n']}, 16:00:58 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:00:58 INFO - 'talos_options': ['--xperf_path', 16:00:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:00:58 INFO - 'tests': ['tp5n']}}, 16:00:58 INFO - 'talos.zip': {'path': '', 16:00:58 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:00:58 INFO - Running post-action listener: _resource_record_post_action 16:00:58 INFO - ##### 16:00:58 INFO - ##### Running create-virtualenv step. 16:00:58 INFO - ##### 16:00:58 INFO - Running pre-action listener: _resource_record_pre_action 16:00:58 INFO - Running main action method: create_virtualenv 16:00:58 INFO - Creating virtualenv /builds/slave/test/build/venv 16:00:58 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 16:00:58 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:00:58 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:00:58 INFO - Using real prefix '/usr' 16:00:58 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:00:58 INFO - Installing distribute.............................................................................................................................................................................................done. 16:01:00 INFO - Installing pip.................done. 16:01:00 INFO - Return code: 0 16:01:00 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:01:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:01:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:01:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:01:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:01:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:01:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:01:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd74bcc2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ce05a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d6f410>, '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 0x1d70310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d707a0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1461797247.23138-1945067221', '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 16:01:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 16:01:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 16:01:00 INFO - Using env: {'DISPLAY': ':0', 16:01:00 INFO - 'HOME': '/home/cltbld', 16:01:00 INFO - 'LANG': 'en_US.UTF-8', 16:01:00 INFO - 'LANGUAGE': 'en_US:en', 16:01:00 INFO - 'LOGNAME': 'cltbld', 16:01:00 INFO - 'MAIL': '/var/mail/cltbld', 16:01:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:01:00 INFO - 'MOZ_NO_REMOTE': '1', 16:01:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:01:00 INFO - 'NO_EM_RESTART': '1', 16:01:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:01:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:01:00 INFO - 'PWD': '/builds/slave/test', 16:01:00 INFO - 'SHELL': '/bin/bash', 16:01:00 INFO - 'SHLVL': '1', 16:01:00 INFO - 'TERM': 'linux', 16:01:00 INFO - 'TMOUT': '86400', 16:01:00 INFO - 'USER': 'cltbld', 16:01:00 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1461797247.23138-1945067221', 16:01:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:01:00 INFO - '_': '/tools/buildbot/bin/python'} 16:01:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:01:01 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 16:01:01 INFO - Cleaning up... 16:01:01 INFO - Return code: 0 16:01:01 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 16:01:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:01:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:01:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:01:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:01:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:01:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:01:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd74bcc2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ce05a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d6f410>, '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 0x1d70310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d707a0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1461797247.23138-1945067221', '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 16:01:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 16:01:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 16:01:01 INFO - Using env: {'DISPLAY': ':0', 16:01:01 INFO - 'HOME': '/home/cltbld', 16:01:01 INFO - 'LANG': 'en_US.UTF-8', 16:01:01 INFO - 'LANGUAGE': 'en_US:en', 16:01:01 INFO - 'LOGNAME': 'cltbld', 16:01:01 INFO - 'MAIL': '/var/mail/cltbld', 16:01:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:01:01 INFO - 'MOZ_NO_REMOTE': '1', 16:01:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:01:01 INFO - 'NO_EM_RESTART': '1', 16:01:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:01:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:01:01 INFO - 'PWD': '/builds/slave/test', 16:01:01 INFO - 'SHELL': '/bin/bash', 16:01:01 INFO - 'SHLVL': '1', 16:01:01 INFO - 'TERM': 'linux', 16:01:01 INFO - 'TMOUT': '86400', 16:01:01 INFO - 'USER': 'cltbld', 16:01:01 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1461797247.23138-1945067221', 16:01:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:01:01 INFO - '_': '/tools/buildbot/bin/python'} 16:01:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:01:01 INFO - Downloading/unpacking psutil>=0.7.1 16:01:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:01:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:01:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:01:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:01:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:01:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:01:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:01:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:01:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:01:03 INFO - Installing collected packages: psutil 16:01:03 INFO - Running setup.py install for psutil 16:01:03 INFO - building 'psutil._psutil_linux' extension 16:01:03 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 16:01:03 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 16:01:03 INFO - building 'psutil._psutil_posix' extension 16:01:03 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 16:01:03 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 16:01:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:01:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:01:03 INFO - Successfully installed psutil 16:01:03 INFO - Cleaning up... 16:01:03 INFO - Return code: 0 16:01:03 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 16:01: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')]} 16:01:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:01:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:01: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')]} 16:01:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:01:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:01: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', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd74bcc2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ce05a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d6f410>, '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 0x1d70310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d707a0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1461797247.23138-1945067221', '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 16:01: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 16:01: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 mozsystemmonitor==0.0.0 16:01:03 INFO - Using env: {'DISPLAY': ':0', 16:01:03 INFO - 'HOME': '/home/cltbld', 16:01:03 INFO - 'LANG': 'en_US.UTF-8', 16:01:03 INFO - 'LANGUAGE': 'en_US:en', 16:01:03 INFO - 'LOGNAME': 'cltbld', 16:01:03 INFO - 'MAIL': '/var/mail/cltbld', 16:01:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:01:03 INFO - 'MOZ_NO_REMOTE': '1', 16:01:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:01:03 INFO - 'NO_EM_RESTART': '1', 16:01:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:01:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:01:03 INFO - 'PWD': '/builds/slave/test', 16:01:03 INFO - 'SHELL': '/bin/bash', 16:01:03 INFO - 'SHLVL': '1', 16:01:03 INFO - 'TERM': 'linux', 16:01:03 INFO - 'TMOUT': '86400', 16:01:03 INFO - 'USER': 'cltbld', 16:01:03 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1461797247.23138-1945067221', 16:01:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:01:03 INFO - '_': '/tools/buildbot/bin/python'} 16:01:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:01:04 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 16:01: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 16:01: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 16:01: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 16:01: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 16:01: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 16:01: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 16:01:05 INFO - Downloading mozsystemmonitor-0.0.tar.gz 16:01:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:01:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 16:01:06 INFO - Installing collected packages: mozsystemmonitor 16:01:06 INFO - Running setup.py install for mozsystemmonitor 16:01:06 INFO - Successfully installed mozsystemmonitor 16:01:06 INFO - Cleaning up... 16:01:06 INFO - Return code: 0 16:01:06 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:01: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')]} 16:01:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:01:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:01: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')]} 16:01:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:01:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:01: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', '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 0x7fd74bcc2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ce05a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d6f410>, '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 0x1d70310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d707a0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1461797247.23138-1945067221', '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 16:01: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 16:01: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 blobuploader==1.2.4 16:01:06 INFO - Using env: {'DISPLAY': ':0', 16:01:06 INFO - 'HOME': '/home/cltbld', 16:01:06 INFO - 'LANG': 'en_US.UTF-8', 16:01:06 INFO - 'LANGUAGE': 'en_US:en', 16:01:06 INFO - 'LOGNAME': 'cltbld', 16:01:06 INFO - 'MAIL': '/var/mail/cltbld', 16:01:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:01:06 INFO - 'MOZ_NO_REMOTE': '1', 16:01:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:01:06 INFO - 'NO_EM_RESTART': '1', 16:01:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:01:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:01:06 INFO - 'PWD': '/builds/slave/test', 16:01:06 INFO - 'SHELL': '/bin/bash', 16:01:06 INFO - 'SHLVL': '1', 16:01:06 INFO - 'TERM': 'linux', 16:01:06 INFO - 'TMOUT': '86400', 16:01:06 INFO - 'USER': 'cltbld', 16:01:06 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1461797247.23138-1945067221', 16:01:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:01:06 INFO - '_': '/tools/buildbot/bin/python'} 16:01:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:01:06 INFO - Downloading/unpacking blobuploader==1.2.4 16:01:06 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 16:01:06 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 16:01:06 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 16:01:06 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 16:01:06 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 16:01:06 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 16:01:08 INFO - Downloading blobuploader-1.2.4.tar.gz 16:01:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:01:08 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:01:08 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 16:01:08 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 16:01:08 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 16:01:08 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 16:01:08 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 16:01:08 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 16:01:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:01:08 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:01:08 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 16:01:08 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 16:01:08 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 16:01:08 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 16:01:08 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 16:01:08 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 16:01:08 INFO - Downloading docopt-0.6.1.tar.gz 16:01:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:01:08 INFO - Installing collected packages: blobuploader, requests, docopt 16:01:08 INFO - Running setup.py install for blobuploader 16:01:09 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:01:09 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:01:09 INFO - Running setup.py install for requests 16:01:09 INFO - Running setup.py install for docopt 16:01:09 INFO - Successfully installed blobuploader requests docopt 16:01:09 INFO - Cleaning up... 16:01:09 INFO - Return code: 0 16:01:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:01: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')]} 16:01:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:01:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:01: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')]} 16:01:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:01:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:01:09 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 0x7fd74bcc2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ce05a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d6f410>, '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 0x1d70310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d707a0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1461797247.23138-1945067221', '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 16:01:09 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 16:01:09 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 16:01:09 INFO - Using env: {'DISPLAY': ':0', 16:01:09 INFO - 'HOME': '/home/cltbld', 16:01:09 INFO - 'LANG': 'en_US.UTF-8', 16:01:09 INFO - 'LANGUAGE': 'en_US:en', 16:01:09 INFO - 'LOGNAME': 'cltbld', 16:01:09 INFO - 'MAIL': '/var/mail/cltbld', 16:01:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:01:09 INFO - 'MOZ_NO_REMOTE': '1', 16:01:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:01:09 INFO - 'NO_EM_RESTART': '1', 16:01:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:01:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:01:09 INFO - 'PWD': '/builds/slave/test', 16:01:09 INFO - 'SHELL': '/bin/bash', 16:01:09 INFO - 'SHLVL': '1', 16:01:09 INFO - 'TERM': 'linux', 16:01:09 INFO - 'TMOUT': '86400', 16:01:09 INFO - 'USER': 'cltbld', 16:01:09 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1461797247.23138-1945067221', 16:01:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:01:09 INFO - '_': '/tools/buildbot/bin/python'} 16:01:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:01:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:01:09 INFO - Running setup.py (path:/tmp/pip-c1NJDA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:01:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:01:09 INFO - Running setup.py (path:/tmp/pip-yZ6y2d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:01:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:01:09 INFO - Running setup.py (path:/tmp/pip-jh1pMi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:01:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:01:10 INFO - Running setup.py (path:/tmp/pip-uUBREH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:01:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:01:10 INFO - Running setup.py (path:/tmp/pip-zqVQsI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:01:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:01:10 INFO - Running setup.py (path:/tmp/pip-m0MbFp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:01:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:01:10 INFO - Running setup.py (path:/tmp/pip-bH483d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:01:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:01:10 INFO - Running setup.py (path:/tmp/pip-TmtSYW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:01:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:01:10 INFO - Running setup.py (path:/tmp/pip-0xgCxI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:01:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:01:10 INFO - Running setup.py (path:/tmp/pip-MbO1fa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:01:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:01:10 INFO - Running setup.py (path:/tmp/pip-LPb1q8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:01:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:01:10 INFO - Running setup.py (path:/tmp/pip-hHrzIE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:01:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:01:10 INFO - Running setup.py (path:/tmp/pip-bk9R8t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:01:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:01:10 INFO - Running setup.py (path:/tmp/pip-wMpcbO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:01:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:01:10 INFO - Running setup.py (path:/tmp/pip-fx3nYp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:01:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:01:10 INFO - Running setup.py (path:/tmp/pip-YkM5L5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:01:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:01:10 INFO - Running setup.py (path:/tmp/pip-abZSck-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:01:11 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:01:11 INFO - Running setup.py install for manifestparser 16:01:11 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:01:11 INFO - Running setup.py install for mozcrash 16:01:11 INFO - Running setup.py install for mozdebug 16:01:11 INFO - Running setup.py install for mozdevice 16:01:11 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:01:11 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:01:11 INFO - Running setup.py install for mozfile 16:01:11 INFO - Running setup.py install for mozhttpd 16:01:11 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:01:11 INFO - Running setup.py install for mozinfo 16:01:11 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:01:11 INFO - Running setup.py install for mozInstall 16:01:11 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:01:11 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:01:11 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:01:11 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:01:11 INFO - Running setup.py install for mozleak 16:01:11 INFO - Running setup.py install for mozlog 16:01:12 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:01:12 INFO - Running setup.py install for moznetwork 16:01:12 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:01:12 INFO - Running setup.py install for mozprocess 16:01:12 INFO - Running setup.py install for mozprofile 16:01:12 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:01:12 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:01:12 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:01:12 INFO - Running setup.py install for mozrunner 16:01:12 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:01:12 INFO - Running setup.py install for mozscreenshot 16:01:12 INFO - Running setup.py install for moztest 16:01:12 INFO - Running setup.py install for mozversion 16:01:12 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:01:12 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:01:12 INFO - Cleaning up... 16:01:12 INFO - Return code: 0 16:01:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:01: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')]} 16:01:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:01:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:01: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')]} 16:01:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:01:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:01:12 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 0x7fd74bcc2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ce05a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d6f410>, '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 0x1d70310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d707a0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1461797247.23138-1945067221', '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 16:01:12 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 16:01:12 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 16:01:12 INFO - Using env: {'DISPLAY': ':0', 16:01:12 INFO - 'HOME': '/home/cltbld', 16:01:12 INFO - 'LANG': 'en_US.UTF-8', 16:01:12 INFO - 'LANGUAGE': 'en_US:en', 16:01:12 INFO - 'LOGNAME': 'cltbld', 16:01:12 INFO - 'MAIL': '/var/mail/cltbld', 16:01:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:01:12 INFO - 'MOZ_NO_REMOTE': '1', 16:01:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:01:12 INFO - 'NO_EM_RESTART': '1', 16:01:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:01:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:01:12 INFO - 'PWD': '/builds/slave/test', 16:01:12 INFO - 'SHELL': '/bin/bash', 16:01:12 INFO - 'SHLVL': '1', 16:01:12 INFO - 'TERM': 'linux', 16:01:12 INFO - 'TMOUT': '86400', 16:01:12 INFO - 'USER': 'cltbld', 16:01:12 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1461797247.23138-1945067221', 16:01:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:01:12 INFO - '_': '/tools/buildbot/bin/python'} 16:01:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:01:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:01:13 INFO - Running setup.py (path:/tmp/pip-yq5mKK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:01:13 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)) 16:01:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:01:13 INFO - Running setup.py (path:/tmp/pip-2dNb6P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:01:13 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)) 16:01:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:01:13 INFO - Running setup.py (path:/tmp/pip-kNgUmW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:01:13 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)) 16:01:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:01:13 INFO - Running setup.py (path:/tmp/pip-dQjTZm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:01:13 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)) 16:01:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:01:13 INFO - Running setup.py (path:/tmp/pip-1eTMg3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:01:13 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)) 16:01:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:01:13 INFO - Running setup.py (path:/tmp/pip-tZGHBD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:01:13 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)) 16:01:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:01:13 INFO - Running setup.py (path:/tmp/pip-VGDRu2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:01:13 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)) 16:01:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:01:13 INFO - Running setup.py (path:/tmp/pip-q5G9Dy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:01:13 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)) 16:01:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:01:13 INFO - Running setup.py (path:/tmp/pip-1NwajR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:01:13 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)) 16:01:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:01:13 INFO - Running setup.py (path:/tmp/pip-FnaYjB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:01:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 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)) 16:01:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:01:13 INFO - Running setup.py (path:/tmp/pip-_lS_fQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:01:13 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)) 16:01:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:01:13 INFO - Running setup.py (path:/tmp/pip-YDd8Py-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:01:13 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)) 16:01:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:01:13 INFO - Running setup.py (path:/tmp/pip-jm33Mo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:01:13 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)) 16:01:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:01:13 INFO - Running setup.py (path:/tmp/pip-DUux7O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:01:14 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)) 16:01:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:01:14 INFO - Running setup.py (path:/tmp/pip-gHlUFw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:01:14 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)) 16:01:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:01:14 INFO - Running setup.py (path:/tmp/pip-xTC8Hp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:01:14 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)) 16:01:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:01:14 INFO - Running setup.py (path:/tmp/pip-FDwWXs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:01:14 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)) 16:01:14 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)) 16:01:14 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)) 16:01:14 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)) 16:01:14 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)) 16:01:14 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)) 16:01:14 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:01: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 16:01: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 16:01: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 16:01: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 16:01: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 16:01: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 16:01:16 INFO - Downloading blessings-1.6.tar.gz 16:01:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:01:16 INFO - Installing collected packages: blessings 16:01:16 INFO - Running setup.py install for blessings 16:01:16 INFO - Successfully installed blessings 16:01:16 INFO - Cleaning up... 16:01:16 INFO - Return code: 0 16:01:16 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:01:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:01:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:01:16 INFO - Reading from file tmpfile_stdout 16:01:16 INFO - Current package versions: 16:01:16 INFO - argparse == 1.2.1 16:01:16 INFO - blessings == 1.6 16:01:16 INFO - blobuploader == 1.2.4 16:01:16 INFO - docopt == 0.6.1 16:01:16 INFO - manifestparser == 1.1 16:01:16 INFO - mozInstall == 1.12 16:01:16 INFO - mozcrash == 0.17 16:01:16 INFO - mozdebug == 0.1 16:01:16 INFO - mozdevice == 0.48 16:01:16 INFO - mozfile == 1.2 16:01:16 INFO - mozhttpd == 0.7 16:01:16 INFO - mozinfo == 0.9 16:01:16 INFO - mozleak == 0.1 16:01:16 INFO - mozlog == 3.1 16:01:16 INFO - moznetwork == 0.27 16:01:16 INFO - mozprocess == 0.22 16:01:16 INFO - mozprofile == 0.28 16:01:16 INFO - mozrunner == 6.11 16:01:16 INFO - mozscreenshot == 0.1 16:01:16 INFO - mozsystemmonitor == 0.0 16:01:16 INFO - moztest == 0.7 16:01:16 INFO - mozversion == 1.4 16:01:16 INFO - psutil == 3.1.1 16:01:16 INFO - requests == 1.2.3 16:01:16 INFO - wsgiref == 0.1.2 16:01:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:01:16 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')]} 16:01:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:01:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:01:16 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')]} 16:01:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:01:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:01:16 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 0x7fd74bcc2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ce05a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d6f410>, '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 0x1d70310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d707a0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1461797247.23138-1945067221', '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 16:01:16 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 16:01:16 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 16:01:16 INFO - Using env: {'DISPLAY': ':0', 16:01:16 INFO - 'HOME': '/home/cltbld', 16:01:16 INFO - 'LANG': 'en_US.UTF-8', 16:01:16 INFO - 'LANGUAGE': 'en_US:en', 16:01:16 INFO - 'LOGNAME': 'cltbld', 16:01:16 INFO - 'MAIL': '/var/mail/cltbld', 16:01:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:01:16 INFO - 'MOZ_NO_REMOTE': '1', 16:01:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:01:16 INFO - 'NO_EM_RESTART': '1', 16:01:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:01:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:01:16 INFO - 'PWD': '/builds/slave/test', 16:01:16 INFO - 'SHELL': '/bin/bash', 16:01:16 INFO - 'SHLVL': '1', 16:01:16 INFO - 'TERM': 'linux', 16:01:16 INFO - 'TMOUT': '86400', 16:01:16 INFO - 'USER': 'cltbld', 16:01:16 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1461797247.23138-1945067221', 16:01:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:01:16 INFO - '_': '/tools/buildbot/bin/python'} 16:01:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:01:16 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)) 16:01:16 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)) 16:01:16 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)) 16:01:16 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)) 16:01:16 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)) 16:01:16 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)) 16:01:16 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)) 16:01:16 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)) 16:01:16 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)) 16:01:16 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)) 16:01:16 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)) 16:01:16 INFO - Cleaning up... 16:01:16 INFO - Return code: 0 16:01:16 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:01:16 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')]} 16:01:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:01:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:01:16 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')]} 16:01:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:01:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:01:16 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 0x7fd74bcc2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ce05a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d6f410>, '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 0x1d70310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d707a0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1461797247.23138-1945067221', '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 16:01:16 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 16:01:16 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 16:01:16 INFO - Using env: {'DISPLAY': ':0', 16:01:16 INFO - 'HOME': '/home/cltbld', 16:01:16 INFO - 'LANG': 'en_US.UTF-8', 16:01:16 INFO - 'LANGUAGE': 'en_US:en', 16:01:16 INFO - 'LOGNAME': 'cltbld', 16:01:16 INFO - 'MAIL': '/var/mail/cltbld', 16:01:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:01:16 INFO - 'MOZ_NO_REMOTE': '1', 16:01:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:01:16 INFO - 'NO_EM_RESTART': '1', 16:01:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:01:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:01:16 INFO - 'PWD': '/builds/slave/test', 16:01:16 INFO - 'SHELL': '/bin/bash', 16:01:16 INFO - 'SHLVL': '1', 16:01:16 INFO - 'TERM': 'linux', 16:01:16 INFO - 'TMOUT': '86400', 16:01:16 INFO - 'USER': 'cltbld', 16:01:16 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1461797247.23138-1945067221', 16:01:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:01:16 INFO - '_': '/tools/buildbot/bin/python'} 16:01:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:01:17 INFO - Downloading/unpacking jsonschema 16:01:17 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 16:01:17 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 16:01:17 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 16:01:17 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 16:01:17 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 16:01:17 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 16:01:18 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:01:18 INFO - Downloading/unpacking functools32 (from jsonschema) 16:01:18 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 16:01:18 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 16:01:18 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 16:01:18 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 16:01:18 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 16:01:18 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 16:01:19 INFO - Downloading functools32-3.2.3-2.tar.gz 16:01:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:01:19 INFO - warning: no files found matching '*.txt' 16:01:19 INFO - no previously-included directories found matching 'build' 16:01:19 INFO - no previously-included directories found matching 'dist' 16:01:19 INFO - no previously-included directories found matching '.git*' 16:01:19 INFO - Installing collected packages: jsonschema, functools32 16:01:19 INFO - Running setup.py install for functools32 16:01:19 INFO - warning: no files found matching '*.txt' 16:01:19 INFO - no previously-included directories found matching 'build' 16:01:19 INFO - no previously-included directories found matching 'dist' 16:01:19 INFO - no previously-included directories found matching '.git*' 16:01:19 INFO - Successfully installed jsonschema functools32 16:01:19 INFO - Cleaning up... 16:01:19 INFO - Return code: 0 16:01:19 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 16:01:19 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')]} 16:01:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:01:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:01:19 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')]} 16:01:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:01:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:01:19 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 0x7fd74bcc2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ce05a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d6f410>, '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 0x1d70310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d707a0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1461797247.23138-1945067221', '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 16:01:19 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 16:01:19 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 16:01:19 INFO - Using env: {'DISPLAY': ':0', 16:01:19 INFO - 'HOME': '/home/cltbld', 16:01:19 INFO - 'LANG': 'en_US.UTF-8', 16:01:19 INFO - 'LANGUAGE': 'en_US:en', 16:01:19 INFO - 'LOGNAME': 'cltbld', 16:01:19 INFO - 'MAIL': '/var/mail/cltbld', 16:01:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:01:19 INFO - 'MOZ_NO_REMOTE': '1', 16:01:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:01:19 INFO - 'NO_EM_RESTART': '1', 16:01:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:01:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:01:19 INFO - 'PWD': '/builds/slave/test', 16:01:19 INFO - 'SHELL': '/bin/bash', 16:01:19 INFO - 'SHLVL': '1', 16:01:19 INFO - 'TERM': 'linux', 16:01:19 INFO - 'TMOUT': '86400', 16:01:19 INFO - 'USER': 'cltbld', 16:01:19 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1461797247.23138-1945067221', 16:01:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:01:19 INFO - '_': '/tools/buildbot/bin/python'} 16:01:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:01:19 INFO - Downloading/unpacking flake8 16:01:19 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 16:01:19 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 16:01:19 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 16:01:19 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 16:01:19 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 16:01:19 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 16:01:21 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 16:01:21 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 16:01:21 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 16:01:21 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 16:01:21 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 16:01:21 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 16:01:21 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 16:01:21 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 16:01:21 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 16:01:21 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 16:01:21 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 16:01:21 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 16:01:21 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 16:01:21 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 16:01:21 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 16:01:21 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 16:01:21 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 16:01:21 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 16:01:21 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 16:01:21 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 16:01:21 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 16:01:21 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 16:01:21 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 16:01:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 16:01:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:01:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:01:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:01:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:01:22 INFO - no previously-included directories found matching 'docs/_build' 16:01:22 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 16:01:22 INFO - Running setup.py install for pep8 16:01:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:01:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:01:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:01:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:01:22 INFO - no previously-included directories found matching 'docs/_build' 16:01:22 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 16:01:22 INFO - Successfully installed flake8 mccabe pyflakes pep8 16:01:22 INFO - Cleaning up... 16:01:22 INFO - Return code: 0 16:01:22 INFO - Running post-action listener: _resource_record_post_action 16:01:22 INFO - Running post-action listener: _start_resource_monitoring 16:01:22 INFO - Starting resource monitoring. 16:01:22 INFO - ##### 16:01:22 INFO - ##### Running install step. 16:01:22 INFO - ##### 16:01:22 INFO - Running pre-action listener: _resource_record_pre_action 16:01:22 INFO - Running main action method: install 16:01:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:01:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:01:22 INFO - Reading from file tmpfile_stdout 16:01:22 INFO - Detecting whether we're running mozinstall >=1.0... 16:01:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:01:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:01:22 INFO - Reading from file tmpfile_stdout 16:01:22 INFO - Output received: 16:01:22 INFO - Usage: mozinstall [options] installer 16:01:22 INFO - Options: 16:01:22 INFO - -h, --help show this help message and exit 16:01:22 INFO - -d DEST, --destination=DEST 16:01:22 INFO - Directory to install application into. [default: 16:01:22 INFO - "/builds/slave/test"] 16:01:22 INFO - --app=APP Application being installed. [default: firefox] 16:01:22 INFO - mkdir: /builds/slave/test/build/application 16:01:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 16:01:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 16:01:39 INFO - Reading from file tmpfile_stdout 16:01:39 INFO - Output received: 16:01:39 INFO - /builds/slave/test/build/application/firefox/firefox 16:01:39 INFO - Running post-action listener: _resource_record_post_action 16:01:39 INFO - ##### 16:01:39 INFO - ##### Running run-tests step. 16:01:39 INFO - ##### 16:01:39 INFO - Running pre-action listener: _resource_record_pre_action 16:01:39 INFO - Running main action method: run_tests 16:01:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:01:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:01:39 INFO - Python 2.7.3 16:01:39 INFO - Return code: 0 16:01:39 INFO - grabbing minidump binary from tooltool 16:01:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:01:39 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: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d6f410>, '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 0x1d70310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d707a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:01:39 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 16:01:39 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 16:01:39 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:01:39 INFO - Return code: 0 16:01:39 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:01:39 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:01:39 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:01:39 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:01:39 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:01:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 16:01:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 16:01:40 INFO - Return code: 0 16:01:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IhU5KjaCR_SW_Bgi5qJ3wA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-057', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 16:01:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/IhU5KjaCR_SW_Bgi5qJ3wA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-057 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 16:01:40 INFO - Using env: {'DISPLAY': ':0', 16:01:40 INFO - 'HOME': '/home/cltbld', 16:01:40 INFO - 'LANG': 'en_US.UTF-8', 16:01:40 INFO - 'LANGUAGE': 'en_US:en', 16:01:40 INFO - 'LOGNAME': 'cltbld', 16:01:40 INFO - 'MAIL': '/var/mail/cltbld', 16:01:40 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:01:40 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:01:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:01:40 INFO - 'MOZ_NO_REMOTE': '1', 16:01:40 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:01:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:01:40 INFO - 'NO_EM_RESTART': '1', 16:01:40 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:01:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:01:40 INFO - 'PWD': '/builds/slave/test', 16:01:40 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:01:40 INFO - 'SHELL': '/bin/bash', 16:01:40 INFO - 'SHLVL': '1', 16:01:40 INFO - 'TERM': 'linux', 16:01:40 INFO - 'TMOUT': '86400', 16:01:40 INFO - 'USER': 'cltbld', 16:01:40 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1461797247.23138-1945067221', 16:01:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:01:40 INFO - '_': '/tools/buildbot/bin/python'} 16:01:40 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IhU5KjaCR_SW_Bgi5qJ3wA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-057', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 16:01:40 INFO - mozversion application_buildid: 20160427133047 16:01:40 INFO - mozversion application_changeset: 119f55446e975341b3d09cd4036dc39a3b59ec82 16:01:40 INFO - mozversion application_display_name: Nightly 16:01:40 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:01:40 INFO - mozversion application_name: Firefox 16:01:40 INFO - mozversion application_remotingname: firefox 16:01:40 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 16:01:40 INFO - mozversion application_vendor: Mozilla 16:01:40 INFO - mozversion application_version: 49.0a1 16:01:40 INFO - mozversion platform_buildid: 20160427133047 16:01:40 INFO - mozversion platform_changeset: 119f55446e975341b3d09cd4036dc39a3b59ec82 16:01:40 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 16:01:40 INFO - mozversion platform_version: 49.0a1 16:01:40 INFO - using testdate: 1461798100 16:01:40 INFO - actual date: 1461798100 16:01:40 INFO - starting webserver on 'localhost:34090' 16:01:40 INFO - SUITE-START | Running 2 tests 16:01:40 INFO - TEST-START | dromaeo_css 16:01:40 INFO - operating with platform_type : linux_ 16:01:40 INFO - Initialising browser for dromaeo_css test... 16:01:40 INFO - TEST-INFO | started process 6549 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7vNavM/profile http://localhost:34090/getInfo.html) 16:01:44 INFO - PROCESS | 6549 | 16:01:44 INFO - PROCESS | 6549 | (process:6617): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 16:01:45 INFO - PROCESS | 6549 | __metrics Screen width/height:1600/1200 16:01:45 INFO - PROCESS | 6549 | colorDepth:24 16:01:45 INFO - PROCESS | 6549 | Browser inner width/height: 1024/697 16:01:45 INFO - PROCESS | 6549 | __metrics 16:01:46 ERROR - PROCESS | 6549 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 16:01:46 INFO - TEST-INFO | 6549: exit 0 16:01:46 INFO - Browser initialized. 16:01:46 INFO - Running cycle 1/1 for dromaeo_css test... 16:01:46 INFO - TEST-INFO | started process 6668 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7vNavM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:01:48 INFO - PROCESS | 6668 | 16:01:48 INFO - PROCESS | 6668 | (process:6729): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 16:01:58 INFO - PROCESS | 6668 | RSS: Main: 164732928 16:01:58 INFO - PROCESS | 6668 | 16:02:48 INFO - PROCESS | 6668 | 1461798168270 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] 16:04:55 INFO - PROCESS | 6668 | Cycle 1(1): loaded http://localhost:34090/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34090/tests/dromaeo/cssquery-ext.html) 16:04:56 INFO - PROCESS | 6668 | RSS: Main: 169553920 16:04:56 INFO - PROCESS | 6668 | 16:07:58 INFO - PROCESS | 6668 | Cycle 1(1): loaded http://localhost:34090/tests/dromaeo/cssquery-ext.html (next: http://localhost:34090/tests/dromaeo/cssquery-jquery.html) 16:07:59 INFO - PROCESS | 6668 | RSS: Main: 166764544 16:07:59 INFO - PROCESS | 6668 | 16:11:00 INFO - PROCESS | 6668 | Cycle 1(1): loaded http://localhost:34090/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34090/tests/dromaeo/cssquery-mootools.html) 16:11:01 INFO - PROCESS | 6668 | RSS: Main: 167690240 16:11:01 INFO - PROCESS | 6668 | 16:14:03 INFO - PROCESS | 6668 | Cycle 1(1): loaded http://localhost:34090/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34090/tests/dromaeo/cssquery-prototype.html) 16:14:03 INFO - PROCESS | 6668 | RSS: Main: 165404672 16:14:03 INFO - PROCESS | 6668 | 16:17:06 INFO - PROCESS | 6668 | Cycle 1(1): loaded http://localhost:34090/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34090/tests/dromaeo/cssquery-yui.html) 16:17:06 INFO - PROCESS | 6668 | RSS: Main: 166727680 16:17:06 INFO - PROCESS | 6668 | 16:20:09 INFO - PROCESS | 6668 | Cycle 1(1): loaded http://localhost:34090/tests/dromaeo/cssquery-yui.html (next: http://localhost:34090/tests/dromaeo/cssquery-dojo.html) 16:20:09 INFO - PROCESS | 6668 | RSS: Main: 168509440 16:20:09 INFO - PROCESS | 6668 | 16:20:09 INFO - PROCESS | 6668 | __start_tp_report 16:20:09 INFO - PROCESS | 6668 | _x_x_mozilla_page_load 16:20:09 INFO - PROCESS | 6668 | _x_x_mozilla_page_load_details 16:20:09 INFO - PROCESS | 6668 | |i|pagename|runs| 16:20:09 INFO - PROCESS | 6668 | |0;dojo.html;3134.388794185134;3179.7138257556817;3188.5376620390043;3231.773775835691;3235.0294911526553;5402.108652072408;5405.783768649254;5420.214068959998;5439.782408703657;5441.428649991753;5294.92057619136;5343.305370301865;5383.057964856154;5478.397376288615;5593.161025846125;4880.3655524781725;4911.484294149099;4948.430930442991;4985.576226020775;5017.69893806371;853.4174914135009;4837.4195096588455;4945.752712364385;4956.281339205813;4962.478939711333;4904.558589726924;4908.877278068041;4921.606271498272;4928.901421971558;4971.527704868014;4797.568218860284;4936.555709986119;4950.8267210647455;4953.801847926079;5000.399952005782;4888.706677599355;4902.828401005948;4944.035912996967;4950.579200767939;4956.851294461172;5299.152135658314;5314.601404894648;5339.252504649352;5339.5728341732565;5340.465953404668;5743.971280143614;5773.769049238025;5777.046787280094;5780.393058728857;5855.707214639251;5769.307683078057;5876.236089308405;5880.4119588041285;5893.7053147342895;5911.674857882857;5414.485623865727;5450.482204190595;5470.070088084995;5474.124140137559;5478.643888147258;5805.883882322414;5899.321578018583;5934.080217566284;5984.700764961734;5998.550108741774;5712.542996560265;5757.971210144006;5759.65442073477;5765.394633563499;5765.971170144123;5820.621659592198;5823.097419899922;5833.912491312549;5841.065429531254;5843.941560584425;5664.85837854057;5869.148973398833;5892.499137573354;5903.911441328383;5984.102384642251;5664.20701101846;5744.109663002241;5768.278965129359;5823.970880145657;5879.029960056543;4366.279563871925;4371.69398142127;4377.518472967971;4378.60592546666;4418.226810308183;3876.5735769065946;3880.728349015542;3918.941215881764;3919.5296564411883;3978.3435733104293;5547.140193270049;5597.384287728347;5599.132134519156;5605.215269862222;5643.209950606918;5770.855728606734;5834.27071616048;5837.562182836305;5860.765569377178;5872.706364681749;5458.344998600193;5477.096279113981;5557.110862262019;5558.138488534284;5566.55467562594;4988.052270068675;5013.897106716872;5026.045051440287;5045.192769156917;5055.443901170868;6076.665783381868;6080.574359794772;6097.664628445478;6101.786437474756;6131.693415329216;5693.117566777239;5791.102379131242;5867.119932010062;5894.204282421818;5983.222181116427;5997.850053748692;6040.184575082308;6060.818175454743;6068.787592434243;6070.18052562916;5707.942920570741;5749.741261643319;5751.626144300607;5754.338251101177;5765.56758243125;5728.684922329312;5773.913391299218;5842.357340692605;5852.239208902815;5888.823335299948;5610.270664813548;5641.774329026793;5644.350899646429;5656.43435656431;5662.490375866192;5579.414161513145;5630.127330263816;5665.49010589049;5667.376588575171;5686.516646084963;5480.91778623313;5559.9444005561045;5578.219049333015;5644.6613203207935;5667.773289068391;5642.943570564242;5685.033544297562;5701.116326969326;5770.711464426846;5775.191473193672;5592.916106258491;5594.104943209067;5606.719664016701;5611.691356975405;5620.04459241938 16:20:09 INFO - PROCESS | 6668 | |1;ext.html;599.4814485470067;643.8776632439836;643.9742410303583;656.1175219330001;659.4032400677386;39116.217675646505;40570.7971460143;40810;41057.58942410575;41119.177616447654;41457.58542414575;42362.152756944844;42480.150396992045;42668.78665606667;42884.78557607208;8870.51212183328;9075.591598378089;9084.454932704059;9089.772755681128;9109.180173784358;8790.077041910603;8966.193042626162;8973.685920992766;8983.281337492985;9019.23336516397;8957.552122393887;8978.685745998891;8992.820143597124;9016.459012459241;9036.096390360977;8800.339974501905;8948.910510894873;8967.282617390625;8971.730848074569;9006.144416280444;8915.955420222923;9010.684626038123;9016.05331440196;9023.684171053981;9066.818663626756;40310.79844600758;40720.79639601813;41185.382219266736;41226.58773412288;41362.172756545;3725.2549490102087;3747.569029561608;3828.2152158807376;4023;4250.107477429743;31807;31888.521672174935;32304.676953230402;32635.18412039694;33260.83369583161;4267.679924005712;4322.7190232634775;4331.610155086026;4332.870013899556;4383.211022016036;233493;238155;238179;239090;301378;55911.44088559144;56173;56862;56922.43077569254;57145.42854571484;55996.44003559994;57015;57399;59268;59449;15604.921975390278;15821.683566328838;15936.760948585781;15954.840451595335;15958.202089895458;11308.604198853165;11332.773344533063;11341.092712582973;11348.546058157746;11388.487518061707;18913.527161821065;18988.05059747007;19025.619487610446;19138.138783754763;19198.8080119197;7230.927690723131;7297.233790451926;7344.669489872968;7491.925080749123;7525.736599219001;992.771662517625;1051.1800795379615;1087.983680244797;1132.0943245403644;1146.8817902545118;31136;31684.683153168633;31835.681643183736;31840.840795795873;31848.363032739217;1153.146671463128;1164.0978241862624;1166.8891455311732;1171.4025846818183;1211.4608998995363;16760.916195418944;16893.32426702918;16913.238904249338;16976;17211.91394043022;510490;528234;529110;529257;530096;55257.72371138199;56200.71899640476;56275.437245627836;56288.155677664865;56392;1402.2217669193492;1413.1097408632495;1415.2004117673482;1427.414759948416;1523.8190402437976;29585;29752.553711694774;29891.103266902028;30077;30364.544531831598;50502.747486262335;51143.744281278356;51233.743831280604;51405;51522.74238628783;341286;348349;348589;349426;349616;39358.803205983786;40879.59120408758;41187.1762564741;41385.58614413817;41406.585934140276;47420.7628961853;47642;47824.52175478201;48451.75774121107;49083.5091649079;36029.819850900574;39552.40671389989;39565.60434395734;39776.60223397729;39861.003474913356;38165;38231.617683822806;38587;39470.40794388144;39565.60434395734;32468.837655812516;34692.30615387729;39610.80194599008;40093.79953100216;40664.39003414892;39313.41029884497;40125.79937100413;40272;40355.79822100871;40499.59500405076;30605.540916886708;30898.53652195264;31199.688003119678;31304.686953130178;32029.67970320267 16:20:09 INFO - PROCESS | 6668 | |2;jquery.html;394.9782761948093;397.84682897084616;400.6394245179339;401.66059679570753;403.5157810627248;17243.3102675893;18049.27802887883;18121.818781812195;18197.7270340945;20325.796742032577;18584.90707546464;18863.62272754544;19007.334743283987;19058.809411905877;19455.124519396624;5612.07400778871;5663.122216056508;5698.886022279552;5762.827115186551;5836.620619659709;5707.800226992056;5709;5731.484166425021;5745.712714364286;5753.971230143843;5477.3427188737205;5497.725113744316;5575.8606034849045;5576.498115169634;5598.1322894951145;5527.088030474967;5529.640573362759;5549.306336707911;5572.60991730579;5604.747786349603;4888.022395520875;4951.950480495221;5025.547700706954;5046.116929537353;5053.898922021539;22451.887740561357;22879.88560057189;23247.3025809226;23292.883535582383;23332.183373581844;1814.8911065336122;2178.455386153462;2276.435746328617;2284.5430913817136;2619.751123643251;10050.296479246455;10136.189104871593;10285.9485702571;10379.688609341732;10497.632582859564;1971.083446197525;2004.2877798274947;2065.555905480329;2071.3682326890294;2120.1837292642444;77399.61300193463;79975.60012199901;80501;81646.18353816445;82339.5883020587;11064.170187235828;11084.722881928017;11127.27672701288;11319.603813866475;11341.319520828776;15674.764878526832;15755.606109847116;15818.525444236691;15829.050256984618;15845.286962086733;7274.818129546804;7727.343175830005;8124.431289809657;8158.714444994397;8170.877436838452;7531.736389226351;7596.088469383599;7708.8458230836195;7808.726694565663;7810.6875724971505;4683.648726345469;4687.039156972813;4749.833755818529;4769.856904292877;4816.109019831342;1971.5761111361126;1984.5435549823621;1996.5507760753715;1997.2011195521907;2041.428400047989;952.3286083311249;1088.259983211408;1089.6894385100209;1108.013867657785;1121.3888430805068;17430.215640296217;18285.817141828677;18774.906125469286;19098.427047188605;19141.521461963563;998.9350692204983;1013.083159740436;1026.4457193115784;1046.7383154211448;1047.7328281288223;10526.631567895087;10550.103241224428;10701.09040731531;10839.349639021684;10896.182786290901;475004;476337;482335;486222;502356.3468374544;57115.14327285094;66402.66798665976;83499.16500834914;83998;86946.69579956305;1027.4349107990724;1071.978560428787;1072.4744875011188;1077.2405454154803;1108.695108845058;17329.56676083108;17341.393051243147;17426.86725362898;17537.684673649273;17724.379646712303;39970.2005959885;40282.590109346034;40948.9494271864;41192.176156476104;43214.56785432105;56744.14883776829;58284.70857645854;58842.11736824037;59397;59997.70001149966;7996.6401511930935;8053.597320134087;8072.757817265491;8226.506409615442;8394.0766515682;13350.465981360638;14075.648108796953;14104.78842817338;14144.22206778637;14248.786268206193;11882.227655202385;11922.701932451759;11970.76058478843;11991.280523168638;12010.279383237033;11575.652730418102;11776.470058847544;11842.348670823187;12039.75920481568;12066;12046.337451439904;12097.57658481984;12254.87745122573;12441.813372799234;12471;8454;8963.372563920462;9043.55303151519;9058.320625953213;9086.45481271126;11943.104267179822;11967.401629918644;12091.334976576021;12136.453859576164;12310.26138431697 16:20:09 INFO - PROCESS | 6668 | |3;mootools.html;1473.1823837770037;1525.3593490733895;1661.5846038490376;1763.5150333658241;1773.3793172389674;7364.631768411571;7816.1402245753;8053.718119865805;8082.313003394711;8096.352291816655;8137.226963438478;8197.344212463004;8204.507729536232;8214.630341634625;8243.91756082439;2282.281081459339;2342.8008619267384;2352.5765362234793;2355.281639100074;2358.433975845793;2292.426893276681;2301.6317389217643;2326;2342.051469154995;2356.22244659262;2308.4575124845646;2321.117975169433;2328.871912044837;2352.6588644646517;2355.281639100074;2229.576380487702;2238.507528343762;2257.1761307122865;2259.20927675314;2268.3308424014954;2240.708707867983;2265.9660105098437;2274.3404412720292;2279.054192510123;2291.014863608648;8337.291330236938;8404.957975210145;8407.579621018986;8440;8462.4076314658;4957.405111386621;5096.337476128117;5123.077845987758;5152;5153.665011774223;3368.713659338959;3449.741269404805;3536.8054756988354;3563.5901871284614;3580.946285805715;1115.8884111588857;1139.7720455908768;1165.4755360087995;1167.2296284452307;1168.0655475619556;11424;11433.885661143366;11500.884991150066;11521.942390288079;11529.769404611861;4426;4539.182947069493;4559.749213793273;4567.040921406542;4568.451785785727;9755.853662195073;9826.80346393068;9829.361091529028;9845.50772461374;9865.753356166153;5130.1535246684625;5156.690598564098;5157.484251574812;5182.093133701663;5195.870103247374;4200.369944508348;4461.464624245046;4610;4645.279981602857;4760.09558183944;3876.9418458723144;3877.166409222031;3941.6058394160927;3960.2871483132735;4016.6385025347276;1257.3084803358117;1295.33290355467;1296.293520031585;1304.2370213425252;1305.340802894532;870.4429165334191;981.4062492192263;1000.8298589239847;1002.9749256268506;1005.5575546759402;5797.391273916262;5930.11048342752;5943.078822782476;6052.636841789418;6089.908651370233;443.080607738943;450.34474839109015;450.9210888094636;452.80076766222754;465.8998315362213;4027.939580906289;4047.1500984793524;4094.651954583834;4105.486814148231;4167.499900012018;9973.252006099572;10376.481175941173;10477;10528.368297901998;10551.20865935058;10238;10238.078572928323;10254.897451025543;10324.535395907202;10370.377777333384;7548.245175482518;7809.140994490602;7935.1668074853615;7985.880211796828;7991;5782.363939966516;5790.10253410722;5856.443637854397;5912.940870591411;5954.940450595439;9057.501837399006;9482.857757133786;9496.952515237379;9541;9599.712008639752;9553.90446095558;9570.090841370058;9688;9700.029997000243;9824.263180261367;6844.247132815287;7276.381507571704;7410.481266311306;7546.2831031051965;7556.65995030236;8089.9191008089165;8093.352531797324;8118.75643730689;8124.309433697966;8168.714095006646;7297.817554561178;7365.8158546036775;7485.026946496921;7589.506682065648;7601.239876012576;7150.10623672041;7189;7361.153467351323;7377.926220737724;7494.250574942462;6911.481638877004;6953.895691564529;6990.860182796418;6999.12510936133;7011.263817299314;4892.143874821963;4893.73084480357;4940.7035577865445;4981.327520784647;5059.671121377099;5029.119904016709;5079.92380114306;5127.769250383816;5155.072087024221;5281.867953301198 16:20:09 INFO - PROCESS | 6668 | |4;prototype.html;320.52882263073286;331.96016478022625;334.6001528173833;339.2807248632899;340.14453649072584;5405.405405405412;5428.4842939920745;5535.557155427567;5555.944440555593;5611.298587676541;5516.834494965147;5534.806281780138;5565;5565.1374037024225;5596.944030559694;4341.6526677865695;4367.148406060819;4381.233284175257;4387.934180987288;4398.4062151609605;4066;4313.849015284466;4315.805788739499;4381.561843815625;4390.560943905616;4242.172776308621;4259.487881801962;4270.402143699885;4272.679549033819;4289.914201715979;4274.316109422493;4286.892827679302;4308.849190278356;4315.870523884289;4316.2446571849805;3669.3578623740736;3770.811459427045;3779.716521260889;3783.905402364963;3784.526934133233;5371.382291036542;5374.381946076212;5378.354597448331;5391.191321301797;5412.161115027177;5009.323741294915;5020.221865610836;5023;5025.0954828130925;5033.421156567005;5494.780208791643;5783.913241301384;5841.561882858802;5853.76584936602;5858.3848695886745;4199.7690127043;4206.095689426757;4219.97890010548;4223.64099051581;4239.364095385686;5994.411480957549;6140.7236674349315;6147.692615369214;6159.7536098556;6169.105479705462;4241.833495788683;4331.112122014979;4335.869923902288;4346.587074227943;4346.695731298779;4359.847405340861;4364.585364390377;4403;4415.977920110379;4422.513523512411;4953.2570114483115;4971.925421118686;4983.302337672729;5002.799328161215;5016.347874776328;5698.971505142531;5882.676452795052;5894.941050589525;5916.290045194604;5923.703814809242;1591.3475475055172;1595.7367034439187;1597.297189236732;1600.199900049975;1613.1692178528067;1075.833245846895;1088.5319312695617;1088.689723428819;1099.828682453185;1112.3826276416667;6064.9090263646085;6082.118092876508;6083.452489275986;6101.969490152521;6102.755889764359;6422.389872962061;6448.355164483608;6460.483161347081;6476.481881449473;6487.643179625072;5843.3864444233595;6080.878382432326;6083.783243351348;6088.878222435526;6091.939080609137;3396.371671240779;3443.6728510791436;3452.1369657585606;3453.1021934297264;3453.4992426098074;6514.641694706742;6602.524053479945;6663.700133494004;6665.366790154928;6695.397414232742;6495.642739649365;6546.297962529777;6557.540972132;6566.507511936624;6569.408753212234;6530;6626.9337306627285;6630.569013014235;6707.899381509281;6720.764773232913;6382.808515744535;6396.584222025554;6415.390537898892;6432.324605916311;6438.649892789192;5762.337331206797;6343.619382837044;6382.648954307558;6383.1382763326355;6390.840228994312;5936.317323507852;6066.848328791639;6268.4955610652205;6297.716602752796;6315.55791094619;4167.291560434794;4210.63154474803;4235.195312890541;4237.279662457451;4248.640435060751;6051.727672254671;6052.2132122825515;6065.575409721454;6087.604305720114;6104.17593624855;5746.396628353963;5857.677827719516;5901.822945311647;5913.29040515141;5931.911021334769;5827.475527202572;5846.123081537633;5865.824025279248;5878.353381128158;5884.763789760035;5580.972095139498;5762.740676669644;5807.8548036299435;5811.215485909348;5815.360310365941;5845.707714614337;5925.4370834770625;5929.407059294036;5962.791302304398;5963.463288304073;5770.192173095854;5774.105013722879;5777.353454265514;5781.190633311424;5819.679917604572 16:20:09 INFO - PROCESS | 6668 | |5;yui.html;769.7536788227762;781.6258412644879;802.4783890471197;814.1939479914886;817.8200795824919;13842.169469831804;14634.853651463482;14647;14660.047096938719;14719.411223551058;13426.865731342683;13439.193648381104;13497.055206135574;13501.2574308413;13507.527236546723;644.935506449356;763.3816608547081;774.7559518751603;790.0519376747897;793.4842352470882;777.2577188784697;784.6390660296271;786.6656670914867;788.0464637788283;792.9960350198241;806.822499050208;807.8828569857396;808.8584497712906;813.7965508622844;824.4805772363403;802.8715405535115;806.6531391501652;807.2653884964654;810.0441479054713;823.6211342782298;602.8071017274474;609.8261995331353;610.1640752169557;611.0071134406589;612.6691586543261;12969.935150324281;12972.286524241163;12984.350782460839;12987.675308117277;13027.674308142277;13881.375338109709;14013.5095271665;14203.289835508183;14251;14269.500567480192;10955.17836162291;11107.611233606785;11335.603253886075;11588.07295416373;11624.476898539586;3681.2821499807546;3694.7967861767593;3734.1971476132762;3803.1633040730994;3844.5770965193806;51098.74450627723;51413.22880156801;53140;53457.465425346025;53804.192937105974;10699.786004280026;10862.945685271523;10946.507407166697;10946.726331841768;11082.722931926766;17826.732599011026;18061.638767224846;18195.090245487674;18223.362182323555;18418.539536511427;8353.457025293457;8378.078411374743;8421;8442.197991190827;8559.871601925975;4876.951230487721;4945.208766597327;5015.3480047593575;5016.097102521581;5196.506331898464;3029.5304227844717;3150.8109513429267;3153.858076386568;3160.1625569224175;3161.5257711343484;562.8086450606813;567.9829605111853;622.3745136138152;648.4067078623007;652.2629428745487;663.7079684938611;712.7434123715458;718.4001358865406;734.6730704836297;756.5498528375608;8252.595670411807;8536.530490822941;8608.612612432456;8612.095729948265;8622.353323500762;625.8497960489541;670.1723371636026;704.9295070493013;712.3846479118495;749.9287567681062;3996.2806694795217;4066.67466602677;4068.3888680893547;4079.755214687128;4194.748315101104;69267;70640.2935970644;71443.28556714367;71960.64019679972;72082;63316;64070.35929640737;64666.35333646697;64948;66090.35638574499;50747.49252507502;52657.473425265256;57231.71384143136;57574;58152.70923645439;7790.5325680459355;7794.181610930771;7932.6430310637315;8026.799330016563;8086.070101938352;36076.27847443089;36450;37486.43770343393;37660.43509347417;38336.42495362516;43807.34288985732;45621;48124;48530.757346213046;49099;10871.069041540408;11041.889581104408;11114.166437517057;11162.107031437303;11291.266067705574;11834.940825295818;11914.40427978615;12299.262044277371;12377.257364558156;12415.44130514111;9900.752481188028;10743.140548755924;11539.19225654196;11766.588169414372;11818.527258909548;11269.549218031514;12007.639770806889;12018.459169337226;12089.214201076902;12245.510179592717;11718.531258749554;12208.351355516932;12375.504979800708;12607.306598137191;12720.74558508843;10701.785964280827;10731.678049658523;10969.780604388026;10975.725606859573;11118.166137539554;10452.895471045193;10665;10928.508217130408;11030;11039.889601103887 16:20:09 INFO - PROCESS | 6668 | __end_tp_report 16:20:09 INFO - PROCESS | 6668 | __start_cc_report 16:20:09 INFO - PROCESS | 6668 | _x_x_mozilla_cycle_collect,334 16:20:09 INFO - PROCESS | 6668 | __end_cc_report 16:20:09 INFO - PROCESS | 6668 | __startTimestamp1461799209284__endTimestamp 16:20:09 INFO - PROCESS | 6668 | 16:20:09 INFO - PROCESS | 6668 | ------- Summary: start ------- 16:20:09 INFO - PROCESS | 6668 | Number of tests: 6 16:20:09 INFO - PROCESS | 6668 | 16:20:09 INFO - PROCESS | 6668 | [#0] dojo.html Cycles:165 Average:5378.54 Median:5620.04 stddev:714.73 (12.7%) stddev-sans-first:694.90 16:20:09 INFO - PROCESS | 6668 | Values: 3134.4 3179.7 3188.5 3231.8 3235.0 5402.1 5405.8 5420.2 5439.8 5441.4 5294.9 5343.3 5383.1 5478.4 5593.2 4880.4 4911.5 4948.4 4985.6 5017.7 853.4 4837.4 4945.8 4956.3 4962.5 4904.6 4908.9 4921.6 4928.9 4971.5 4797.6 4936.6 4950.8 4953.8 5000.4 4888.7 4902.8 4944.0 4950.6 4956.9 5299.2 5314.6 5339.3 5339.6 5340.5 5744.0 5773.8 5777.0 5780.4 5855.7 5769.3 5876.2 5880.4 5893.7 5911.7 5414.5 5450.5 5470.1 5474.1 5478.6 5805.9 5899.3 5934.1 5984.7 5998.6 5712.5 5758.0 5759.7 5765.4 5766.0 5820.6 5823.1 5833.9 5841.1 5843.9 5664.9 5869.1 5892.5 5903.9 5984.1 5664.2 5744.1 5768.3 5824.0 5879.0 4366.3 4371.7 4377.5 4378.6 4418.2 3876.6 3880.7 3918.9 3919.5 3978.3 5547.1 5597.4 5599.1 5605.2 5643.2 5770.9 5834.3 5837.6 5860.8 5872.7 5458.3 5477.1 5557.1 5558.1 5566.6 4988.1 5013.9 5026.0 5045.2 5055.4 6076.7 6080.6 6097.7 6101.8 6131.7 5693.1 5791.1 5867.1 5894.2 5983.2 5997.9 6040.2 6060.8 6068.8 6070.2 5707.9 5749.7 5751.6 5754.3 5765.6 5728.7 5773.9 5842.4 5852.2 5888.8 5610.3 5641.8 5644.4 5656.4 5662.5 5579.4 5630.1 5665.5 5667.4 5686.5 5480.9 5559.9 5578.2 5644.7 5667.8 5642.9 5685.0 5701.1 5770.7 5775.2 5592.9 5594.1 5606.7 5611.7 5620.0 16:20:09 INFO - PROCESS | 6668 | 16:20:09 INFO - PROCESS | 6668 | [#1] ext.html Cycles:180 Average:54613.27 Median:40617.59 stddev:103783.95 (255.5%) stddev-sans-first:103995.86 16:20:09 INFO - PROCESS | 6668 | Values: 599.5 643.9 644.0 656.1 659.4 39116.2 40570.8 40810.0 41057.6 41119.2 41457.6 42362.2 42480.2 42668.8 42884.8 8870.5 9075.6 9084.5 9089.8 9109.2 8790.1 8966.2 8973.7 8983.3 9019.2 8957.6 8978.7 8992.8 9016.5 9036.1 8800.3 8948.9 8967.3 8971.7 9006.1 8916.0 9010.7 9016.1 9023.7 9066.8 40310.8 40720.8 41185.4 41226.6 41362.2 3725.3 3747.6 3828.2 4023.0 4250.1 31807.0 31888.5 32304.7 32635.2 33260.8 4267.7 4322.7 4331.6 4332.9 4383.2 233493.0 238155.0 238179.0 239090.0 301378.0 55911.4 56173.0 56862.0 56922.4 57145.4 55996.4 57015.0 57399.0 59268.0 59449.0 15604.9 15821.7 15936.8 15954.8 15958.2 11308.6 11332.8 11341.1 11348.5 11388.5 18913.5 18988.1 19025.6 19138.1 19198.8 7230.9 7297.2 7344.7 7491.9 7525.7 992.8 1051.2 1088.0 1132.1 1146.9 31136.0 31684.7 31835.7 31840.8 31848.4 1153.1 1164.1 1166.9 1171.4 1211.5 16760.9 16893.3 16913.2 16976.0 17211.9 510490.0 528234.0 529110.0 529257.0 530096.0 55257.7 56200.7 56275.4 56288.2 56392.0 1402.2 1413.1 1415.2 1427.4 1523.8 29585.0 29752.6 29891.1 30077.0 30364.5 50502.7 51143.7 51233.7 51405.0 51522.7 341286.0 348349.0 348589.0 349426.0 349616.0 39358.8 40879.6 41187.2 41385.6 41406.6 47420.8 47642.0 47824.5 48451.8 49083.5 36029.8 39552.4 39565.6 39776.6 39861.0 38165.0 38231.6 38587.0 39470.4 39565.6 32468.8 34692.3 39610.8 40093.8 40664.4 39313.4 40125.8 40272.0 40355.8 40499.6 30605.5 30898.5 31199.7 31304.7 32029.7 16:20:09 INFO - PROCESS | 6668 | 16:20:09 INFO - PROCESS | 6668 | [#2] jquery.html Cycles:180 Average:28375.28 Median:12364.16 stddev:79622.30 (644.0%) stddev-sans-first:79817.95 16:20:09 INFO - PROCESS | 6668 | Values: 395.0 397.8 400.6 401.7 403.5 17243.3 18049.3 18121.8 18197.7 20325.8 18584.9 18863.6 19007.3 19058.8 19455.1 5612.1 5663.1 5698.9 5762.8 5836.6 5707.8 5709.0 5731.5 5745.7 5754.0 5477.3 5497.7 5575.9 5576.5 5598.1 5527.1 5529.6 5549.3 5572.6 5604.7 4888.0 4952.0 5025.5 5046.1 5053.9 22451.9 22879.9 23247.3 23292.9 23332.2 1814.9 2178.5 2276.4 2284.5 2619.8 10050.3 10136.2 10285.9 10379.7 10497.6 1971.1 2004.3 2065.6 2071.4 2120.2 77399.6 79975.6 80501.0 81646.2 82339.6 11064.2 11084.7 11127.3 11319.6 11341.3 15674.8 15755.6 15818.5 15829.1 15845.3 7274.8 7727.3 8124.4 8158.7 8170.9 7531.7 7596.1 7708.8 7808.7 7810.7 4683.6 4687.0 4749.8 4769.9 4816.1 1971.6 1984.5 1996.6 1997.2 2041.4 952.3 1088.3 1089.7 1108.0 1121.4 17430.2 18285.8 18774.9 19098.4 19141.5 998.9 1013.1 1026.4 1046.7 1047.7 10526.6 10550.1 10701.1 10839.3 10896.2 475004.0 476337.0 482335.0 486222.0 502356.3 57115.1 66402.7 83499.2 83998.0 86946.7 1027.4 1072.0 1072.5 1077.2 1108.7 17329.6 17341.4 17426.9 17537.7 17724.4 39970.2 40282.6 40948.9 41192.2 43214.6 56744.1 58284.7 58842.1 59397.0 59997.7 7996.6 8053.6 8072.8 8226.5 8394.1 13350.5 14075.6 14104.8 14144.2 14248.8 11882.2 11922.7 11970.8 11991.3 12010.3 11575.7 11776.5 11842.3 12039.8 12066.0 12046.3 12097.6 12254.9 12441.8 12471.0 8454.0 8963.4 9043.6 9058.3 9086.5 11943.1 11967.4 12091.3 12136.5 12310.3 16:20:09 INFO - PROCESS | 6668 | 16:20:09 INFO - PROCESS | 6668 | [#3] mootools.html Cycles:180 Average:5566.92 Median:4969.37 stddev:3085.35 (62.1%) stddev-sans-first:3078.67 16:20:09 INFO - PROCESS | 6668 | Values: 1473.2 1525.4 1661.6 1763.5 1773.4 7364.6 7816.1 8053.7 8082.3 8096.4 8137.2 8197.3 8204.5 8214.6 8243.9 2282.3 2342.8 2352.6 2355.3 2358.4 2292.4 2301.6 2326.0 2342.1 2356.2 2308.5 2321.1 2328.9 2352.7 2355.3 2229.6 2238.5 2257.2 2259.2 2268.3 2240.7 2266.0 2274.3 2279.1 2291.0 8337.3 8405.0 8407.6 8440.0 8462.4 4957.4 5096.3 5123.1 5152.0 5153.7 3368.7 3449.7 3536.8 3563.6 3580.9 1115.9 1139.8 1165.5 1167.2 1168.1 11424.0 11433.9 11500.9 11521.9 11529.8 4426.0 4539.2 4559.7 4567.0 4568.5 9755.9 9826.8 9829.4 9845.5 9865.8 5130.2 5156.7 5157.5 5182.1 5195.9 4200.4 4461.5 4610.0 4645.3 4760.1 3876.9 3877.2 3941.6 3960.3 4016.6 1257.3 1295.3 1296.3 1304.2 1305.3 870.4 981.4 1000.8 1003.0 1005.6 5797.4 5930.1 5943.1 6052.6 6089.9 443.1 450.3 450.9 452.8 465.9 4027.9 4047.2 4094.7 4105.5 4167.5 9973.3 10376.5 10477.0 10528.4 10551.2 10238.0 10238.1 10254.9 10324.5 10370.4 7548.2 7809.1 7935.2 7985.9 7991.0 5782.4 5790.1 5856.4 5912.9 5954.9 9057.5 9482.9 9497.0 9541.0 9599.7 9553.9 9570.1 9688.0 9700.0 9824.3 6844.2 7276.4 7410.5 7546.3 7556.7 8089.9 8093.4 8118.8 8124.3 8168.7 7297.8 7365.8 7485.0 7589.5 7601.2 7150.1 7189.0 7361.2 7377.9 7494.3 6911.5 6953.9 6990.9 6999.1 7011.3 4892.1 4893.7 4940.7 4981.3 5059.7 5029.1 5079.9 5127.8 5155.1 5281.9 16:20:09 INFO - PROCESS | 6668 | 16:20:09 INFO - PROCESS | 6668 | [#4] prototype.html Cycles:180 Average:5037.02 Median:5604.12 stddev:1511.22 (27.0%) stddev-sans-first:1473.41 16:20:09 INFO - PROCESS | 6668 | Values: 320.5 332.0 334.6 339.3 340.1 5405.4 5428.5 5535.6 5555.9 5611.3 5516.8 5534.8 5565.0 5565.1 5596.9 4341.7 4367.1 4381.2 4387.9 4398.4 4066.0 4313.8 4315.8 4381.6 4390.6 4242.2 4259.5 4270.4 4272.7 4289.9 4274.3 4286.9 4308.8 4315.9 4316.2 3669.4 3770.8 3779.7 3783.9 3784.5 5371.4 5374.4 5378.4 5391.2 5412.2 5009.3 5020.2 5023.0 5025.1 5033.4 5494.8 5783.9 5841.6 5853.8 5858.4 4199.8 4206.1 4220.0 4223.6 4239.4 5994.4 6140.7 6147.7 6159.8 6169.1 4241.8 4331.1 4335.9 4346.6 4346.7 4359.8 4364.6 4403.0 4416.0 4422.5 4953.3 4971.9 4983.3 5002.8 5016.3 5699.0 5882.7 5894.9 5916.3 5923.7 1591.3 1595.7 1597.3 1600.2 1613.2 1075.8 1088.5 1088.7 1099.8 1112.4 6064.9 6082.1 6083.5 6102.0 6102.8 6422.4 6448.4 6460.5 6476.5 6487.6 5843.4 6080.9 6083.8 6088.9 6091.9 3396.4 3443.7 3452.1 3453.1 3453.5 6514.6 6602.5 6663.7 6665.4 6695.4 6495.6 6546.3 6557.5 6566.5 6569.4 6530.0 6626.9 6630.6 6707.9 6720.8 6382.8 6396.6 6415.4 6432.3 6438.6 5762.3 6343.6 6382.6 6383.1 6390.8 5936.3 6066.8 6268.5 6297.7 6315.6 4167.3 4210.6 4235.2 4237.3 4248.6 6051.7 6052.2 6065.6 6087.6 6104.2 5746.4 5857.7 5901.8 5913.3 5931.9 5827.5 5846.1 5865.8 5878.4 5884.8 5581.0 5762.7 5807.9 5811.2 5815.4 5845.7 5925.4 5929.4 5962.8 5963.5 5770.2 5774.1 5777.4 5781.2 5819.7 16:20:09 INFO - PROCESS | 6668 | 16:20:09 INFO - PROCESS | 6668 | [#5] yui.html Cycles:180 Average:15308.11 Median:46872.50 stddev:18883.09 (40.3%) stddev-sans-first:18904.50 16:20:09 INFO - PROCESS | 6668 | Values: 769.8 781.6 802.5 814.2 817.8 13842.2 14634.9 14647.0 14660.0 14719.4 13426.9 13439.2 13497.1 13501.3 13507.5 644.9 763.4 774.8 790.1 793.5 777.3 784.6 786.7 788.0 793.0 806.8 807.9 808.9 813.8 824.5 802.9 806.7 807.3 810.0 823.6 602.8 609.8 610.2 611.0 612.7 12969.9 12972.3 12984.4 12987.7 13027.7 13881.4 14013.5 14203.3 14251.0 14269.5 10955.2 11107.6 11335.6 11588.1 11624.5 3681.3 3694.8 3734.2 3803.2 3844.6 51098.7 51413.2 53140.0 53457.5 53804.2 10699.8 10862.9 10946.5 10946.7 11082.7 17826.7 18061.6 18195.1 18223.4 18418.5 8353.5 8378.1 8421.0 8442.2 8559.9 4877.0 4945.2 5015.3 5016.1 5196.5 3029.5 3150.8 3153.9 3160.2 3161.5 562.8 568.0 622.4 648.4 652.3 663.7 712.7 718.4 734.7 756.5 8252.6 8536.5 8608.6 8612.1 8622.4 625.8 670.2 704.9 712.4 749.9 3996.3 4066.7 4068.4 4079.8 4194.7 69267.0 70640.3 71443.3 71960.6 72082.0 63316.0 64070.4 64666.4 64948.0 66090.4 50747.5 52657.5 57231.7 57574.0 58152.7 7790.5 7794.2 7932.6 8026.8 8086.1 36076.3 36450.0 37486.4 37660.4 38336.4 43807.3 45621.0 48124.0 48530.8 49099.0 10871.1 11041.9 11114.2 11162.1 11291.3 11834.9 11914.4 12299.3 12377.3 12415.4 9900.8 10743.1 11539.2 11766.6 11818.5 11269.5 12007.6 12018.5 12089.2 12245.5 11718.5 12208.4 12375.5 12607.3 12720.7 10701.8 10731.7 10969.8 10975.7 11118.2 10452.9 10665.0 10928.5 11030.0 11039.9 16:20:09 INFO - PROCESS | 6668 | -------- Summary: end -------- 16:20:09 INFO - PROCESS | 6668 | 16:20:09 INFO - TEST-INFO | 6668: exit 0 16:20:09 INFO - TEST-OK | dromaeo_css | took 1109439ms 16:20:09 INFO - TEST-START | kraken 16:20:09 INFO - operating with platform_type : linux_ 16:20:09 INFO - Initialising browser for kraken test... 16:20:09 INFO - TEST-INFO | started process 6901 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfNE_Cj/profile http://localhost:34090/getInfo.html) 16:20:13 INFO - PROCESS | 6901 | 16:20:13 INFO - PROCESS | 6901 | (process:6971): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 16:20:14 INFO - PROCESS | 6901 | __metrics Screen width/height:1600/1200 16:20:14 INFO - PROCESS | 6901 | colorDepth:24 16:20:14 INFO - PROCESS | 6901 | Browser inner width/height: 1024/697 16:20:14 INFO - PROCESS | 6901 | __metrics 16:20:15 ERROR - PROCESS | 6901 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 16:20:15 INFO - TEST-INFO | 6901: exit 0 16:20:15 INFO - Browser initialized. 16:20:15 INFO - Running cycle 1/1 for kraken test... 16:20:15 INFO - TEST-INFO | started process 7022 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfNE_Cj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:20:17 INFO - PROCESS | 7022 | 16:20:17 INFO - PROCESS | 7022 | (process:7081): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 16:20:27 INFO - PROCESS | 7022 | RSS: Main: 164282368 16:20:27 INFO - PROCESS | 7022 | 16:20:30 INFO - PROCESS | 7022 | Cycle 1(1): loaded http://localhost:34090/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34090/tests/kraken/driver.html?testName=audio-beat-detection) 16:20:31 INFO - PROCESS | 7022 | RSS: Main: 168591360 16:20:31 INFO - PROCESS | 7022 | 16:20:33 INFO - PROCESS | 7022 | Cycle 1(1): loaded http://localhost:34090/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34090/tests/kraken/driver.html?testName=audio-dft) 16:20:34 INFO - PROCESS | 7022 | RSS: Main: 172441600 16:20:34 INFO - PROCESS | 7022 | 16:20:37 INFO - PROCESS | 7022 | Cycle 1(1): loaded http://localhost:34090/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34090/tests/kraken/driver.html?testName=audio-fft) 16:20:37 INFO - PROCESS | 7022 | RSS: Main: 163803136 16:20:37 INFO - PROCESS | 7022 | 16:20:40 INFO - PROCESS | 7022 | Cycle 1(1): loaded http://localhost:34090/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34090/tests/kraken/driver.html?testName=audio-oscillator) 16:20:40 INFO - PROCESS | 7022 | RSS: Main: 163467264 16:20:40 INFO - PROCESS | 7022 | 16:20:42 INFO - PROCESS | 7022 | Cycle 1(1): loaded http://localhost:34090/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34090/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:20:43 INFO - PROCESS | 7022 | RSS: Main: 164085760 16:20:43 INFO - PROCESS | 7022 | 16:20:46 INFO - PROCESS | 7022 | Cycle 1(1): loaded http://localhost:34090/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34090/tests/kraken/driver.html?testName=imaging-darkroom) 16:20:47 INFO - PROCESS | 7022 | RSS: Main: 164749312 16:20:47 INFO - PROCESS | 7022 | 16:20:50 INFO - PROCESS | 7022 | Cycle 1(1): loaded http://localhost:34090/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34090/tests/kraken/driver.html?testName=imaging-desaturate) 16:20:51 INFO - PROCESS | 7022 | RSS: Main: 164659200 16:20:51 INFO - PROCESS | 7022 | 16:20:53 INFO - PROCESS | 7022 | Cycle 1(1): loaded http://localhost:34090/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34090/tests/kraken/driver.html?testName=json-parse-financial) 16:20:54 INFO - PROCESS | 7022 | RSS: Main: 167280640 16:20:54 INFO - PROCESS | 7022 | 16:20:56 INFO - PROCESS | 7022 | Cycle 1(1): loaded http://localhost:34090/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34090/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:20:56 INFO - PROCESS | 7022 | RSS: Main: 166936576 16:20:56 INFO - PROCESS | 7022 | 16:20:58 INFO - PROCESS | 7022 | Cycle 1(1): loaded http://localhost:34090/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34090/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:20:59 INFO - PROCESS | 7022 | RSS: Main: 166871040 16:20:59 INFO - PROCESS | 7022 | 16:21:01 INFO - PROCESS | 7022 | Cycle 1(1): loaded http://localhost:34090/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34090/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:21:01 INFO - PROCESS | 7022 | RSS: Main: 167243776 16:21:01 INFO - PROCESS | 7022 | 16:21:04 INFO - PROCESS | 7022 | Cycle 1(1): loaded http://localhost:34090/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34090/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:21:05 INFO - PROCESS | 7022 | RSS: Main: 167809024 16:21:05 INFO - PROCESS | 7022 | 16:21:07 INFO - PROCESS | 7022 | Cycle 1(1): loaded http://localhost:34090/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34090/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:21:08 INFO - PROCESS | 7022 | RSS: Main: 167866368 16:21:08 INFO - PROCESS | 7022 | 16:21:10 INFO - PROCESS | 7022 | Cycle 1(1): loaded http://localhost:34090/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34090/tests/kraken/driver.html?testName=ai-astar) 16:21:10 INFO - PROCESS | 7022 | RSS: Main: 169435136 16:21:10 INFO - PROCESS | 7022 | 16:21:10 INFO - PROCESS | 7022 | __start_tp_report 16:21:10 INFO - PROCESS | 7022 | _x_x_mozilla_page_load 16:21:10 INFO - PROCESS | 7022 | _x_x_mozilla_page_load_details 16:21:10 INFO - PROCESS | 7022 | |i|pagename|runs| 16:21:10 INFO - PROCESS | 7022 | |0;ai-astar;114;107;112;111;112;126;113;113;113;117 16:21:10 INFO - PROCESS | 7022 | |1;audio-beat-detection;159;130;151;178;135;156;159;128;196;128 16:21:10 INFO - PROCESS | 7022 | |2;audio-dft;163;162;162;161;163;164;167;165;164;163 16:21:10 INFO - PROCESS | 7022 | |3;audio-fft;73;73;73;169;77;77;73;73;151;77 16:21:10 INFO - PROCESS | 7022 | |4;audio-oscillator;92;94;146;95;93;93;146;93;92;139 16:21:10 INFO - PROCESS | 7022 | |5;imaging-gaussian-blur;118;117;117;117;117;119;118;117;117;118 16:21:10 INFO - PROCESS | 7022 | |6;imaging-darkroom;146;147;146;146;147;146;147;147;147;146 16:21:10 INFO - PROCESS | 7022 | |7;imaging-desaturate;95;96;95;98;96;96;95;95;94;95 16:21:10 INFO - PROCESS | 7022 | |8;json-parse-financial;59;61;58;60;59;60;61;81;58;58 16:21:10 INFO - PROCESS | 7022 | |9;json-stringify-tinderbox;61;61;61;62;62;62;62;62;62;62 16:21:10 INFO - PROCESS | 7022 | |10;stanford-crypto-aes;76;82;84;76;77;79;78;76;78;79 16:21:10 INFO - PROCESS | 7022 | |11;stanford-crypto-ccm;125;126;124;132;127;131;123;133;153;133 16:21:10 INFO - PROCESS | 7022 | |12;stanford-crypto-pbkdf2;167;174;167;167;163;166;166;165;167;172 16:21:10 INFO - PROCESS | 7022 | |13;stanford-crypto-sha256-iterative;69;69;71;69;70;69;77;68;69;68 16:21:10 INFO - PROCESS | 7022 | __end_tp_report 16:21:10 INFO - PROCESS | 7022 | __start_cc_report 16:21:10 INFO - PROCESS | 7022 | _x_x_mozilla_cycle_collect,853 16:21:10 INFO - PROCESS | 7022 | __end_cc_report 16:21:10 INFO - PROCESS | 7022 | __startTimestamp1461799270554__endTimestamp 16:21:10 INFO - PROCESS | 7022 | 16:21:10 INFO - PROCESS | 7022 | ------- Summary: start ------- 16:21:10 INFO - PROCESS | 7022 | Number of tests: 14 16:21:10 INFO - PROCESS | 7022 | 16:21:10 INFO - PROCESS | 7022 | [#0] ai-astar Cycles:10 Average:113.80 Median:113.00 stddev:4.96 (4.4%) stddev-sans-first:5.26 16:21:10 INFO - PROCESS | 7022 | Values: 114.0 107.0 112.0 111.0 112.0 126.0 113.0 113.0 113.0 117.0 16:21:10 INFO - PROCESS | 7022 | 16:21:10 INFO - PROCESS | 7022 | [#1] audio-beat-detection Cycles:10 Average:152.00 Median:157.50 stddev:22.74 (14.4%) stddev-sans-first:23.97 16:21:10 INFO - PROCESS | 7022 | Values: 159.0 130.0 151.0 178.0 135.0 156.0 159.0 128.0 196.0 128.0 16:21:10 INFO - PROCESS | 7022 | 16:21:10 INFO - PROCESS | 7022 | [#2] audio-dft Cycles:10 Average:163.40 Median:163.50 stddev:1.71 (1.0%) stddev-sans-first:1.81 16:21:10 INFO - PROCESS | 7022 | Values: 163.0 162.0 162.0 161.0 163.0 164.0 167.0 165.0 164.0 163.0 16:21:10 INFO - PROCESS | 7022 | 16:21:10 INFO - PROCESS | 7022 | [#3] audio-fft Cycles:10 Average:91.60 Median:73.00 stddev:36.34 (49.8%) stddev-sans-first:37.92 16:21:10 INFO - PROCESS | 7022 | Values: 73.0 73.0 73.0 169.0 77.0 77.0 73.0 73.0 151.0 77.0 16:21:10 INFO - PROCESS | 7022 | 16:21:10 INFO - PROCESS | 7022 | [#4] audio-oscillator Cycles:10 Average:108.30 Median:93.00 stddev:24.50 (26.3%) stddev-sans-first:25.26 16:21:10 INFO - PROCESS | 7022 | Values: 92.0 94.0 146.0 95.0 93.0 93.0 146.0 93.0 92.0 139.0 16:21:10 INFO - PROCESS | 7022 | 16:21:10 INFO - PROCESS | 7022 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:117.50 stddev:0.71 (0.6%) stddev-sans-first:0.73 16:21:10 INFO - PROCESS | 7022 | Values: 118.0 117.0 117.0 117.0 117.0 119.0 118.0 117.0 117.0 118.0 16:21:10 INFO - PROCESS | 7022 | 16:21:10 INFO - PROCESS | 7022 | [#6] imaging-darkroom Cycles:10 Average:146.50 Median:147.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 16:21:10 INFO - PROCESS | 7022 | Values: 146.0 147.0 146.0 146.0 147.0 146.0 147.0 147.0 147.0 146.0 16:21:10 INFO - PROCESS | 7022 | 16:21:10 INFO - PROCESS | 7022 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:95.50 stddev:1.08 (1.1%) stddev-sans-first:1.13 16:21:10 INFO - PROCESS | 7022 | Values: 95.0 96.0 95.0 98.0 96.0 96.0 95.0 95.0 94.0 95.0 16:21:10 INFO - PROCESS | 7022 | 16:21:10 INFO - PROCESS | 7022 | [#8] json-parse-financial Cycles:10 Average:61.50 Median:60.00 stddev:6.95 (11.6%) stddev-sans-first:7.31 16:21:10 INFO - PROCESS | 7022 | Values: 59.0 61.0 58.0 60.0 59.0 60.0 61.0 81.0 58.0 58.0 16:21:10 INFO - PROCESS | 7022 | 16:21:10 INFO - PROCESS | 7022 | [#9] json-stringify-tinderbox Cycles:10 Average:61.70 Median:62.00 stddev:0.48 (0.8%) stddev-sans-first:0.44 16:21:10 INFO - PROCESS | 7022 | Values: 61.0 61.0 61.0 62.0 62.0 62.0 62.0 62.0 62.0 62.0 16:21:10 INFO - PROCESS | 7022 | 16:21:10 INFO - PROCESS | 7022 | [#10] stanford-crypto-aes Cycles:10 Average:78.50 Median:78.50 stddev:2.68 (3.4%) stddev-sans-first:2.68 16:21:10 INFO - PROCESS | 7022 | Values: 76.0 82.0 84.0 76.0 77.0 79.0 78.0 76.0 78.0 79.0 16:21:10 INFO - PROCESS | 7022 | 16:21:10 INFO - PROCESS | 7022 | [#11] stanford-crypto-ccm Cycles:10 Average:130.70 Median:131.50 stddev:8.71 (6.6%) stddev-sans-first:8.99 16:21:10 INFO - PROCESS | 7022 | Values: 125.0 126.0 124.0 132.0 127.0 131.0 123.0 133.0 153.0 133.0 16:21:10 INFO - PROCESS | 7022 | 16:21:10 INFO - PROCESS | 7022 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.40 Median:167.00 stddev:3.24 (1.9%) stddev-sans-first:3.43 16:21:10 INFO - PROCESS | 7022 | Values: 167.0 174.0 167.0 167.0 163.0 166.0 166.0 165.0 167.0 172.0 16:21:10 INFO - PROCESS | 7022 | 16:21:10 INFO - PROCESS | 7022 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.90 Median:69.00 stddev:2.64 (3.8%) stddev-sans-first:2.78 16:21:10 INFO - PROCESS | 7022 | Values: 69.0 69.0 71.0 69.0 70.0 69.0 77.0 68.0 69.0 68.0 16:21:10 INFO - PROCESS | 7022 | -------- Summary: end -------- 16:21:10 INFO - PROCESS | 7022 | 16:21:11 INFO - TEST-INFO | 7022: exit 0 16:21:11 INFO - TEST-OK | kraken | took 61605ms 16:21:11 INFO - SUITE-END | took 1171s 16:21:11 INFO - Completed test suite (00:19:31) 16:21:11 INFO - javascript benchmark 16:21:11 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3134.388794185134, 3179.7138257556817, 3188.5376620390043, 3231.773775835691, 3235.0294911526553, 5402.108652072408, 5405.783768649254, 5420.214068959998, 5439.782408703657, 5441.428649991753, 5294.92057619136, 5343.305370301865, 5383.057964856154, 5478.397376288615, 5593.161025846125, 4880.3655524781725, 4911.484294149099, 4948.430930442991, 4985.576226020775, 5017.69893806371, 853.4174914135009, 4837.4195096588455, 4945.752712364385, 4956.281339205813, 4962.478939711333, 4904.558589726924, 4908.877278068041, 4921.606271498272, 4928.901421971558, 4971.527704868014, 4797.568218860284, 4936.555709986119, 4950.8267210647455, 4953.801847926079, 5000.399952005782, 4888.706677599355, 4902.828401005948, 4944.035912996967, 4950.579200767939, 4956.851294461172, 5299.152135658314, 5314.601404894648, 5339.252504649352, 5339.5728341732565, 5340.465953404668, 5743.971280143614, 5773.769049238025, 5777.046787280094, 5780.393058728857, 5855.707214639251, 5769.307683078057, 5876.236089308405, 5880.4119588041285, 5893.7053147342895, 5911.674857882857, 5414.485623865727, 5450.482204190595, 5470.070088084995, 5474.124140137559, 5478.643888147258, 5805.883882322414, 5899.321578018583, 5934.080217566284, 5984.700764961734, 5998.550108741774, 5712.542996560265, 5757.971210144006, 5759.65442073477, 5765.394633563499, 5765.971170144123, 5820.621659592198, 5823.097419899922, 5833.912491312549, 5841.065429531254, 5843.941560584425, 5664.85837854057, 5869.148973398833, 5892.499137573354, 5903.911441328383, 5984.102384642251, 5664.20701101846, 5744.109663002241, 5768.278965129359, 5823.970880145657, 5879.029960056543, 4366.279563871925, 4371.69398142127, 4377.518472967971, 4378.60592546666, 4418.226810308183, 3876.5735769065946, 3880.728349015542, 3918.941215881764, 3919.5296564411883, 3978.3435733104293, 5547.140193270049, 5597.384287728347, 5599.132134519156, 5605.215269862222, 5643.209950606918, 5770.855728606734, 5834.27071616048, 5837.562182836305, 5860.765569377178, 5872.706364681749, 5458.344998600193, 5477.096279113981, 5557.110862262019, 5558.138488534284, 5566.55467562594, 4988.052270068675, 5013.897106716872, 5026.045051440287, 5045.192769156917, 5055.443901170868, 6076.665783381868, 6080.574359794772, 6097.664628445478, 6101.786437474756, 6131.693415329216, 5693.117566777239, 5791.102379131242, 5867.119932010062, 5894.204282421818, 5983.222181116427, 5997.850053748692, 6040.184575082308, 6060.818175454743, 6068.787592434243, 6070.18052562916, 5707.942920570741, 5749.741261643319, 5751.626144300607, 5754.338251101177, 5765.56758243125, 5728.684922329312, 5773.913391299218, 5842.357340692605, 5852.239208902815, 5888.823335299948, 5610.270664813548, 5641.774329026793, 5644.350899646429, 5656.43435656431, 5662.490375866192, 5579.414161513145, 5630.127330263816, 5665.49010589049, 5667.376588575171, 5686.516646084963, 5480.91778623313, 5559.9444005561045, 5578.219049333015, 5644.6613203207935, 5667.773289068391, 5642.943570564242, 5685.033544297562, 5701.116326969326, 5770.711464426846, 5775.191473193672, 5592.916106258491, 5594.104943209067, 5606.719664016701, 5611.691356975405, 5620.04459241938], "value": 5331.736428338797, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [599.4814485470067, 643.8776632439836, 643.9742410303583, 656.1175219330001, 659.4032400677386, 39116.217675646505, 40570.7971460143, 40810.0, 41057.58942410575, 41119.177616447654, 41457.58542414575, 42362.152756944844, 42480.150396992045, 42668.78665606667, 42884.78557607208, 8870.51212183328, 9075.591598378089, 9084.454932704059, 9089.772755681128, 9109.180173784358, 8790.077041910603, 8966.193042626162, 8973.685920992766, 8983.281337492985, 9019.23336516397, 8957.552122393887, 8978.685745998891, 8992.820143597124, 9016.459012459241, 9036.096390360977, 8800.339974501905, 8948.910510894873, 8967.282617390625, 8971.730848074569, 9006.144416280444, 8915.955420222923, 9010.684626038123, 9016.05331440196, 9023.684171053981, 9066.818663626756, 40310.79844600758, 40720.79639601813, 41185.382219266736, 41226.58773412288, 41362.172756545, 3725.2549490102087, 3747.569029561608, 3828.2152158807376, 4023.0, 4250.107477429743, 31807.0, 31888.521672174935, 32304.676953230402, 32635.18412039694, 33260.83369583161, 4267.679924005712, 4322.7190232634775, 4331.610155086026, 4332.870013899556, 4383.211022016036, 233493.0, 238155.0, 238179.0, 239090.0, 301378.0, 55911.44088559144, 56173.0, 56862.0, 56922.43077569254, 57145.42854571484, 55996.44003559994, 57015.0, 57399.0, 59268.0, 59449.0, 15604.921975390278, 15821.683566328838, 15936.760948585781, 15954.840451595335, 15958.202089895458, 11308.604198853165, 11332.773344533063, 11341.092712582973, 11348.546058157746, 11388.487518061707, 18913.527161821065, 18988.05059747007, 19025.619487610446, 19138.138783754763, 19198.8080119197, 7230.927690723131, 7297.233790451926, 7344.669489872968, 7491.925080749123, 7525.736599219001, 992.771662517625, 1051.1800795379615, 1087.983680244797, 1132.0943245403644, 1146.8817902545118, 31136.0, 31684.683153168633, 31835.681643183736, 31840.840795795873, 31848.363032739217, 1153.146671463128, 1164.0978241862624, 1166.8891455311732, 1171.4025846818183, 1211.4608998995363, 16760.916195418944, 16893.32426702918, 16913.238904249338, 16976.0, 17211.91394043022, 510490.0, 528234.0, 529110.0, 529257.0, 530096.0, 55257.72371138199, 56200.71899640476, 56275.437245627836, 56288.155677664865, 56392.0, 1402.2217669193492, 1413.1097408632495, 1415.2004117673482, 1427.414759948416, 1523.8190402437976, 29585.0, 29752.553711694774, 29891.103266902028, 30077.0, 30364.544531831598, 50502.747486262335, 51143.744281278356, 51233.743831280604, 51405.0, 51522.74238628783, 341286.0, 348349.0, 348589.0, 349426.0, 349616.0, 39358.803205983786, 40879.59120408758, 41187.1762564741, 41385.58614413817, 41406.585934140276, 47420.7628961853, 47642.0, 47824.52175478201, 48451.75774121107, 49083.5091649079, 36029.819850900574, 39552.40671389989, 39565.60434395734, 39776.60223397729, 39861.003474913356, 38165.0, 38231.617683822806, 38587.0, 39470.40794388144, 39565.60434395734, 32468.837655812516, 34692.30615387729, 39610.80194599008, 40093.79953100216, 40664.39003414892, 39313.41029884497, 40125.79937100413, 40272.0, 40355.79822100871, 40499.59500405076, 30605.540916886708, 30898.53652195264, 31199.688003119678, 31304.686953130178, 32029.67970320267], "value": 19964.28552333052, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [394.9782761948093, 397.84682897084616, 400.6394245179339, 401.66059679570753, 403.5157810627248, 17243.3102675893, 18049.27802887883, 18121.818781812195, 18197.7270340945, 20325.796742032577, 18584.90707546464, 18863.62272754544, 19007.334743283987, 19058.809411905877, 19455.124519396624, 5612.07400778871, 5663.122216056508, 5698.886022279552, 5762.827115186551, 5836.620619659709, 5707.800226992056, 5709.0, 5731.484166425021, 5745.712714364286, 5753.971230143843, 5477.3427188737205, 5497.725113744316, 5575.8606034849045, 5576.498115169634, 5598.1322894951145, 5527.088030474967, 5529.640573362759, 5549.306336707911, 5572.60991730579, 5604.747786349603, 4888.022395520875, 4951.950480495221, 5025.547700706954, 5046.116929537353, 5053.898922021539, 22451.887740561357, 22879.88560057189, 23247.3025809226, 23292.883535582383, 23332.183373581844, 1814.8911065336122, 2178.455386153462, 2276.435746328617, 2284.5430913817136, 2619.751123643251, 10050.296479246455, 10136.189104871593, 10285.9485702571, 10379.688609341732, 10497.632582859564, 1971.083446197525, 2004.2877798274947, 2065.555905480329, 2071.3682326890294, 2120.1837292642444, 77399.61300193463, 79975.60012199901, 80501.0, 81646.18353816445, 82339.5883020587, 11064.170187235828, 11084.722881928017, 11127.27672701288, 11319.603813866475, 11341.319520828776, 15674.764878526832, 15755.606109847116, 15818.525444236691, 15829.050256984618, 15845.286962086733, 7274.818129546804, 7727.343175830005, 8124.431289809657, 8158.714444994397, 8170.877436838452, 7531.736389226351, 7596.088469383599, 7708.8458230836195, 7808.726694565663, 7810.6875724971505, 4683.648726345469, 4687.039156972813, 4749.833755818529, 4769.856904292877, 4816.109019831342, 1971.5761111361126, 1984.5435549823621, 1996.5507760753715, 1997.2011195521907, 2041.428400047989, 952.3286083311249, 1088.259983211408, 1089.6894385100209, 1108.013867657785, 1121.3888430805068, 17430.215640296217, 18285.817141828677, 18774.906125469286, 19098.427047188605, 19141.521461963563, 998.9350692204983, 1013.083159740436, 1026.4457193115784, 1046.7383154211448, 1047.7328281288223, 10526.631567895087, 10550.103241224428, 10701.09040731531, 10839.349639021684, 10896.182786290901, 475004.0, 476337.0, 482335.0, 486222.0, 502356.3468374544, 57115.14327285094, 66402.66798665976, 83499.16500834914, 83998.0, 86946.69579956305, 1027.4349107990724, 1071.978560428787, 1072.4744875011188, 1077.2405454154803, 1108.695108845058, 17329.56676083108, 17341.393051243147, 17426.86725362898, 17537.684673649273, 17724.379646712303, 39970.2005959885, 40282.590109346034, 40948.9494271864, 41192.176156476104, 43214.56785432105, 56744.14883776829, 58284.70857645854, 58842.11736824037, 59397.0, 59997.70001149966, 7996.6401511930935, 8053.597320134087, 8072.757817265491, 8226.506409615442, 8394.0766515682, 13350.465981360638, 14075.648108796953, 14104.78842817338, 14144.22206778637, 14248.786268206193, 11882.227655202385, 11922.701932451759, 11970.76058478843, 11991.280523168638, 12010.279383237033, 11575.652730418102, 11776.470058847544, 11842.348670823187, 12039.75920481568, 12066.0, 12046.337451439904, 12097.57658481984, 12254.87745122573, 12441.813372799234, 12471.0, 8454.0, 8963.372563920462, 9043.55303151519, 9058.320625953213, 9086.45481271126, 11943.104267179822, 11967.401629918644, 12091.334976576021, 12136.453859576164, 12310.26138431697], "value": 9192.244405607313, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1473.1823837770037, 1525.3593490733895, 1661.5846038490376, 1763.5150333658241, 1773.3793172389674, 7364.631768411571, 7816.1402245753, 8053.718119865805, 8082.313003394711, 8096.352291816655, 8137.226963438478, 8197.344212463004, 8204.507729536232, 8214.630341634625, 8243.91756082439, 2282.281081459339, 2342.8008619267384, 2352.5765362234793, 2355.281639100074, 2358.433975845793, 2292.426893276681, 2301.6317389217643, 2326.0, 2342.051469154995, 2356.22244659262, 2308.4575124845646, 2321.117975169433, 2328.871912044837, 2352.6588644646517, 2355.281639100074, 2229.576380487702, 2238.507528343762, 2257.1761307122865, 2259.20927675314, 2268.3308424014954, 2240.708707867983, 2265.9660105098437, 2274.3404412720292, 2279.054192510123, 2291.014863608648, 8337.291330236938, 8404.957975210145, 8407.579621018986, 8440.0, 8462.4076314658, 4957.405111386621, 5096.337476128117, 5123.077845987758, 5152.0, 5153.665011774223, 3368.713659338959, 3449.741269404805, 3536.8054756988354, 3563.5901871284614, 3580.946285805715, 1115.8884111588857, 1139.7720455908768, 1165.4755360087995, 1167.2296284452307, 1168.0655475619556, 11424.0, 11433.885661143366, 11500.884991150066, 11521.942390288079, 11529.769404611861, 4426.0, 4539.182947069493, 4559.749213793273, 4567.040921406542, 4568.451785785727, 9755.853662195073, 9826.80346393068, 9829.361091529028, 9845.50772461374, 9865.753356166153, 5130.1535246684625, 5156.690598564098, 5157.484251574812, 5182.093133701663, 5195.870103247374, 4200.369944508348, 4461.464624245046, 4610.0, 4645.279981602857, 4760.09558183944, 3876.9418458723144, 3877.166409222031, 3941.6058394160927, 3960.2871483132735, 4016.6385025347276, 1257.3084803358117, 1295.33290355467, 1296.293520031585, 1304.2370213425252, 1305.340802894532, 870.4429165334191, 981.4062492192263, 1000.8298589239847, 1002.9749256268506, 1005.5575546759402, 5797.391273916262, 5930.11048342752, 5943.078822782476, 6052.636841789418, 6089.908651370233, 443.080607738943, 450.34474839109015, 450.9210888094636, 452.80076766222754, 465.8998315362213, 4027.939580906289, 4047.1500984793524, 4094.651954583834, 4105.486814148231, 4167.499900012018, 9973.252006099572, 10376.481175941173, 10477.0, 10528.368297901998, 10551.20865935058, 10238.0, 10238.078572928323, 10254.897451025543, 10324.535395907202, 10370.377777333384, 7548.245175482518, 7809.140994490602, 7935.1668074853615, 7985.880211796828, 7991.0, 5782.363939966516, 5790.10253410722, 5856.443637854397, 5912.940870591411, 5954.940450595439, 9057.501837399006, 9482.857757133786, 9496.952515237379, 9541.0, 9599.712008639752, 9553.90446095558, 9570.090841370058, 9688.0, 9700.029997000243, 9824.263180261367, 6844.247132815287, 7276.381507571704, 7410.481266311306, 7546.2831031051965, 7556.65995030236, 8089.9191008089165, 8093.352531797324, 8118.75643730689, 8124.309433697966, 8168.714095006646, 7297.817554561178, 7365.8158546036775, 7485.026946496921, 7589.506682065648, 7601.239876012576, 7150.10623672041, 7189.0, 7361.153467351323, 7377.926220737724, 7494.250574942462, 6911.481638877004, 6953.895691564529, 6990.860182796418, 6999.12510936133, 7011.263817299314, 4892.143874821963, 4893.73084480357, 4940.7035577865445, 4981.327520784647, 5059.671121377099, 5029.119904016709, 5079.92380114306, 5127.769250383816, 5155.072087024221, 5281.867953301198], "value": 4439.0520612199225, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [320.52882263073286, 331.96016478022625, 334.6001528173833, 339.2807248632899, 340.14453649072584, 5405.405405405412, 5428.4842939920745, 5535.557155427567, 5555.944440555593, 5611.298587676541, 5516.834494965147, 5534.806281780138, 5565.0, 5565.1374037024225, 5596.944030559694, 4341.6526677865695, 4367.148406060819, 4381.233284175257, 4387.934180987288, 4398.4062151609605, 4066.0, 4313.849015284466, 4315.805788739499, 4381.561843815625, 4390.560943905616, 4242.172776308621, 4259.487881801962, 4270.402143699885, 4272.679549033819, 4289.914201715979, 4274.316109422493, 4286.892827679302, 4308.849190278356, 4315.870523884289, 4316.2446571849805, 3669.3578623740736, 3770.811459427045, 3779.716521260889, 3783.905402364963, 3784.526934133233, 5371.382291036542, 5374.381946076212, 5378.354597448331, 5391.191321301797, 5412.161115027177, 5009.323741294915, 5020.221865610836, 5023.0, 5025.0954828130925, 5033.421156567005, 5494.780208791643, 5783.913241301384, 5841.561882858802, 5853.76584936602, 5858.3848695886745, 4199.7690127043, 4206.095689426757, 4219.97890010548, 4223.64099051581, 4239.364095385686, 5994.411480957549, 6140.7236674349315, 6147.692615369214, 6159.7536098556, 6169.105479705462, 4241.833495788683, 4331.112122014979, 4335.869923902288, 4346.587074227943, 4346.695731298779, 4359.847405340861, 4364.585364390377, 4403.0, 4415.977920110379, 4422.513523512411, 4953.2570114483115, 4971.925421118686, 4983.302337672729, 5002.799328161215, 5016.347874776328, 5698.971505142531, 5882.676452795052, 5894.941050589525, 5916.290045194604, 5923.703814809242, 1591.3475475055172, 1595.7367034439187, 1597.297189236732, 1600.199900049975, 1613.1692178528067, 1075.833245846895, 1088.5319312695617, 1088.689723428819, 1099.828682453185, 1112.3826276416667, 6064.9090263646085, 6082.118092876508, 6083.452489275986, 6101.969490152521, 6102.755889764359, 6422.389872962061, 6448.355164483608, 6460.483161347081, 6476.481881449473, 6487.643179625072, 5843.3864444233595, 6080.878382432326, 6083.783243351348, 6088.878222435526, 6091.939080609137, 3396.371671240779, 3443.6728510791436, 3452.1369657585606, 3453.1021934297264, 3453.4992426098074, 6514.641694706742, 6602.524053479945, 6663.700133494004, 6665.366790154928, 6695.397414232742, 6495.642739649365, 6546.297962529777, 6557.540972132, 6566.507511936624, 6569.408753212234, 6530.0, 6626.9337306627285, 6630.569013014235, 6707.899381509281, 6720.764773232913, 6382.808515744535, 6396.584222025554, 6415.390537898892, 6432.324605916311, 6438.649892789192, 5762.337331206797, 6343.619382837044, 6382.648954307558, 6383.1382763326355, 6390.840228994312, 5936.317323507852, 6066.848328791639, 6268.4955610652205, 6297.716602752796, 6315.55791094619, 4167.291560434794, 4210.63154474803, 4235.195312890541, 4237.279662457451, 4248.640435060751, 6051.727672254671, 6052.2132122825515, 6065.575409721454, 6087.604305720114, 6104.17593624855, 5746.396628353963, 5857.677827719516, 5901.822945311647, 5913.29040515141, 5931.911021334769, 5827.475527202572, 5846.123081537633, 5865.824025279248, 5878.353381128158, 5884.763789760035, 5580.972095139498, 5762.740676669644, 5807.8548036299435, 5811.215485909348, 5815.360310365941, 5845.707714614337, 5925.4370834770625, 5929.407059294036, 5962.791302304398, 5963.463288304073, 5770.192173095854, 5774.105013722879, 5777.353454265514, 5781.190633311424, 5819.679917604572], "value": 4559.209615781222, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [769.7536788227762, 781.6258412644879, 802.4783890471197, 814.1939479914886, 817.8200795824919, 13842.169469831804, 14634.853651463482, 14647.0, 14660.047096938719, 14719.411223551058, 13426.865731342683, 13439.193648381104, 13497.055206135574, 13501.2574308413, 13507.527236546723, 644.935506449356, 763.3816608547081, 774.7559518751603, 790.0519376747897, 793.4842352470882, 777.2577188784697, 784.6390660296271, 786.6656670914867, 788.0464637788283, 792.9960350198241, 806.822499050208, 807.8828569857396, 808.8584497712906, 813.7965508622844, 824.4805772363403, 802.8715405535115, 806.6531391501652, 807.2653884964654, 810.0441479054713, 823.6211342782298, 602.8071017274474, 609.8261995331353, 610.1640752169557, 611.0071134406589, 612.6691586543261, 12969.935150324281, 12972.286524241163, 12984.350782460839, 12987.675308117277, 13027.674308142277, 13881.375338109709, 14013.5095271665, 14203.289835508183, 14251.0, 14269.500567480192, 10955.17836162291, 11107.611233606785, 11335.603253886075, 11588.07295416373, 11624.476898539586, 3681.2821499807546, 3694.7967861767593, 3734.1971476132762, 3803.1633040730994, 3844.5770965193806, 51098.74450627723, 51413.22880156801, 53140.0, 53457.465425346025, 53804.192937105974, 10699.786004280026, 10862.945685271523, 10946.507407166697, 10946.726331841768, 11082.722931926766, 17826.732599011026, 18061.638767224846, 18195.090245487674, 18223.362182323555, 18418.539536511427, 8353.457025293457, 8378.078411374743, 8421.0, 8442.197991190827, 8559.871601925975, 4876.951230487721, 4945.208766597327, 5015.3480047593575, 5016.097102521581, 5196.506331898464, 3029.5304227844717, 3150.8109513429267, 3153.858076386568, 3160.1625569224175, 3161.5257711343484, 562.8086450606813, 567.9829605111853, 622.3745136138152, 648.4067078623007, 652.2629428745487, 663.7079684938611, 712.7434123715458, 718.4001358865406, 734.6730704836297, 756.5498528375608, 8252.595670411807, 8536.530490822941, 8608.612612432456, 8612.095729948265, 8622.353323500762, 625.8497960489541, 670.1723371636026, 704.9295070493013, 712.3846479118495, 749.9287567681062, 3996.2806694795217, 4066.67466602677, 4068.3888680893547, 4079.755214687128, 4194.748315101104, 69267.0, 70640.2935970644, 71443.28556714367, 71960.64019679972, 72082.0, 63316.0, 64070.35929640737, 64666.35333646697, 64948.0, 66090.35638574499, 50747.49252507502, 52657.473425265256, 57231.71384143136, 57574.0, 58152.70923645439, 7790.5325680459355, 7794.181610930771, 7932.6430310637315, 8026.799330016563, 8086.070101938352, 36076.27847443089, 36450.0, 37486.43770343393, 37660.43509347417, 38336.42495362516, 43807.34288985732, 45621.0, 48124.0, 48530.757346213046, 49099.0, 10871.069041540408, 11041.889581104408, 11114.166437517057, 11162.107031437303, 11291.266067705574, 11834.940825295818, 11914.40427978615, 12299.262044277371, 12377.257364558156, 12415.44130514111, 9900.752481188028, 10743.140548755924, 11539.19225654196, 11766.588169414372, 11818.527258909548, 11269.549218031514, 12007.639770806889, 12018.459169337226, 12089.214201076902, 12245.510179592717, 11718.531258749554, 12208.351355516932, 12375.504979800708, 12607.306598137191, 12720.74558508843, 10701.785964280827, 10731.678049658523, 10969.780604388026, 10975.725606859573, 11118.166137539554, 10452.895471045193, 10665.0, 10928.508217130408, 11030.0, 11039.889601103887], "value": 6636.445453356642, "unit": "score"}], "name": "dromaeo_css", "value": 7130.453378240142, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 107.0, 112.0, 111.0, 112.0, 126.0, 113.0, 113.0, 113.0, 117.0], "value": 113.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 130.0, 151.0, 178.0, 135.0, 156.0, 159.0, 128.0, 196.0, 128.0], "value": 152.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 162.0, 161.0, 163.0, 164.0, 167.0, 165.0, 164.0, 163.0], "value": 163.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 73.0, 73.0, 169.0, 77.0, 77.0, 73.0, 73.0, 151.0, 77.0], "value": 91.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 94.0, 146.0, 95.0, 93.0, 93.0, 146.0, 93.0, 92.0, 139.0], "value": 108.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 117.0, 117.0, 119.0, 118.0, 117.0, 117.0, 118.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 146.0, 146.0, 147.0, 146.0, 147.0, 147.0, 147.0, 146.0], "value": 146.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 98.0, 96.0, 96.0, 95.0, 95.0, 94.0, 95.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 61.0, 58.0, 60.0, 59.0, 60.0, 61.0, 81.0, 58.0, 58.0], "value": 61.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 61.0, 62.0, 62.0, 62.0, 62.0, 62.0, 62.0, 62.0], "value": 61.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 82.0, 84.0, 76.0, 77.0, 79.0, 78.0, 76.0, 78.0, 79.0], "value": 78.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 126.0, 124.0, 132.0, 127.0, 131.0, 123.0, 133.0, 153.0, 133.0], "value": 130.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 174.0, 167.0, 167.0, 163.0, 166.0, 166.0, 165.0, 167.0, 172.0], "value": 167.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 69.0, 71.0, 69.0, 70.0, 69.0, 77.0, 68.0, 69.0, 68.0], "value": 69.9, "unit": "score"}], "name": "kraken", "value": 1558.3000000000002, "alertThreshold": 2.0}]} 16:21:11 INFO - Return code: 0 16:21:11 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 16:21:11 ERROR - # TBPL SUCCESS # 16:21:11 INFO - Running post-action listener: _resource_record_post_action 16:21:11 INFO - Running post-run listener: _resource_record_post_run 16:21:12 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 200704; Write bytes: 386473984; Read time: 92; Write time: 260536 16:21:12 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 73560064; Read time: 0; Write time: 63432 16:21:12 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 200704; Write bytes: 286760960; Read time: 92; Write time: 191760 16:21:12 INFO - Running post-run listener: _upload_blobber_files 16:21:12 INFO - Blob upload gear active. 16:21:12 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:21:12 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 16:21:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:21:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:21:13 INFO - (blobuploader) - INFO - Open directory for files ... 16:21:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:21:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:21:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:21:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:21:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:21:14 INFO - (blobuploader) - INFO - Done attempting. 16:21:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:21:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:21:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:21:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:21:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:21:14 INFO - (blobuploader) - INFO - Done attempting. 16:21:14 INFO - (blobuploader) - INFO - Iteration through files over. 16:21:15 INFO - Return code: 0 16:21:15 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:21:15 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:21:15 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/7e81e216d253aed17dc6f088b2d7dde1d5addcccc7cd818b06bda94fe9a12083de433065a1391b7352d248da2d2e6763ee5f87d311f8f3a45ff951763c448f2e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/cc53da61b6b03acbfda8ceef3991a8173903b2fab574e69d784686e57f58b0e7517c262d2098d35e5ee106aa1b7da5f5bece076ed6bb71b9619cd302098ef1e9"} 16:21:15 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:21:15 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:21:15 INFO - Contents: 16:21:15 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/7e81e216d253aed17dc6f088b2d7dde1d5addcccc7cd818b06bda94fe9a12083de433065a1391b7352d248da2d2e6763ee5f87d311f8f3a45ff951763c448f2e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/cc53da61b6b03acbfda8ceef3991a8173903b2fab574e69d784686e57f58b0e7517c262d2098d35e5ee106aa1b7da5f5bece076ed6bb71b9619cd302098ef1e9"} 16:21:15 INFO - Running post-run listener: copy_logs_to_upload_dir 16:21:15 INFO - Copying logs to upload dir... 16:21:15 INFO - mkdir: /builds/slave/test/build/upload/logs 16:21:15 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1600.918883 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 26 mins, 40 secs) (at 2016-04-27 16:21:14.994890) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-27 16:21:14.998408) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1461797247.23138-1945067221 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/7e81e216d253aed17dc6f088b2d7dde1d5addcccc7cd818b06bda94fe9a12083de433065a1391b7352d248da2d2e6763ee5f87d311f8f3a45ff951763c448f2e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/cc53da61b6b03acbfda8ceef3991a8173903b2fab574e69d784686e57f58b0e7517c262d2098d35e5ee106aa1b7da5f5bece076ed6bb71b9619cd302098ef1e9"} build_url:https://queue.taskcluster.net/v1/task/IhU5KjaCR_SW_Bgi5qJ3wA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011288 build_url: 'https://queue.taskcluster.net/v1/task/IhU5KjaCR_SW_Bgi5qJ3wA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/7e81e216d253aed17dc6f088b2d7dde1d5addcccc7cd818b06bda94fe9a12083de433065a1391b7352d248da2d2e6763ee5f87d311f8f3a45ff951763c448f2e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/cc53da61b6b03acbfda8ceef3991a8173903b2fab574e69d784686e57f58b0e7517c262d2098d35e5ee106aa1b7da5f5bece076ed6bb71b9619cd302098ef1e9"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-27 16:21:15.029423) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 16:21:15.030209) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1461797247.23138-1945067221 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004455 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 16:21:15.117330) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-27 16:21:15.117691) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-27 16:21:15.118045) ========= ========= Total master_lag: 0.22 =========