builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-048 starttime: 1464324948.87 results: success (0) buildid: 20160526193054 builduid: 6679197b131a4e01a6257c922e70900d revision: d61769108d96a74b2389bc36c4c00f4686a0b794 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-26 21:55:48.866674) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-26 21:55:48.867274) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-26 21:55:48.867554) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-26 21:55:48.882426) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 21:55:48.882730) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=fa44defc139c4ba8574fe040000001db-1464319772.313099-1720444971 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-26 21:55:49-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.9M=0s 2016-05-26 21:55:49 (46.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.164975 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 21:55:49.061065) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 21:55:49.061368) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=fa44defc139c4ba8574fe040000001db-1464319772.313099-1720444971 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017296 ========= master_lag: 0.07 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 21:55:49.147669) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 21:55:49.148004) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev d61769108d96a74b2389bc36c4c00f4686a0b794 --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 d61769108d96a74b2389bc36c4c00f4686a0b794 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=fa44defc139c4ba8574fe040000001db-1464319772.313099-1720444971 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-26 21:55:49,400 truncating revision to first 12 chars 2016-05-26 21:55:49,400 Setting DEBUG logging. 2016-05-26 21:55:49,400 attempt 1/10 2016-05-26 21:55:49,400 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/d61769108d96?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-26 21:55:49,786 unpacking tar archive at: mozilla-inbound-d61769108d96/testing/mozharness/ program finished with exit code 0 elapsedTime=0.732575 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 21:55:49.893970) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-26 21:55:49.894245) ========= script_repo_revision: d61769108d96a74b2389bc36c4c00f4686a0b794 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-26 21:55:49.894626) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-26 21:55:49.894905) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-26 21:55:49.906528) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-05-26 21:55:49.906817) ========= /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=fa44defc139c4ba8574fe040000001db-1464319772.313099-1720444971 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 21:55:50 INFO - MultiFileLogger online at 20160526 21:55:50 in /builds/slave/test 21:55:50 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 21:55:50 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:55:50 INFO - {'append_to_log': False, 21:55:50 INFO - 'base_work_dir': '/builds/slave/test', 21:55:50 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 21:55:50 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:55:50 INFO - 'branch': 'Mozilla-Inbound', 21:55:50 INFO - 'buildbot_json_path': 'buildprops.json', 21:55:50 INFO - 'config_files': ('talos/linux_config.py',), 21:55:50 INFO - 'default_actions': ('clobber', 21:55:50 INFO - 'read-buildbot-config', 21:55:50 INFO - 'download-and-extract', 21:55:50 INFO - 'populate-webroot', 21:55:50 INFO - 'create-virtualenv', 21:55:50 INFO - 'install', 21:55:50 INFO - 'run-tests'), 21:55:50 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:55:50 INFO - 'download_minidump_stackwalk': True, 21:55:50 INFO - 'download_symbols': 'ondemand', 21:55:50 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:55:50 INFO - 'tooltool.py': '/tools/tooltool.py', 21:55:50 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:55:50 INFO - '/tools/misc-python/virtualenv.py')}, 21:55:50 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:55:50 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:55:50 INFO - 'installer_path': 'installer.exe', 21:55:50 INFO - 'log_level': 'info', 21:55:50 INFO - 'log_name': 'talos', 21:55:50 INFO - 'log_to_console': True, 21:55:50 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 21:55:50 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 21:55:50 INFO - 'opt_config_files': (), 21:55:50 INFO - 'pip_index': False, 21:55:50 INFO - 'sps_profile': False, 21:55:50 INFO - 'sps_profile_interval': 0, 21:55:50 INFO - 'suite': 'dromaeojs-e10s', 21:55:50 INFO - 'system_bits': '32', 21:55:50 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:55:50 INFO - 'title': 'talos-linux64-ix-048', 21:55:50 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:55:50 INFO - 'use_talos_json': True, 21:55:50 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:55:50 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:55:50 INFO - 'work_dir': 'build'} 21:55:50 INFO - ##### 21:55:50 INFO - ##### Running clobber step. 21:55:50 INFO - ##### 21:55:50 INFO - Running pre-action listener: _resource_record_pre_action 21:55:50 INFO - Running main action method: clobber 21:55:50 INFO - rmtree: /builds/slave/test/build 21:55:50 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:55:51 INFO - Running post-action listener: _resource_record_post_action 21:55:51 INFO - ##### 21:55:51 INFO - ##### Finished clobber step (success) 21:55:51 INFO - ##### 21:55:51 INFO - ##### 21:55:51 INFO - ##### Running read-buildbot-config step. 21:55:51 INFO - ##### 21:55:51 INFO - Running pre-action listener: _resource_record_pre_action 21:55:51 INFO - Running main action method: read_buildbot_config 21:55:51 INFO - Using buildbot properties: 21:55:51 INFO - { 21:55:51 INFO - "project": "", 21:55:51 INFO - "product": "firefox", 21:55:51 INFO - "script_repo_revision": "production", 21:55:51 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 21:55:51 INFO - "repository": "", 21:55:51 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 21:55:51 INFO - "buildid": "20160526193054", 21:55:51 INFO - "pgo_build": "True", 21:55:51 INFO - "basedir": "/builds/slave/test", 21:55:51 INFO - "buildnumber": 1079, 21:55:51 INFO - "slavename": "talos-linux64-ix-048", 21:55:51 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 21:55:51 INFO - "platform": "ubuntu64_hw", 21:55:51 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 21:55:51 INFO - "branch": "mozilla-inbound", 21:55:51 INFO - "repo_path": "integration/mozilla-inbound", 21:55:51 INFO - "revision": "d61769108d96a74b2389bc36c4c00f4686a0b794", 21:55:51 INFO - "stage_platform": "linux64-pgo", 21:55:51 INFO - "builduid": "6679197b131a4e01a6257c922e70900d", 21:55:51 INFO - "slavebuilddir": "test" 21:55:51 INFO - } 21:55:51 INFO - Found installer url https://queue.taskcluster.net/v1/task/eu6p6VfbS-WZaixceNt6BA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 21:55:51 INFO - Running post-action listener: _resource_record_post_action 21:55:51 INFO - ##### 21:55:51 INFO - ##### Finished read-buildbot-config step (success) 21:55:51 INFO - ##### 21:55:51 INFO - ##### 21:55:51 INFO - ##### Running download-and-extract step. 21:55:51 INFO - ##### 21:55:51 INFO - Running pre-action listener: _resource_record_pre_action 21:55:51 INFO - Running main action method: download_and_extract 21:55:51 INFO - mkdir: /builds/slave/test/build/tests 21:55:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:55:51 INFO - https://queue.taskcluster.net/v1/task/eu6p6VfbS-WZaixceNt6BA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 21:55:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eu6p6VfbS-WZaixceNt6BA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 21:55:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eu6p6VfbS-WZaixceNt6BA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 21:55:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eu6p6VfbS-WZaixceNt6BA/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 21:55:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eu6p6VfbS-WZaixceNt6BA/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 21:55:58 INFO - Downloaded 1361 bytes. 21:55:58 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 21:55:58 INFO - Using the following test package requirements: 21:55:58 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 21:55:58 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 21:55:58 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 21:55:58 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 21:55:58 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 21:55:58 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 21:55:58 INFO - u'jsshell-linux-x86_64.zip'], 21:55:58 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 21:55:58 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 21:55:58 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 21:55:58 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 21:55:58 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 21:55:58 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 21:55:58 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 21:55:58 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 21:55:58 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 21:55:58 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 21:55:58 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 21:55:58 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 21:55:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:55:58 INFO - https://queue.taskcluster.net/v1/task/eu6p6VfbS-WZaixceNt6BA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 21:55:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eu6p6VfbS-WZaixceNt6BA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 21:55:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eu6p6VfbS-WZaixceNt6BA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 21:55:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eu6p6VfbS-WZaixceNt6BA/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 21:55:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eu6p6VfbS-WZaixceNt6BA/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 21:56:01 INFO - Downloaded 24410537 bytes. 21: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'] 21: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 21:56:02 INFO - Return code: 0 21:56:02 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 21: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')]} 21:56:02 INFO - https://queue.taskcluster.net/v1/task/eu6p6VfbS-WZaixceNt6BA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 21:56:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eu6p6VfbS-WZaixceNt6BA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 21:56:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eu6p6VfbS-WZaixceNt6BA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 21:56:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eu6p6VfbS-WZaixceNt6BA/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 21:56:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eu6p6VfbS-WZaixceNt6BA/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 21:56:04 INFO - Downloaded 24410537 bytes. 21:56:04 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'] 21:56:04 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 21:56:05 INFO - Return code: 0 21:56:05 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')]} 21:56:05 INFO - https://queue.taskcluster.net/v1/task/eu6p6VfbS-WZaixceNt6BA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 21:56:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eu6p6VfbS-WZaixceNt6BA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 21:56:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eu6p6VfbS-WZaixceNt6BA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 21:56:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eu6p6VfbS-WZaixceNt6BA/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 21:56:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eu6p6VfbS-WZaixceNt6BA/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 21:56:06 INFO - Downloaded 10834034 bytes. 21:56:06 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'] 21:56:06 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 21:56:07 INFO - Return code: 0 21:56:07 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')]} 21:56:07 INFO - https://queue.taskcluster.net/v1/task/eu6p6VfbS-WZaixceNt6BA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 21:56:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eu6p6VfbS-WZaixceNt6BA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 21:56:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eu6p6VfbS-WZaixceNt6BA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 21:56:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eu6p6VfbS-WZaixceNt6BA/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 21:56:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eu6p6VfbS-WZaixceNt6BA/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 21:56:08 INFO - Downloaded 58703396 bytes. 21:56:08 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/eu6p6VfbS-WZaixceNt6BA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 21:56:08 INFO - mkdir: /builds/slave/test/properties 21:56:08 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:56:08 INFO - Writing to file /builds/slave/test/properties/build_url 21:56:08 INFO - Contents: 21:56:08 INFO - build_url:https://queue.taskcluster.net/v1/task/eu6p6VfbS-WZaixceNt6BA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 21:56:09 INFO - Running post-action listener: _resource_record_post_action 21:56:09 INFO - Running post-action listener: set_extra_try_arguments 21:56:09 INFO - ##### 21:56:09 INFO - ##### Finished download-and-extract step (success) 21:56:09 INFO - ##### 21:56:09 INFO - ##### 21:56:09 INFO - ##### Running populate-webroot step. 21:56:09 INFO - ##### 21:56:09 INFO - Running pre-action listener: _resource_record_pre_action 21:56:09 INFO - Running main action method: populate_webroot 21:56:09 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:56:09 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:56:09 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:56:09 INFO - '--tppagecycles', 21:56:09 INFO - '7'], 21:56:09 INFO - 'tests': ['tsvgm']}}, 21:56:09 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 21:56:09 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:56:09 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:56:09 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 21:56:09 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:56:09 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:56:09 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:56:09 INFO - 'talos_options': ['--disable-e10s'], 21:56:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:56:09 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:56:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:56:09 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:56:09 INFO - 'talos_options': ['--disable-e10s'], 21:56:09 INFO - 'tests': ['damp', 'tps']}, 21:56:09 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:56:09 INFO - 'tests': ['damp', 'tps']}, 21:56:09 INFO - 'g3': {'talos_options': ['--disable-e10s'], 21:56:09 INFO - 'tests': ['dromaeo_dom']}, 21:56:09 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:56:09 INFO - 'other': {'talos_options': ['--disable-e10s'], 21:56:09 INFO - 'tests': ['a11yr', 21:56:09 INFO - 'ts_paint', 21:56:09 INFO - 'tpaint', 21:56:09 INFO - 'sessionrestore', 21:56:09 INFO - 'sessionrestore_no_auto_restore', 21:56:09 INFO - 'tabpaint']}, 21:56:09 INFO - 'other-e10s': {'tests': ['a11yr', 21:56:09 INFO - 'ts_paint', 21:56:09 INFO - 'tpaint', 21:56:09 INFO - 'sessionrestore', 21:56:09 INFO - 'sessionrestore_no_auto_restore', 21:56:09 INFO - 'tabpaint']}, 21:56:09 INFO - 'other-e10s_l64': {'tests': ['a11yr', 21:56:09 INFO - 'ts_paint', 21:56:09 INFO - 'tpaint', 21:56:09 INFO - 'sessionrestore', 21:56:09 INFO - 'sessionrestore_no_auto_restore', 21:56:09 INFO - 'tabpaint']}, 21:56:09 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 21:56:09 INFO - 'ts_paint', 21:56:09 INFO - 'tpaint', 21:56:09 INFO - 'sessionrestore', 21:56:09 INFO - 'sessionrestore_no_auto_restore', 21:56:09 INFO - 'tabpaint']}, 21:56:09 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 21:56:09 INFO - 'tests': ['a11yr', 21:56:09 INFO - 'ts_paint', 21:56:09 INFO - 'tpaint', 21:56:09 INFO - 'sessionrestore', 21:56:09 INFO - 'sessionrestore_no_auto_restore', 21:56:09 INFO - 'tabpaint']}, 21:56:09 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 21:56:09 INFO - 'tests': ['a11yr', 21:56:09 INFO - 'ts_paint', 21:56:09 INFO - 'tpaint', 21:56:09 INFO - 'sessionrestore', 21:56:09 INFO - 'sessionrestore_no_auto_restore', 21:56:09 INFO - 'tabpaint']}, 21:56:09 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 21:56:09 INFO - 'tests': ['tsvgx', 21:56:09 INFO - 'tsvgr_opacity', 21:56:09 INFO - 'tart', 21:56:09 INFO - 'tscrollx', 21:56:09 INFO - 'cart']}, 21:56:09 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:56:09 INFO - 'tsvgr_opacity', 21:56:09 INFO - 'tart', 21:56:09 INFO - 'tscrollx', 21:56:09 INFO - 'cart']}, 21:56:09 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:56:09 INFO - 'talos_options': ['--disable-e10s'], 21:56:09 INFO - 'tests': ['tp5o']}, 21:56:09 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:56:09 INFO - 'tests': ['tp5o']}, 21:56:09 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:56:09 INFO - 'talos_options': ['--disable-e10s', 21:56:09 INFO - '--xperf_path', 21:56:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:56:09 INFO - 'tests': ['tp5n']}, 21:56:09 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:56:09 INFO - 'talos_options': ['--xperf_path', 21:56:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:56:09 INFO - 'tests': ['tp5n']}}, 21:56:09 INFO - 'talos.zip': {'path': '', 21:56:09 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:56:09 INFO - Running post-action listener: _resource_record_post_action 21:56:09 INFO - ##### 21:56:09 INFO - ##### Finished populate-webroot step (success) 21:56:09 INFO - ##### 21:56:09 INFO - ##### 21:56:09 INFO - ##### Running create-virtualenv step. 21:56:09 INFO - ##### 21:56:09 INFO - Running pre-action listener: _resource_record_pre_action 21:56:09 INFO - Running main action method: create_virtualenv 21:56:09 INFO - Creating virtualenv /builds/slave/test/build/venv 21:56:09 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 21:56:09 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:56:09 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:56:09 INFO - Using real prefix '/usr' 21:56:09 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:56:09 INFO - Installing distribute.............................................................................................................................................................................................done. 21:56:11 INFO - Installing pip.................done. 21:56:11 INFO - Return code: 0 21:56:11 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:56:11 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')]} 21:56:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:56:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:56:11 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')]} 21:56:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:56:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:56:11 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 0x7fa3d4897f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11e68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12b1770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13409c0>, '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 0x13418c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1341d50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1464319772.313099-1720444971', '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 21:56:11 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 21:56:11 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 21:56:11 INFO - Using env: {'DISPLAY': ':0', 21:56:11 INFO - 'HOME': '/home/cltbld', 21:56:11 INFO - 'LANG': 'en_US.UTF-8', 21:56:11 INFO - 'LANGUAGE': 'en_US:en', 21:56:11 INFO - 'LOGNAME': 'cltbld', 21:56:11 INFO - 'MAIL': '/var/mail/cltbld', 21:56:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:56:11 INFO - 'MOZ_NO_REMOTE': '1', 21:56:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:56:11 INFO - 'NO_EM_RESTART': '1', 21:56:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:56:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:56:11 INFO - 'PWD': '/builds/slave/test', 21:56:11 INFO - 'SHELL': '/bin/bash', 21:56:11 INFO - 'SHLVL': '1', 21:56:11 INFO - 'TERM': 'linux', 21:56:11 INFO - 'TMOUT': '86400', 21:56:11 INFO - 'USER': 'cltbld', 21:56:11 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1464319772.313099-1720444971', 21:56:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:56:11 INFO - '_': '/tools/buildbot/bin/python'} 21:56:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:56:12 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 21:56:12 INFO - Cleaning up... 21:56:12 INFO - Return code: 0 21:56:12 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 21:56: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')]} 21:56:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:56:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:56: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')]} 21:56:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:56:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:56:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa3d4897f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11e68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12b1770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13409c0>, '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 0x13418c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1341d50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1464319772.313099-1720444971', '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 21:56:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 21:56:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 21:56:12 INFO - Using env: {'DISPLAY': ':0', 21:56:12 INFO - 'HOME': '/home/cltbld', 21:56:12 INFO - 'LANG': 'en_US.UTF-8', 21:56:12 INFO - 'LANGUAGE': 'en_US:en', 21:56:12 INFO - 'LOGNAME': 'cltbld', 21:56:12 INFO - 'MAIL': '/var/mail/cltbld', 21:56:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:56:12 INFO - 'MOZ_NO_REMOTE': '1', 21:56:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:56:12 INFO - 'NO_EM_RESTART': '1', 21:56:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:56:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:56:12 INFO - 'PWD': '/builds/slave/test', 21:56:12 INFO - 'SHELL': '/bin/bash', 21:56:12 INFO - 'SHLVL': '1', 21:56:12 INFO - 'TERM': 'linux', 21:56:12 INFO - 'TMOUT': '86400', 21:56:12 INFO - 'USER': 'cltbld', 21:56:12 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1464319772.313099-1720444971', 21:56:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:56:12 INFO - '_': '/tools/buildbot/bin/python'} 21:56:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:56:12 INFO - Downloading/unpacking psutil>=3.1.1 21:56:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:56:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:56:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:56:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:56:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:56:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:56:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:56:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:56:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:56:14 INFO - Installing collected packages: psutil 21:56:14 INFO - Running setup.py install for psutil 21:56:14 INFO - building 'psutil._psutil_linux' extension 21:56:14 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 21:56:14 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 21:56:14 INFO - building 'psutil._psutil_posix' extension 21:56:14 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 21:56:14 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 21:56:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:56:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:56:14 INFO - Successfully installed psutil 21:56:14 INFO - Cleaning up... 21:56:14 INFO - Return code: 0 21:56:14 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 21:56:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:56:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:56:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:56:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:56:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:56:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:56:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa3d4897f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11e68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12b1770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13409c0>, '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 0x13418c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1341d50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1464319772.313099-1720444971', '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 21:56:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 21:56:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 21:56:14 INFO - Using env: {'DISPLAY': ':0', 21:56:14 INFO - 'HOME': '/home/cltbld', 21:56:14 INFO - 'LANG': 'en_US.UTF-8', 21:56:14 INFO - 'LANGUAGE': 'en_US:en', 21:56:14 INFO - 'LOGNAME': 'cltbld', 21:56:14 INFO - 'MAIL': '/var/mail/cltbld', 21:56:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:56:14 INFO - 'MOZ_NO_REMOTE': '1', 21:56:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:56:14 INFO - 'NO_EM_RESTART': '1', 21:56:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:56:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:56:14 INFO - 'PWD': '/builds/slave/test', 21:56:14 INFO - 'SHELL': '/bin/bash', 21:56:14 INFO - 'SHLVL': '1', 21:56:14 INFO - 'TERM': 'linux', 21:56:14 INFO - 'TMOUT': '86400', 21:56:14 INFO - 'USER': 'cltbld', 21:56:14 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1464319772.313099-1720444971', 21:56:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:56:14 INFO - '_': '/tools/buildbot/bin/python'} 21:56:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:56:15 INFO - Downloading/unpacking mozsystemmonitor==0.3 21:56:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:56:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:56:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:56:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:56:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:56:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:56:17 INFO - Downloading mozsystemmonitor-0.3.tar.gz 21:56:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:56:17 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 21:56:17 INFO - Installing collected packages: mozsystemmonitor 21:56:17 INFO - Running setup.py install for mozsystemmonitor 21:56:17 INFO - Successfully installed mozsystemmonitor 21:56:17 INFO - Cleaning up... 21:56:17 INFO - Return code: 0 21:56:17 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:56:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:56:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:56:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:56:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:56:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:56:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:56:17 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 0x7fa3d4897f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11e68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12b1770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13409c0>, '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 0x13418c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1341d50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1464319772.313099-1720444971', '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 21:56:17 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 21:56:17 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 21:56:17 INFO - Using env: {'DISPLAY': ':0', 21:56:17 INFO - 'HOME': '/home/cltbld', 21:56:17 INFO - 'LANG': 'en_US.UTF-8', 21:56:17 INFO - 'LANGUAGE': 'en_US:en', 21:56:17 INFO - 'LOGNAME': 'cltbld', 21:56:17 INFO - 'MAIL': '/var/mail/cltbld', 21:56:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:56:17 INFO - 'MOZ_NO_REMOTE': '1', 21:56:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:56:17 INFO - 'NO_EM_RESTART': '1', 21:56:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:56:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:56:17 INFO - 'PWD': '/builds/slave/test', 21:56:17 INFO - 'SHELL': '/bin/bash', 21:56:17 INFO - 'SHLVL': '1', 21:56:17 INFO - 'TERM': 'linux', 21:56:17 INFO - 'TMOUT': '86400', 21:56:17 INFO - 'USER': 'cltbld', 21:56:17 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1464319772.313099-1720444971', 21:56:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:56:17 INFO - '_': '/tools/buildbot/bin/python'} 21:56:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:56:17 INFO - Downloading/unpacking blobuploader==1.2.4 21:56: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 21:56: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 21:56: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 21:56: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 21:56: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 21:56: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 21:56:19 INFO - Downloading blobuploader-1.2.4.tar.gz 21:56:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:56:19 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:56: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 21:56: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 21:56: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 21:56: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 21:56: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 21:56: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 21:56:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:56:19 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:56: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 21:56: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 21:56: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 21:56: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 21:56: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 21:56: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 21:56:20 INFO - Downloading docopt-0.6.1.tar.gz 21:56:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:56:20 INFO - Installing collected packages: blobuploader, requests, docopt 21:56:20 INFO - Running setup.py install for blobuploader 21:56:20 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:56:20 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:56:20 INFO - Running setup.py install for requests 21:56:20 INFO - Running setup.py install for docopt 21:56:20 INFO - Successfully installed blobuploader requests docopt 21:56:20 INFO - Cleaning up... 21:56:20 INFO - Return code: 0 21:56:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:56:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:56:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:56:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:56:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:56:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:56:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:56:20 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 0x7fa3d4897f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11e68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12b1770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13409c0>, '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 0x13418c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1341d50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1464319772.313099-1720444971', '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 21:56:20 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 21:56:20 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 21:56:20 INFO - Using env: {'DISPLAY': ':0', 21:56:20 INFO - 'HOME': '/home/cltbld', 21:56:20 INFO - 'LANG': 'en_US.UTF-8', 21:56:20 INFO - 'LANGUAGE': 'en_US:en', 21:56:20 INFO - 'LOGNAME': 'cltbld', 21:56:20 INFO - 'MAIL': '/var/mail/cltbld', 21:56:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:56:20 INFO - 'MOZ_NO_REMOTE': '1', 21:56:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:56:20 INFO - 'NO_EM_RESTART': '1', 21:56:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:56:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:56:20 INFO - 'PWD': '/builds/slave/test', 21:56:20 INFO - 'SHELL': '/bin/bash', 21:56:20 INFO - 'SHLVL': '1', 21:56:20 INFO - 'TERM': 'linux', 21:56:20 INFO - 'TMOUT': '86400', 21:56:20 INFO - 'USER': 'cltbld', 21:56:20 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1464319772.313099-1720444971', 21:56:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:56:20 INFO - '_': '/tools/buildbot/bin/python'} 21:56:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:56:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:56:21 INFO - Running setup.py (path:/tmp/pip-4B5axW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:56:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:56:21 INFO - Running setup.py (path:/tmp/pip-JQrg50-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:56:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:56:21 INFO - Running setup.py (path:/tmp/pip-iiVYOB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:56:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:56:21 INFO - Running setup.py (path:/tmp/pip-rFEvsd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:56:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:56:21 INFO - Running setup.py (path:/tmp/pip-FxloZx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:56:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:56:21 INFO - Running setup.py (path:/tmp/pip-VgmzFh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:56:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:56:21 INFO - Running setup.py (path:/tmp/pip-k6CRY2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:56:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:56:21 INFO - Running setup.py (path:/tmp/pip-Oarh9g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:56:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:56:21 INFO - Running setup.py (path:/tmp/pip-QO7M26-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:56:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:56:21 INFO - Running setup.py (path:/tmp/pip-xkRfzc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:56:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:56:21 INFO - Running setup.py (path:/tmp/pip-GlePl1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:56:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:56:21 INFO - Running setup.py (path:/tmp/pip-_jCBAg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:56:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:56:21 INFO - Running setup.py (path:/tmp/pip-qgDtpk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:56:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:56:22 INFO - Running setup.py (path:/tmp/pip-3Sfjs2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:56:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:56:22 INFO - Running setup.py (path:/tmp/pip-kO5dNv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:56:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:56:22 INFO - Running setup.py (path:/tmp/pip-fvJhYn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:56:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:56:22 INFO - Running setup.py (path:/tmp/pip-SlIPSe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:56:22 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:56:22 INFO - Running setup.py install for manifestparser 21:56:22 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:56:22 INFO - Running setup.py install for mozcrash 21:56:22 INFO - Running setup.py install for mozdebug 21:56:22 INFO - Running setup.py install for mozdevice 21:56:22 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 21:56:22 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:56:22 INFO - Running setup.py install for mozfile 21:56:22 INFO - Running setup.py install for mozhttpd 21:56:22 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:56:22 INFO - Running setup.py install for mozinfo 21:56:23 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:56:23 INFO - Running setup.py install for mozInstall 21:56:23 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:56:23 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:56:23 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:56:23 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:56:23 INFO - Running setup.py install for mozleak 21:56:23 INFO - Running setup.py install for mozlog 21:56:23 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:56:23 INFO - Running setup.py install for moznetwork 21:56:23 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:56:23 INFO - Running setup.py install for mozprocess 21:56:23 INFO - Running setup.py install for mozprofile 21:56:23 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:56:23 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:56:23 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:56:23 INFO - Running setup.py install for mozrunner 21:56:23 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:56:23 INFO - Running setup.py install for mozscreenshot 21:56:23 INFO - Running setup.py install for moztest 21:56:23 INFO - Running setup.py install for mozversion 21:56:24 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:56:24 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:56:24 INFO - Cleaning up... 21:56:24 INFO - Return code: 0 21:56:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:56:24 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')]} 21:56:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:56:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:56:24 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')]} 21:56:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:56:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:56:24 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 0x7fa3d4897f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11e68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12b1770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13409c0>, '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 0x13418c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1341d50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1464319772.313099-1720444971', '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 21:56:24 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 21:56:24 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 21:56:24 INFO - Using env: {'DISPLAY': ':0', 21:56:24 INFO - 'HOME': '/home/cltbld', 21:56:24 INFO - 'LANG': 'en_US.UTF-8', 21:56:24 INFO - 'LANGUAGE': 'en_US:en', 21:56:24 INFO - 'LOGNAME': 'cltbld', 21:56:24 INFO - 'MAIL': '/var/mail/cltbld', 21:56:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:56:24 INFO - 'MOZ_NO_REMOTE': '1', 21:56:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:56:24 INFO - 'NO_EM_RESTART': '1', 21:56:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:56:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:56:24 INFO - 'PWD': '/builds/slave/test', 21:56:24 INFO - 'SHELL': '/bin/bash', 21:56:24 INFO - 'SHLVL': '1', 21:56:24 INFO - 'TERM': 'linux', 21:56:24 INFO - 'TMOUT': '86400', 21:56:24 INFO - 'USER': 'cltbld', 21:56:24 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1464319772.313099-1720444971', 21:56:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:56:24 INFO - '_': '/tools/buildbot/bin/python'} 21:56:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:56:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:56:24 INFO - Running setup.py (path:/tmp/pip-1k6mFw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:56:24 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)) 21:56:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:56:24 INFO - Running setup.py (path:/tmp/pip-OC_WQ0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:56:24 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)) 21:56:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:56:24 INFO - Running setup.py (path:/tmp/pip-fwSwv_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:56:24 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)) 21:56:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:56:24 INFO - Running setup.py (path:/tmp/pip-ZZvFa1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:56:24 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)) 21:56:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:56:24 INFO - Running setup.py (path:/tmp/pip-8NJQKu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:56:24 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)) 21:56:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:56:24 INFO - Running setup.py (path:/tmp/pip-y9JSGt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:56:24 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)) 21:56:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:56:24 INFO - Running setup.py (path:/tmp/pip-RG6uyp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:56:24 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)) 21:56:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:56:24 INFO - Running setup.py (path:/tmp/pip-raTU6k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:56:24 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)) 21:56:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:56:24 INFO - Running setup.py (path:/tmp/pip-jO7hrm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:56:24 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)) 21:56:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:56:24 INFO - Running setup.py (path:/tmp/pip-0c3Pc7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:56:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:56:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:56:25 INFO - Running setup.py (path:/tmp/pip-FYdMDv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:56:25 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)) 21:56:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:56:25 INFO - Running setup.py (path:/tmp/pip-w3cYum-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:56:25 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)) 21:56:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:56:25 INFO - Running setup.py (path:/tmp/pip-SqbLvD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:56:25 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)) 21:56:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:56:25 INFO - Running setup.py (path:/tmp/pip-TTnAlL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:56:25 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)) 21:56:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:56:25 INFO - Running setup.py (path:/tmp/pip-BqJ7HT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:56:25 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)) 21:56:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:56:25 INFO - Running setup.py (path:/tmp/pip-bwGqGv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:56:25 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)) 21:56:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:56:25 INFO - Running setup.py (path:/tmp/pip-Et0p0E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:56:25 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)) 21:56:25 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)) 21:56:25 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)) 21:56:25 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)) 21:56:25 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)) 21:56:25 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)) 21:56:25 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:56:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:56:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:56:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:56:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:56:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:56:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:56:27 INFO - Downloading blessings-1.6.tar.gz 21:56:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:56:27 INFO - Installing collected packages: blessings 21:56:27 INFO - Running setup.py install for blessings 21:56:27 INFO - Successfully installed blessings 21:56:27 INFO - Cleaning up... 21:56:27 INFO - Return code: 0 21:56:27 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:56:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:56:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:56:27 INFO - Reading from file tmpfile_stdout 21:56:27 INFO - Current package versions: 21:56:27 INFO - argparse == 1.2.1 21:56:27 INFO - blessings == 1.6 21:56:27 INFO - blobuploader == 1.2.4 21:56:27 INFO - docopt == 0.6.1 21:56:27 INFO - manifestparser == 1.1 21:56:27 INFO - mozInstall == 1.12 21:56:27 INFO - mozcrash == 0.17 21:56:27 INFO - mozdebug == 0.1 21:56:27 INFO - mozdevice == 0.48 21:56:27 INFO - mozfile == 1.2 21:56:27 INFO - mozhttpd == 0.7 21:56:27 INFO - mozinfo == 0.9 21:56:27 INFO - mozleak == 0.1 21:56:27 INFO - mozlog == 3.2 21:56:27 INFO - moznetwork == 0.27 21:56:27 INFO - mozprocess == 0.22 21:56:27 INFO - mozprofile == 0.28 21:56:27 INFO - mozrunner == 6.11 21:56:27 INFO - mozscreenshot == 0.1 21:56:27 INFO - mozsystemmonitor == 0.3 21:56:27 INFO - moztest == 0.7 21:56:27 INFO - mozversion == 1.4 21:56:27 INFO - psutil == 3.1.1 21:56:27 INFO - requests == 1.2.3 21:56:27 INFO - wsgiref == 0.1.2 21:56:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:56:27 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')]} 21:56:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:56:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:56:27 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')]} 21:56:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:56:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:56:27 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 0x7fa3d4897f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11e68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12b1770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13409c0>, '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 0x13418c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1341d50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1464319772.313099-1720444971', '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 21:56:27 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 21:56:27 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 21:56:27 INFO - Using env: {'DISPLAY': ':0', 21:56:27 INFO - 'HOME': '/home/cltbld', 21:56:27 INFO - 'LANG': 'en_US.UTF-8', 21:56:27 INFO - 'LANGUAGE': 'en_US:en', 21:56:27 INFO - 'LOGNAME': 'cltbld', 21:56:27 INFO - 'MAIL': '/var/mail/cltbld', 21:56:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:56:27 INFO - 'MOZ_NO_REMOTE': '1', 21:56:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:56:27 INFO - 'NO_EM_RESTART': '1', 21:56:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:56:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:56:27 INFO - 'PWD': '/builds/slave/test', 21:56:27 INFO - 'SHELL': '/bin/bash', 21:56:27 INFO - 'SHLVL': '1', 21:56:27 INFO - 'TERM': 'linux', 21:56:27 INFO - 'TMOUT': '86400', 21:56:27 INFO - 'USER': 'cltbld', 21:56:27 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1464319772.313099-1720444971', 21:56:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:56:27 INFO - '_': '/tools/buildbot/bin/python'} 21:56:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:56:28 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)) 21:56:28 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)) 21:56:28 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)) 21:56:28 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)) 21:56:28 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)) 21:56:28 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)) 21:56:28 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)) 21:56:28 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)) 21:56:28 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)) 21:56:28 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)) 21:56:28 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)) 21:56:28 INFO - Cleaning up... 21:56:28 INFO - Return code: 0 21:56:28 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:56:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:56:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:56:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:56:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:56:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:56:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:56:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa3d4897f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11e68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12b1770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13409c0>, '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 0x13418c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1341d50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1464319772.313099-1720444971', '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 21:56:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 21:56:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 21:56:28 INFO - Using env: {'DISPLAY': ':0', 21:56:28 INFO - 'HOME': '/home/cltbld', 21:56:28 INFO - 'LANG': 'en_US.UTF-8', 21:56:28 INFO - 'LANGUAGE': 'en_US:en', 21:56:28 INFO - 'LOGNAME': 'cltbld', 21:56:28 INFO - 'MAIL': '/var/mail/cltbld', 21:56:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:56:28 INFO - 'MOZ_NO_REMOTE': '1', 21:56:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:56:28 INFO - 'NO_EM_RESTART': '1', 21:56:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:56:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:56:28 INFO - 'PWD': '/builds/slave/test', 21:56:28 INFO - 'SHELL': '/bin/bash', 21:56:28 INFO - 'SHLVL': '1', 21:56:28 INFO - 'TERM': 'linux', 21:56:28 INFO - 'TMOUT': '86400', 21:56:28 INFO - 'USER': 'cltbld', 21:56:28 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1464319772.313099-1720444971', 21:56:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:56:28 INFO - '_': '/tools/buildbot/bin/python'} 21:56:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:56:28 INFO - Downloading/unpacking jsonschema 21:56:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:56:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:56:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:56:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:56:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:56:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:56:30 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:56:30 INFO - Downloading/unpacking functools32 (from jsonschema) 21:56:30 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 21:56:30 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 21:56:30 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 21:56:30 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 21:56:30 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 21:56:30 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 21:56:30 INFO - Downloading functools32-3.2.3-2.tar.gz 21:56:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:56:30 INFO - warning: no files found matching '*.txt' 21:56:30 INFO - no previously-included directories found matching 'build' 21:56:30 INFO - no previously-included directories found matching 'dist' 21:56:30 INFO - no previously-included directories found matching '.git*' 21:56:30 INFO - Installing collected packages: jsonschema, functools32 21:56:30 INFO - Running setup.py install for functools32 21:56:30 INFO - warning: no files found matching '*.txt' 21:56:30 INFO - no previously-included directories found matching 'build' 21:56:30 INFO - no previously-included directories found matching 'dist' 21:56:30 INFO - no previously-included directories found matching '.git*' 21:56:30 INFO - Successfully installed jsonschema functools32 21:56:30 INFO - Cleaning up... 21:56:30 INFO - Return code: 0 21:56:30 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 21:56:30 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')]} 21:56:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:56:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:56:30 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')]} 21:56:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:56:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:56:30 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 0x7fa3d4897f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11e68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12b1770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13409c0>, '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 0x13418c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1341d50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1464319772.313099-1720444971', '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 21:56:30 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 21:56:30 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 21:56:30 INFO - Using env: {'DISPLAY': ':0', 21:56:30 INFO - 'HOME': '/home/cltbld', 21:56:30 INFO - 'LANG': 'en_US.UTF-8', 21:56:30 INFO - 'LANGUAGE': 'en_US:en', 21:56:30 INFO - 'LOGNAME': 'cltbld', 21:56:30 INFO - 'MAIL': '/var/mail/cltbld', 21:56:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:56:30 INFO - 'MOZ_NO_REMOTE': '1', 21:56:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:56:30 INFO - 'NO_EM_RESTART': '1', 21:56:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:56:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:56:30 INFO - 'PWD': '/builds/slave/test', 21:56:30 INFO - 'SHELL': '/bin/bash', 21:56:30 INFO - 'SHLVL': '1', 21:56:30 INFO - 'TERM': 'linux', 21:56:30 INFO - 'TMOUT': '86400', 21:56:30 INFO - 'USER': 'cltbld', 21:56:30 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1464319772.313099-1720444971', 21:56:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:56:30 INFO - '_': '/tools/buildbot/bin/python'} 21:56:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:56:30 INFO - Downloading/unpacking flake8 21:56:30 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 21:56:30 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 21:56:30 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 21:56:30 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 21:56:30 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 21:56:30 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 21:56:32 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 21:56:32 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 21:56:32 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 21:56:32 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 21:56:32 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 21:56:32 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 21:56:32 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 21:56:32 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 21:56:32 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 21:56:32 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 21:56:32 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 21:56:32 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 21:56:32 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 21:56:32 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 21:56:32 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 21:56:32 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 21:56:33 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 21:56:33 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 21:56:33 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 21:56:33 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 21:56:33 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 21:56:33 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 21:56:33 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 21:56:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 21:56:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 21:56:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 21:56:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 21:56:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 21:56:33 INFO - no previously-included directories found matching 'docs/_build' 21:56:33 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 21:56:33 INFO - Running setup.py install for pep8 21:56:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 21:56:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 21:56:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 21:56:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 21:56:33 INFO - no previously-included directories found matching 'docs/_build' 21:56:33 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 21:56:33 INFO - Successfully installed flake8 mccabe pyflakes pep8 21:56:33 INFO - Cleaning up... 21:56:33 INFO - Return code: 0 21:56:33 INFO - Running post-action listener: _resource_record_post_action 21:56:33 INFO - Running post-action listener: _start_resource_monitoring 21:56:33 INFO - Starting resource monitoring. 21:56:33 INFO - ##### 21:56:33 INFO - ##### Finished create-virtualenv step (success) 21:56:33 INFO - ##### 21:56:33 INFO - ##### 21:56:33 INFO - ##### Running install step. 21:56:33 INFO - ##### 21:56:33 INFO - Running pre-action listener: _resource_record_pre_action 21:56:33 INFO - Running main action method: install 21:56:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:56:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:56:33 INFO - Reading from file tmpfile_stdout 21:56:33 INFO - Detecting whether we're running mozinstall >=1.0... 21:56:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:56:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:56:34 INFO - Reading from file tmpfile_stdout 21:56:34 INFO - Output received: 21:56:34 INFO - Usage: mozinstall [options] installer 21:56:34 INFO - Options: 21:56:34 INFO - -h, --help show this help message and exit 21:56:34 INFO - -d DEST, --destination=DEST 21:56:34 INFO - Directory to install application into. [default: 21:56:34 INFO - "/builds/slave/test"] 21:56:34 INFO - --app=APP Application being installed. [default: firefox] 21:56:34 INFO - mkdir: /builds/slave/test/build/application 21:56:34 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'] 21:56:34 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 21:56:50 INFO - Reading from file tmpfile_stdout 21:56:50 INFO - Output received: 21:56:50 INFO - /builds/slave/test/build/application/firefox/firefox 21:56:50 INFO - Running post-action listener: _resource_record_post_action 21:56:50 INFO - ##### 21:56:50 INFO - ##### Finished install step (success) 21:56:50 INFO - ##### 21:56:50 INFO - ##### 21:56:50 INFO - ##### Running run-tests step. 21:56:50 INFO - ##### 21:56:50 INFO - Running pre-action listener: _resource_record_pre_action 21:56:50 INFO - Running main action method: run_tests 21:56:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:56:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:56:50 INFO - Python 2.7.3 21:56:50 INFO - Return code: 0 21:56:50 INFO - grabbing minidump binary from tooltool 21:56: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')]} 21:56:50 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13409c0>, '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 0x13418c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1341d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:56:50 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 21:56:50 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 21:56:50 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 21:56:50 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:56:50 INFO - Return code: 0 21:56:50 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 21:56:50 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:56:50 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:56:50 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 21:56:50 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:56:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 21:56:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 21:56:51 INFO - Return code: 0 21:56:51 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/eu6p6VfbS-WZaixceNt6BA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 21:56:51 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/eu6p6VfbS-WZaixceNt6BA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-048 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 21:56:51 INFO - Using env: {'DISPLAY': ':0', 21:56:51 INFO - 'HOME': '/home/cltbld', 21:56:51 INFO - 'LANG': 'en_US.UTF-8', 21:56:51 INFO - 'LANGUAGE': 'en_US:en', 21:56:51 INFO - 'LOGNAME': 'cltbld', 21:56:51 INFO - 'MAIL': '/var/mail/cltbld', 21:56:51 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:56:51 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 21:56:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:56:51 INFO - 'MOZ_NO_REMOTE': '1', 21:56:51 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:56:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:56:51 INFO - 'NO_EM_RESTART': '1', 21:56:51 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:56:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:56:51 INFO - 'PWD': '/builds/slave/test', 21:56:51 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:56:51 INFO - 'SHELL': '/bin/bash', 21:56:51 INFO - 'SHLVL': '1', 21:56:51 INFO - 'TERM': 'linux', 21:56:51 INFO - 'TMOUT': '86400', 21:56:51 INFO - 'USER': 'cltbld', 21:56:51 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1464319772.313099-1720444971', 21:56:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:56:51 INFO - '_': '/tools/buildbot/bin/python'} 21:56:51 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/eu6p6VfbS-WZaixceNt6BA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 21:56:51 INFO - mozversion application_buildid: 20160526193054 21:56:51 INFO - mozversion application_changeset: d61769108d96a74b2389bc36c4c00f4686a0b794 21:56:51 INFO - mozversion application_display_name: Nightly 21:56:51 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:56:51 INFO - mozversion application_name: Firefox 21:56:51 INFO - mozversion application_remotingname: firefox 21:56:51 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 21:56:51 INFO - mozversion application_vendor: Mozilla 21:56:51 INFO - mozversion application_version: 49.0a1 21:56:51 INFO - mozversion platform_buildid: 20160526193054 21:56:51 INFO - mozversion platform_changeset: d61769108d96a74b2389bc36c4c00f4686a0b794 21:56:51 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 21:56:51 INFO - mozversion platform_version: 49.0a1 21:56:51 INFO - using testdate: 1464325011 21:56:51 INFO - actual date: 1464325011 21:56:51 INFO - starting webserver on 'localhost:47704' 21:56:51 INFO - SUITE-START | Running 2 tests 21:56:51 INFO - TEST-START | dromaeo_css 21:56:51 INFO - operating with platform_type : linux_ 21:56:51 INFO - Initialising browser for dromaeo_css test... 21:56:51 INFO - TEST-INFO | started process 20730 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwXSYgq/profile http://localhost:47704/getInfo.html) 21:56:55 INFO - PROCESS | 20730 | 21:56:55 INFO - PROCESS | 20730 | (process:20798): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 21:56:56 INFO - PROCESS | 20730 | __metrics Screen width/height:1600/1200 21:56:56 INFO - PROCESS | 20730 | colorDepth:24 21:56:56 INFO - PROCESS | 20730 | Browser inner width/height: 1024/697 21:56:56 INFO - PROCESS | 20730 | __metrics 21:56:57 ERROR - PROCESS | 20730 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 21:56:58 INFO - TEST-INFO | 20730: exit 0 21:56:58 INFO - Browser initialized. 21:56:58 INFO - Running cycle 1/1 for dromaeo_css test... 21:56:58 INFO - TEST-INFO | started process 20850 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwXSYgq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:57:00 INFO - PROCESS | 20850 | 21:57:00 INFO - PROCESS | 20850 | (process:20912): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 21:57:10 INFO - PROCESS | 20850 | RSS: Main: 166604800 21:57:10 INFO - PROCESS | 20850 | 21:57:59 INFO - PROCESS | 20850 | 1464325079661 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] 22:00:07 INFO - PROCESS | 20850 | Cycle 1(1): loaded http://localhost:47704/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47704/tests/dromaeo/cssquery-ext.html) 22:00:08 INFO - PROCESS | 20850 | RSS: Main: 169697280 22:00:08 INFO - PROCESS | 20850 | 22:03:10 INFO - PROCESS | 20850 | Cycle 1(1): loaded http://localhost:47704/tests/dromaeo/cssquery-ext.html (next: http://localhost:47704/tests/dromaeo/cssquery-jquery.html) 22:03:10 INFO - PROCESS | 20850 | RSS: Main: 169250816 22:03:10 INFO - PROCESS | 20850 | 22:06:12 INFO - PROCESS | 20850 | Cycle 1(1): loaded http://localhost:47704/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47704/tests/dromaeo/cssquery-mootools.html) 22:06:13 INFO - PROCESS | 20850 | RSS: Main: 170475520 22:06:13 INFO - PROCESS | 20850 | 22:09:15 INFO - PROCESS | 20850 | Cycle 1(1): loaded http://localhost:47704/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47704/tests/dromaeo/cssquery-prototype.html) 22:09:15 INFO - PROCESS | 20850 | RSS: Main: 167845888 22:09:15 INFO - PROCESS | 20850 | 22:12:18 INFO - PROCESS | 20850 | Cycle 1(1): loaded http://localhost:47704/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47704/tests/dromaeo/cssquery-yui.html) 22:12:18 INFO - PROCESS | 20850 | RSS: Main: 169496576 22:12:18 INFO - PROCESS | 20850 | 22:15:21 INFO - PROCESS | 20850 | Cycle 1(1): loaded http://localhost:47704/tests/dromaeo/cssquery-yui.html (next: http://localhost:47704/tests/dromaeo/cssquery-dojo.html) 22:15:21 INFO - PROCESS | 20850 | RSS: Main: 170438656 22:15:21 INFO - PROCESS | 20850 | 22:15:21 INFO - PROCESS | 20850 | __start_tp_report 22:15:21 INFO - PROCESS | 20850 | _x_x_mozilla_page_load 22:15:21 INFO - PROCESS | 20850 | _x_x_mozilla_page_load_details 22:15:21 INFO - PROCESS | 20850 | |i|pagename|runs| 22:15:21 INFO - PROCESS | 20850 | |0;dojo.html;3090.582771325871;3139.3093519425747;3162.3359094590137;3171.2864605463774;3185.2196211928067;5420.783168673258;5450.591205659572;5450.645708028976;5464.09842376008;5494.835154945358;5287.180487024508;5348.893022139555;5410.729463526818;5439.347278326596;5450.56395488361;4879.1705410080285;4934.654574179809;5026.145555255615;5070.61970352225;5115.411727651312;884.4383079712458;4854.441739199984;4916.0905232532095;4972.627052971024;5008.2738002989545;4902.828401005965;4930.359053323081;4936.3829521309835;4970.552650261476;4972.751362431882;4986.077575648516;4989.925151122736;4993.325901003391;5009.824656137054;5011.123053465629;4904.828331008398;4913.336699545552;4924.433690125646;4939.456659767423;4961.280614310941;5299.390570084451;5342.1185504392115;5368.946310536884;5380.058489764315;5396.622236443451;5687.772489100473;5734.655920644775;5826.941730582682;5868.2371291732225;5869.8239052828485;5820.214271073435;5823.2138661280605;5850.785013603591;5854.853628659275;5877.706114694248;5466.726663666801;5484.067708489566;5489.231507588981;5495.505404513613;5502.257195278627;5755.510781583613;5962.314333851663;5974.163617093611;5976.8804623908145;6003.159557661931;5777.8555536111935;5794.188813566104;5797.681127538026;5816.854578635568;5838.766449342063;5840.3575606683235;5843.474087332161;5844.357120716718;5853;5869.383714709894;5534.640248383842;5598.664080155204;5762.884742305214;5844.532437404998;5872.265966754156;5729.88540229193;5768.884622307531;5771.942280577225;5776;5779.2775903012125;4405.493368262627;4413.955860441419;4418.624416924597;4420.336949457607;4459.130469558405;3835.4438606401914;3916.5104361954754;3922.6077392260545;3950.762954222698;3972.880813575597;5430.402655707869;5437.945620543823;5477.726113694379;5509.3664228613425;5518.53092487135;5670.518005969457;5809.68046757424;5826.504747096459;5826.796062137805;5843.707814609253;5428.240046393508;5482.369527504308;5512.944870551243;5545.112781954868;5568.220449137124;5016.824411145592;5023.271625614266;5035.395752509722;5048.040872234264;5069.163588008011;5998.1002849572915;6051.697415129226;6054.334023257438;6070.423309785563;6071.544634152457;5671.631343962712;5785.190073389813;5808.593398462067;5849.853753656193;5927.703614819242;6034.788782392595;6037.909431358621;6038.909416358671;6040.456358927718;6055.9091613626715;5759.452851979056;5776.162456443876;5779.393163717918;5780.132980053026;5787.768489260382;5636.520895723909;5853.414658534112;5864.970675146597;5900.940990590039;5920.467157955804;5716.171155182558;5732.856678583069;5734.54123670097;5757.91363129545;5768.682722450306;5529.695866727368;5667.376588575171;5695.430456954271;5704.258446401941;5735.713214339183;5468.507834294933;5486.643368181056;5498.505134537911;5513.641613295123;5514.255575497417;5627.718614069362;5642.210090587239;5683.062294721325;5683.7442315095095;5696.715164241688;5469.425710300361;5544.112941929272;5570.637908535932;5581.7209139543675;5584.301962254718 22:15:21 INFO - PROCESS | 20850 | |1;ext.html;576.1846986514083;617.9474744646704;625.9061140828875;633.8763941031498;639.4756299834137;31671.36657266856;42387;43081.569184308144;43131.13737725244;47106.293405598946;42565;42623.360649590206;42717;43025.92435189122;43049.7847510762;8747.562621868912;8890.466572005667;8931.687390941319;8955.462672239686;8959.328050396214;8796.252318552899;8854.114588541159;8916.01923788386;8936.017038125801;8959.865602015974;8824.911750882473;8842.602082906253;8982.550872456384;8985.820283594325;9006.639734410615;8899.95550022249;8902.243309318716;8941;8958.820823583557;8960.417572857743;8822.514761688104;8831.293496520328;8893.955530222373;8919.509426981513;8937.329700272441;41870.58129418697;42260;42524;42591.14817703629;42634.78682606567;3606.6213047629885;3622;3639.636036396339;3810.4474851146706;3859.614038596146;32782;33093.33813323744;33176;33266;33445.331093377994;4354.325079612665;4468.687191896569;4513.458384993789;4569.748663823489;4628.074385122955;346046;346569;347527;348684;349738;34367.656323436444;35412.29175416477;35444.64555354465;37032.814835925645;62104.37895620986;36161;36752.08119797026;36823.631763682555;36913;37029.81485092611;14848.480303189552;14863.405463781544;14939.925300373428;14988.700225995419;15036.624084397978;12303.323317217639;12386.5664701735;12402.441890114966;12459.626211213677;12462.127651064338;8345.248927596545;8399.160083991674;8414.326853851677;8423;8439.324854011664;3239.627442844056;3251.219707270285;3309.4351877294807;3321.5848018997626;3345.1971526833872;1059.078601616583;1063.8563793887881;1110.2672236323988;1166.1691936971413;1184.875588063241;33109;33145.83427082897;33521;33718.8314058433;34028.149296267795;1133.5125895864858;1148.242160174281;1167.3404526442532;1195.7548702515962;1244.9502019919282;17143.314267429414;17461.301547938194;17635.801853882138;17706.645867082585;17782.822171778374;512249;516151;518783;518885;520590;57159.428405716244;57797.71101144468;57990.71004645034;58087.70956145192;58244;1346.4614154338342;1381.7236552689503;1390.5967269491734;1407.8451370349253;1413.6607214268706;31000.379992400478;31875;32136.678633214306;32656;33090.834545827114;50397;50648.240276396624;50679.74660126676;50691;51204.48795511997;450199;452582;459682;462081;464417;27494.725052749218;27896.721032789414;28135;28327.15018549447;28386.574201386582;42756.35865461958;45153.322700160184;46519.53480465152;46606;46655.766721166176;38373.808130959165;39775.60224397835;39994.800025999684;40182.598174019055;40651;38207.752341051324;38723.612763872;38863.80568097141;38938;39608.40587391134;36477.45283820798;39857.80071099626;41977.790111049246;42301;43228.78385608052;34649.82675086609;37976.05059873525;38309.4253586202;38410.66857888368;38570.421443677806;29053.273668158465;29248.853755731085;29321.56017659694;29668;29697.554536681535 22:15:21 INFO - PROCESS | 20850 | |2;jquery.html;382.43781640987737;390.9960900390995;391.129736336651;400.73551456039013;416.0472517933932;13650.590482285548;16563.751543726838;17760.911195444038;17799.644007119867;17806.91096544517;17237.396691115813;18193.90903045483;18611.90694046528;19196.712049319238;19208.711869321938;5172.40517340506;5277.762500687479;5351.518363347298;5366.329208848894;5369.785208591652;5297.496737809902;5306.522412982831;5311.654742441749;5555;5895.174675545427;5926.970365148169;5930.436608522184;5950.37521060289;5975.790847320344;5993.160957465958;5770.6249093808765;5893.086571581412;6421.165248517709;6494.058361537551;6507.707153178071;5725.141228815669;5752.741126649311;5766.88466230673;5773.076307790733;5808.680522571257;21090.3672889812;21796.89101554482;22186.112555497763;22605.321840344815;22658.546829063493;2337.883105844701;2583.6253743207317;2633.5522961096467;2739.58906164075;2786.1084452975056;9822.361546499455;9875.555599998017;10509.211809114347;11554.942225288904;13778.586642400744;1916.319706504185;1991.5660724278641;2000.7699114601862;2038.9694154587544;2066.617675729995;79889.60055199687;82753.58623206845;83453.58273208595;84438.57780711057;84462.93222406675;11016;11111.611093611846;11113.277636953571;11258.774824503627;11379.886201138048;13304.933475332755;13957;15512.844871551366;15614.609634759221;15632.92183539075;7862.174471680506;7909.327707144842;7995.760127196193;8070.636821343053;8170.550619715973;7580.54516728998;7654.693812247448;7664.9616751917;7717.459777815499;7823.335016523545;4687.531246875285;4722.409698787652;4723.078999595046;4759.619230461555;4767.332573439721;1910.617876424693;1939.6120775844888;1939.7575303087115;1971.8957383865081;1977.317825350252;1012.3773879064322;1027.291169093323;1031.1493018259966;1061.2571200159919;1088.3306766338803;18820.153093110843;19310.32413865508;19626.464384389186;19667.21331146738;19742.309019184548;1013.5692330759398;1028.3572767020612;1031.200819364983;1031.4533297352416;1069.7539565899888;10169.593216271414;10913.454327283764;10952.945235273774;10987.285826421257;10992.615258466076;454342;466399;469824;478601;481048;93247;95430;95918.56122158174;95998;96433.51783241039;991.2070343724992;1010.8281592129356;1013.6502906497246;1014.0619926567895;1021.9846702299471;16899.577510562336;17144;17207.397741079003;17364.305427782747;17645.911770441067;29391.706082939752;29868.253293667833;30674.846625766728;35192.47211291884;37382.439263410524;52997.73501132624;55632.443675562725;56968.715156423954;57925.71037144787;58126.709366452895;8079.192080791874;8511.74464766058;8591.097934716765;8662.740117796477;8865;9584.467717255377;13328.733425331633;13455.517903479295;13602.659933501742;13744.244066576433;11458.541658333574;11834.289942603471;11936.104792140797;11991.580294689644;12125.27248365101;11560.826587601025;11582.362970036393;11732.296062236293;11803.940980295043;12045.879541204826;11748.118891083373;11755.235909665844;11863.288202707865;11903.166778325434;11950.820737689115;7480;7814.179511151247;8460.788480288042;8487.066422693622;8747.212750852454;11897.345645989553;12069;12146.514139434677;12174.391280435766;12206.389680515762 22:15:21 INFO - PROCESS | 20850 | |3;mootools.html;1459.233902201344;1511.10844601685;1644.6299582593917;1819.4086921750434;1827.9634407311846;7568.318851303396;8363.372747043966;8439.789005274872;8933.151350621689;8947.55262236888;8582.742517724462;8747.737567872959;8848.247898928583;8850.77873053174;8852.77868053299;2354.8940297686604;2390.4740956989435;2395.9161429349974;2399.748026457223;2401.3756423329974;2321.5240875620543;2322.129201549419;2323.5933711600487;2349.6005679034606;2350.165691179632;2348.5420343033115;2360.291912426274;2387.6299173628117;2403.170906037414;2412.445137618349;2362.9291121266306;2385.1294277588727;2389.390705370137;2402.3994001499627;2407.205622144697;2311.907523699067;2315.8610483371053;2330.93007209784;2339.7894189522854;2339.894704738291;8643;8659.307255419615;8701.47791132534;8722.607482663296;8728.821609082755;5221.503957124067;5253.6322457428;5298.947010529922;5330.92003619946;5396.244525766396;3376.898693039213;3418.1454636340914;3468.9479657805155;3469.774464659789;3482.3905816482015;1209.105262106044;1212.1696637803134;1214.7206142587254;1223.455562274788;1227.1348699167154;12078.154529182873;12079.09406794494;12093.697657558543;12117.818232726517;12128.272303661808;4406.3170208617075;4576.931346029813;4623.953760462419;4646.163690535668;4665.440147182292;10201.693949181536;10206.4386458744;10213.846792298122;10215.7446063849;10226.130778883879;5235.345581802275;5235.502627250406;5253.816116435906;5263.105272103751;5271.6309858310315;4217.936730949038;4781.904361912742;4790.784414701347;4923.138450771101;4926.433460152057;3999.5000624921886;4061.268971585084;4111;4112.403701463271;4118.938215926763;1330.7937269723209;1332.5602551158095;1343.4424713743688;1350.8108864758942;1351.4053816320788;902.2105657549644;1008.193445243802;1023.9846402303972;1026.0509029148009;1049.532957833772;6090.939090609126;6191.9690401547705;6278.121063051177;6290.748370065146;6290.905636415458;460.5233583241329;470.1818835226749;470.96703230773517;480.3659169895774;481.6676493219737;4220.6412454941055;4270.231358355463;4271.31658934569;4293.957060429419;4324.848630297987;10743.24797264184;10858.402787846744;11046.613368532062;11049.944750276358;11055;10563.841542376871;10731.141508679288;10765.515551800188;10882.183836212316;10888.346699198073;8011.679532818738;8050.798730031679;8084.151164127799;8132.430729848854;8180.67277308901;5882.1470886722045;5888.499477544457;5909.202257695156;6045.939540604538;6106.511479081574;9552.283578731762;10005.54975026111;10008.599656013677;10032.347897386646;10103.444310562989;9999.55002024896;10140.188784897338;10191.184705223712;10264.486775661337;10295.330803497749;6905.482088843256;7517.887231691419;7587.279208475186;7594.126675432396;7860.84278314442;8516.829663406574;8590.78523036929;8596;8697.391182617155;8705.347098967477;7566.281203285679;7779.066512018594;7826.686932522863;7829.1779363168325;7903.051633803981;7626.847463050819;7719.961400192963;7739.7678069658;7841.451098423056;7847.646855891385;6944.583325000516;6990.161180658353;7020.157581090302;7051.224365319708;7068.363847253772;5166.844994650167;5280.683159010472;5399.649022813504;5413.269208656781;5424.159255315432;5201.817936372209;5273.5781137509675;5308.389535203347;5397.352317721741;5464.726763661881 22:15:21 INFO - PROCESS | 20850 | |4;prototype.html;321.7667191286318;334.6185348702479;338.4770529531873;339.8148009334912;340.64232555816386;5473.425290344516;5617.522510586605;5722.284714410699;5779.450952159544;5783.45057219564;5532.585056120787;5613.382527921925;5641.435856414367;5643.463870932255;5650.237217975572;4379.58393952574;4394.033312671223;4396.274614688573;4404.471463424377;4414.558544145576;4148.813303401339;4356.455443069616;4359.760213188273;4421.867343979686;4444.555544445546;4267.701260911737;4270.743755374672;4276.636485898703;4283.957160428387;4288.206681763883;4283.892902677427;4300.827966881337;4308.784560771949;4359.149965756678;4374.518802931675;3542.2738338640515;3770.5852356240794;3771.6039815819217;3772.3775577030033;3775.6790672792845;5440.319960004999;5441;5453.563714902798;5471.5896307777075;5546;4892.730899800509;4926.285688575136;4930.605551555867;4931.876703082416;4941.160002799496;5583.497485226349;5894.646321220697;5894.764209431661;5904.852378690524;5919.852003699942;4208.579142085798;4214.473190851144;4225.535191128974;4239.27932251518;4240.533541310453;6187.721552530102;6191.845203869894;6201.689915504252;6208.937910620881;6210.7515699371515;4097.467329247179;4240.664190779895;4256.659467242614;4272.359146128106;4274.5939135782055;4248.299030659907;4268.59448352406;4275.615194632436;4310.159518893785;4318.114786468766;4956.975215123901;4968.403791545038;4994.975025124923;5002.1496345621335;5007.273945277914;5815.680137592389;5970.940290597038;5987.161797348374;5997.460228579449;6063.332583539562;1463.948761793332;1486.5317425011087;1490.5528341497507;1495.5438591229563;1495.8728508076936;916.504854368932;930.6370515498961;942.4251206763869;945.652445265494;959.5825815770023;4967.90064198714;5026.59787217029;5055.216441451581;5098.9490105098475;5128.282040514257;5437.755301011464;5440.075187218104;5445.346558412936;5467.812874850092;5479.945200548023;5030.346055012825;5036.244563315532;5128.435872054071;5146.974265128651;5207.281597072957;2923.693012233685;2927.653279491458;2934.884743797386;2951.631046119235;2963.2443726849947;5478.643888147258;5511.173324001432;5532.944670553324;5662.490375866192;5681.34664513578;5246.68832791802;5525.309336332958;5531.25328080712;5550.47270509301;5603.170398948505;5510.283663123768;5521.371195497338;5595.929506082694;5650.830475085754;5683.687397193194;5237.952409518035;5404.432534583812;5439.864003399788;5478.424765399575;5552;5276.366835979554;5480.890382192254;5483.424240454695;5484.424135465878;5485.985092757853;5483.698396588226;5519.254900588369;5540.418256083214;5552.528579926404;6047.848803779941;4126.66986641062;4262.403263543169;4273.508546517191;4282.743035417885;4286.442762440863;6111.633302001716;6113.480354169767;6123.14276001369;6148.292946311231;6162.414570615784;5675.68783716883;5821;5894.6757928314355;5962.25471816023;5967.283925928917;5870.412958704095;5889.705514724161;5891.528677705859;5912.586118971631;5917.1715959766525;5707.157647880581;5771.7114144293455;5793.204106726928;5806.535477161901;5832.679202643895;5711.600187986967;5886.793962211302;5902.852428689317;5960.254968128984;5967.76128954837;5741.425857414225;5811.750473648186;5820.817193552418;5821.738021788945;5824.650520968756 22:15:21 INFO - PROCESS | 20850 | |5;yui.html;758.6434375843352;817.8282560662261;827.8923739913812;831.6831683168313;843.1863251961855;14562.490312839052;15424.61438464039;15455.30451129699;15465.768013479792;15476.38094476221;13980.37088331025;14176.50382236622;14422.206778627171;14432.5670229893;14490.927545362258;794.2097612875198;807.0597753617044;813.1137060603941;818.4557269415832;819.2217393476192;835.1439774231401;836.2724429746129;838.2288294768828;840.4999025579771;840.5461051032435;869.0006492533573;875.995620021899;881.299367003234;881.7310720230328;884.1909652667802;869.8782170496104;871.9389642725012;876.3733930239878;876.8903887014123;876.9693060742875;630.7350912616712;631.0219160301514;633.5375176121457;638.2149955554694;638.9137466442018;14808.111513309235;14907.850921490755;14924.62688432787;14968.17675027873;15149.242537873173;14042.227677477735;14092.2953852308;14098.577042688736;14098.859011409857;14200.928995354958;11597.536098556047;11709.590164344292;11727.648170554812;11957.701057473545;12075.154739168262;3838.500994870649;3890.1247219375414;3942.9014274643364;4048.4534587830562;4053.128577355853;60721.69639151776;61211.69394153045;61310.38689613091;61414.69292653553;61594;10849.457527123612;10992.835107473395;11122.55509779616;11168.93895079966;11814.763704725858;19917.502062448264;20039.899800501196;20084;20122.597548048958;20209.292674756314;8188.631511581993;8446.155384461505;8532.061473237938;8722.86915696265;8731.083236260101;4744.715317080986;4792.544708252711;4826.251930950638;4832.685875418157;5040.672356296829;3606.495090687306;3697.242065376591;3703.777773333609;3711.0722319420147;3714.665680088805;626.0827887145354;657.1883723601348;659.2616269777784;659.82184810101;663.9236487803868;705.9188193357727;750.3097150621442;768.1166658342838;782.7534326687075;792.3146478296347;9766.121049105615;9850.950745246228;9996.700098997042;10150.289479736495;10213.897861021444;632.2223664892208;701.2741812224324;754.9622518874035;767.8980662748974;772.3589420780851;4613.746243956614;4689.226277664147;4691.81232750693;4708.858734237979;4794.9280760788615;72424.27575724175;72831.63584182151;73171.2682873175;74499.25500745031;74971;56926.715366423734;57401;58612;64546.35453645497;65936.34063659397;53579.19631205535;54235.18647220295;54892.72553637286;55100;56052;9908.455034972858;9962.103410693073;9994.350367226107;10090.798184036132;10208;36762.26475470529;36887.44668830023;37293.81353093217;37312.253754925296;37411.43882841814;45365;47240;47508.52491475179;48034.75982620064;48654.75672621614;11771;11990.880091198977;12536;12616.306103164414;12792.424340904496;13422.530211442552;13740;13909.51316703951;14242.145471271757;14620.853791462374;12871.485140594272;13067.542636007694;13085.803712944124;13097.41061652209;13164.670883227996;12649.93675031619;13540.729185416434;13812.447502100205;13825.654358641115;14346.784798228244;11353.148513861328;11725.941370293094;11819.527218911491;11827.467763950472;11843;10700.197485188486;10718.946405267923;10895;10897.618583349546;11238.606648767254;11498.655040348804;11525.538978440769;11610;11798.292102473879;11844.881551184379 22:15:21 INFO - PROCESS | 20850 | __end_tp_report 22:15:21 INFO - PROCESS | 20850 | __start_cc_report 22:15:21 INFO - PROCESS | 20850 | _x_x_mozilla_cycle_collect,342 22:15:21 INFO - PROCESS | 20850 | __end_cc_report 22:15:21 INFO - PROCESS | 20850 | __startTimestamp1464326121493__endTimestamp 22:15:21 INFO - PROCESS | 20850 | 22:15:21 INFO - PROCESS | 20850 | ------- Summary: start ------- 22:15:21 INFO - PROCESS | 20850 | Number of tests: 6 22:15:21 INFO - PROCESS | 20850 | 22:15:21 INFO - PROCESS | 20850 | [#0] dojo.html Cycles:165 Average:5374.31 Median:5568.22 stddev:708.36 (12.7%) stddev-sans-first:687.50 22:15:21 INFO - PROCESS | 20850 | Values: 3090.6 3139.3 3162.3 3171.3 3185.2 5420.8 5450.6 5450.6 5464.1 5494.8 5287.2 5348.9 5410.7 5439.3 5450.6 4879.2 4934.7 5026.1 5070.6 5115.4 884.4 4854.4 4916.1 4972.6 5008.3 4902.8 4930.4 4936.4 4970.6 4972.8 4986.1 4989.9 4993.3 5009.8 5011.1 4904.8 4913.3 4924.4 4939.5 4961.3 5299.4 5342.1 5368.9 5380.1 5396.6 5687.8 5734.7 5826.9 5868.2 5869.8 5820.2 5823.2 5850.8 5854.9 5877.7 5466.7 5484.1 5489.2 5495.5 5502.3 5755.5 5962.3 5974.2 5976.9 6003.2 5777.9 5794.2 5797.7 5816.9 5838.8 5840.4 5843.5 5844.4 5853.0 5869.4 5534.6 5598.7 5762.9 5844.5 5872.3 5729.9 5768.9 5771.9 5776.0 5779.3 4405.5 4414.0 4418.6 4420.3 4459.1 3835.4 3916.5 3922.6 3950.8 3972.9 5430.4 5437.9 5477.7 5509.4 5518.5 5670.5 5809.7 5826.5 5826.8 5843.7 5428.2 5482.4 5512.9 5545.1 5568.2 5016.8 5023.3 5035.4 5048.0 5069.2 5998.1 6051.7 6054.3 6070.4 6071.5 5671.6 5785.2 5808.6 5849.9 5927.7 6034.8 6037.9 6038.9 6040.5 6055.9 5759.5 5776.2 5779.4 5780.1 5787.8 5636.5 5853.4 5865.0 5900.9 5920.5 5716.2 5732.9 5734.5 5757.9 5768.7 5529.7 5667.4 5695.4 5704.3 5735.7 5468.5 5486.6 5498.5 5513.6 5514.3 5627.7 5642.2 5683.1 5683.7 5696.7 5469.4 5544.1 5570.6 5581.7 5584.3 22:15:21 INFO - PROCESS | 20850 | 22:15:21 INFO - PROCESS | 20850 | [#1] ext.html Cycles:180 Average:58558.63 Median:39273.20 stddev:118592.02 (302.0%) stddev-sans-first:118844.79 22:15:21 INFO - PROCESS | 20850 | Values: 576.2 617.9 625.9 633.9 639.5 31671.4 42387.0 43081.6 43131.1 47106.3 42565.0 42623.4 42717.0 43025.9 43049.8 8747.6 8890.5 8931.7 8955.5 8959.3 8796.3 8854.1 8916.0 8936.0 8959.9 8824.9 8842.6 8982.6 8985.8 9006.6 8900.0 8902.2 8941.0 8958.8 8960.4 8822.5 8831.3 8894.0 8919.5 8937.3 41870.6 42260.0 42524.0 42591.1 42634.8 3606.6 3622.0 3639.6 3810.4 3859.6 32782.0 33093.3 33176.0 33266.0 33445.3 4354.3 4468.7 4513.5 4569.7 4628.1 346046.0 346569.0 347527.0 348684.0 349738.0 34367.7 35412.3 35444.6 37032.8 62104.4 36161.0 36752.1 36823.6 36913.0 37029.8 14848.5 14863.4 14939.9 14988.7 15036.6 12303.3 12386.6 12402.4 12459.6 12462.1 8345.2 8399.2 8414.3 8423.0 8439.3 3239.6 3251.2 3309.4 3321.6 3345.2 1059.1 1063.9 1110.3 1166.2 1184.9 33109.0 33145.8 33521.0 33718.8 34028.1 1133.5 1148.2 1167.3 1195.8 1245.0 17143.3 17461.3 17635.8 17706.6 17782.8 512249.0 516151.0 518783.0 518885.0 520590.0 57159.4 57797.7 57990.7 58087.7 58244.0 1346.5 1381.7 1390.6 1407.8 1413.7 31000.4 31875.0 32136.7 32656.0 33090.8 50397.0 50648.2 50679.7 50691.0 51204.5 450199.0 452582.0 459682.0 462081.0 464417.0 27494.7 27896.7 28135.0 28327.2 28386.6 42756.4 45153.3 46519.5 46606.0 46655.8 38373.8 39775.6 39994.8 40182.6 40651.0 38207.8 38723.6 38863.8 38938.0 39608.4 36477.5 39857.8 41977.8 42301.0 43228.8 34649.8 37976.1 38309.4 38410.7 38570.4 29053.3 29248.9 29321.6 29668.0 29697.6 22:15:21 INFO - PROCESS | 20850 | 22:15:21 INFO - PROCESS | 20850 | [#2] jquery.html Cycles:180 Average:28204.55 Median:12498.21 stddev:77712.84 (621.8%) stddev-sans-first:77902.77 22:15:21 INFO - PROCESS | 20850 | Values: 382.4 391.0 391.1 400.7 416.0 13650.6 16563.8 17760.9 17799.6 17806.9 17237.4 18193.9 18611.9 19196.7 19208.7 5172.4 5277.8 5351.5 5366.3 5369.8 5297.5 5306.5 5311.7 5555.0 5895.2 5927.0 5930.4 5950.4 5975.8 5993.2 5770.6 5893.1 6421.2 6494.1 6507.7 5725.1 5752.7 5766.9 5773.1 5808.7 21090.4 21796.9 22186.1 22605.3 22658.5 2337.9 2583.6 2633.6 2739.6 2786.1 9822.4 9875.6 10509.2 11554.9 13778.6 1916.3 1991.6 2000.8 2039.0 2066.6 79889.6 82753.6 83453.6 84438.6 84462.9 11016.0 11111.6 11113.3 11258.8 11379.9 13304.9 13957.0 15512.8 15614.6 15632.9 7862.2 7909.3 7995.8 8070.6 8170.6 7580.5 7654.7 7665.0 7717.5 7823.3 4687.5 4722.4 4723.1 4759.6 4767.3 1910.6 1939.6 1939.8 1971.9 1977.3 1012.4 1027.3 1031.1 1061.3 1088.3 18820.2 19310.3 19626.5 19667.2 19742.3 1013.6 1028.4 1031.2 1031.5 1069.8 10169.6 10913.5 10952.9 10987.3 10992.6 454342.0 466399.0 469824.0 478601.0 481048.0 93247.0 95430.0 95918.6 95998.0 96433.5 991.2 1010.8 1013.7 1014.1 1022.0 16899.6 17144.0 17207.4 17364.3 17645.9 29391.7 29868.3 30674.8 35192.5 37382.4 52997.7 55632.4 56968.7 57925.7 58126.7 8079.2 8511.7 8591.1 8662.7 8865.0 9584.5 13328.7 13455.5 13602.7 13744.2 11458.5 11834.3 11936.1 11991.6 12125.3 11560.8 11582.4 11732.3 11803.9 12045.9 11748.1 11755.2 11863.3 11903.2 11950.8 7480.0 7814.2 8460.8 8487.1 8747.2 11897.3 12069.0 12146.5 12174.4 12206.4 22:15:21 INFO - PROCESS | 20850 | 22:15:21 INFO - PROCESS | 20850 | [#3] mootools.html Cycles:180 Average:5801.54 Median:2542.24 stddev:3257.94 (128.2%) stddev-sans-first:3250.74 22:15:21 INFO - PROCESS | 20850 | Values: 1459.2 1511.1 1644.6 1819.4 1828.0 7568.3 8363.4 8439.8 8933.2 8947.6 8582.7 8747.7 8848.2 8850.8 8852.8 2354.9 2390.5 2395.9 2399.7 2401.4 2321.5 2322.1 2323.6 2349.6 2350.2 2348.5 2360.3 2387.6 2403.2 2412.4 2362.9 2385.1 2389.4 2402.4 2407.2 2311.9 2315.9 2330.9 2339.8 2339.9 8643.0 8659.3 8701.5 8722.6 8728.8 5221.5 5253.6 5298.9 5330.9 5396.2 3376.9 3418.1 3468.9 3469.8 3482.4 1209.1 1212.2 1214.7 1223.5 1227.1 12078.2 12079.1 12093.7 12117.8 12128.3 4406.3 4576.9 4624.0 4646.2 4665.4 10201.7 10206.4 10213.8 10215.7 10226.1 5235.3 5235.5 5253.8 5263.1 5271.6 4217.9 4781.9 4790.8 4923.1 4926.4 3999.5 4061.3 4111.0 4112.4 4118.9 1330.8 1332.6 1343.4 1350.8 1351.4 902.2 1008.2 1024.0 1026.1 1049.5 6090.9 6192.0 6278.1 6290.7 6290.9 460.5 470.2 471.0 480.4 481.7 4220.6 4270.2 4271.3 4294.0 4324.8 10743.2 10858.4 11046.6 11049.9 11055.0 10563.8 10731.1 10765.5 10882.2 10888.3 8011.7 8050.8 8084.2 8132.4 8180.7 5882.1 5888.5 5909.2 6045.9 6106.5 9552.3 10005.5 10008.6 10032.3 10103.4 9999.6 10140.2 10191.2 10264.5 10295.3 6905.5 7517.9 7587.3 7594.1 7860.8 8516.8 8590.8 8596.0 8697.4 8705.3 7566.3 7779.1 7826.7 7829.2 7903.1 7626.8 7720.0 7739.8 7841.5 7847.6 6944.6 6990.2 7020.2 7051.2 7068.4 5166.8 5280.7 5399.6 5413.3 5424.2 5201.8 5273.6 5308.4 5397.4 5464.7 22:15:21 INFO - PROCESS | 20850 | 22:15:21 INFO - PROCESS | 20850 | [#4] prototype.html Cycles:180 Average:4793.67 Median:5460.69 stddev:1399.27 (25.6%) stddev-sans-first:1362.35 22:15:21 INFO - PROCESS | 20850 | Values: 321.8 334.6 338.5 339.8 340.6 5473.4 5617.5 5722.3 5779.5 5783.5 5532.6 5613.4 5641.4 5643.5 5650.2 4379.6 4394.0 4396.3 4404.5 4414.6 4148.8 4356.5 4359.8 4421.9 4444.6 4267.7 4270.7 4276.6 4284.0 4288.2 4283.9 4300.8 4308.8 4359.1 4374.5 3542.3 3770.6 3771.6 3772.4 3775.7 5440.3 5441.0 5453.6 5471.6 5546.0 4892.7 4926.3 4930.6 4931.9 4941.2 5583.5 5894.6 5894.8 5904.9 5919.9 4208.6 4214.5 4225.5 4239.3 4240.5 6187.7 6191.8 6201.7 6208.9 6210.8 4097.5 4240.7 4256.7 4272.4 4274.6 4248.3 4268.6 4275.6 4310.2 4318.1 4957.0 4968.4 4995.0 5002.1 5007.3 5815.7 5970.9 5987.2 5997.5 6063.3 1463.9 1486.5 1490.6 1495.5 1495.9 916.5 930.6 942.4 945.7 959.6 4967.9 5026.6 5055.2 5098.9 5128.3 5437.8 5440.1 5445.3 5467.8 5479.9 5030.3 5036.2 5128.4 5147.0 5207.3 2923.7 2927.7 2934.9 2951.6 2963.2 5478.6 5511.2 5532.9 5662.5 5681.3 5246.7 5525.3 5531.3 5550.5 5603.2 5510.3 5521.4 5595.9 5650.8 5683.7 5238.0 5404.4 5439.9 5478.4 5552.0 5276.4 5480.9 5483.4 5484.4 5486.0 5483.7 5519.3 5540.4 5552.5 6047.8 4126.7 4262.4 4273.5 4282.7 4286.4 6111.6 6113.5 6123.1 6148.3 6162.4 5675.7 5821.0 5894.7 5962.3 5967.3 5870.4 5889.7 5891.5 5912.6 5917.2 5707.2 5771.7 5793.2 5806.5 5832.7 5711.6 5886.8 5902.9 5960.3 5967.8 5741.4 5811.8 5820.8 5821.7 5824.7 22:15:21 INFO - PROCESS | 20850 | 22:15:21 INFO - PROCESS | 20850 | [#5] yui.html Cycles:180 Average:16014.04 Median:4651.49 stddev:19226.79 (413.3%) stddev-sans-first:19246.60 22:15:21 INFO - PROCESS | 20850 | Values: 758.6 817.8 827.9 831.7 843.2 14562.5 15424.6 15455.3 15465.8 15476.4 13980.4 14176.5 14422.2 14432.6 14490.9 794.2 807.1 813.1 818.5 819.2 835.1 836.3 838.2 840.5 840.5 869.0 876.0 881.3 881.7 884.2 869.9 871.9 876.4 876.9 877.0 630.7 631.0 633.5 638.2 638.9 14808.1 14907.9 14924.6 14968.2 15149.2 14042.2 14092.3 14098.6 14098.9 14200.9 11597.5 11709.6 11727.6 11957.7 12075.2 3838.5 3890.1 3942.9 4048.5 4053.1 60721.7 61211.7 61310.4 61414.7 61594.0 10849.5 10992.8 11122.6 11168.9 11814.8 19917.5 20039.9 20084.0 20122.6 20209.3 8188.6 8446.2 8532.1 8722.9 8731.1 4744.7 4792.5 4826.3 4832.7 5040.7 3606.5 3697.2 3703.8 3711.1 3714.7 626.1 657.2 659.3 659.8 663.9 705.9 750.3 768.1 782.8 792.3 9766.1 9851.0 9996.7 10150.3 10213.9 632.2 701.3 755.0 767.9 772.4 4613.7 4689.2 4691.8 4708.9 4794.9 72424.3 72831.6 73171.3 74499.3 74971.0 56926.7 57401.0 58612.0 64546.4 65936.3 53579.2 54235.2 54892.7 55100.0 56052.0 9908.5 9962.1 9994.4 10090.8 10208.0 36762.3 36887.4 37293.8 37312.3 37411.4 45365.0 47240.0 47508.5 48034.8 48654.8 11771.0 11990.9 12536.0 12616.3 12792.4 13422.5 13740.0 13909.5 14242.1 14620.9 12871.5 13067.5 13085.8 13097.4 13164.7 12649.9 13540.7 13812.4 13825.7 14346.8 11353.1 11725.9 11819.5 11827.5 11843.0 10700.2 10718.9 10895.0 10897.6 11238.6 11498.7 11525.5 11610.0 11798.3 11844.9 22:15:21 INFO - PROCESS | 20850 | -------- Summary: end -------- 22:15:21 INFO - PROCESS | 20850 | 22:15:22 INFO - TEST-INFO | 20850: exit 0 22:15:22 INFO - TEST-OK | dromaeo_css | took 1110254ms 22:15:22 INFO - TEST-START | kraken 22:15:22 INFO - operating with platform_type : linux_ 22:15:22 INFO - Initialising browser for kraken test... 22:15:22 INFO - TEST-INFO | started process 21084 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcWgBAU/profile http://localhost:47704/getInfo.html) 22:15:26 INFO - PROCESS | 21084 | 22:15:26 INFO - PROCESS | 21084 | (process:21154): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 22:15:26 INFO - PROCESS | 21084 | __metrics Screen width/height:1600/1200 22:15:26 INFO - PROCESS | 21084 | colorDepth:24 22:15:26 INFO - PROCESS | 21084 | Browser inner width/height: 1024/697 22:15:26 INFO - PROCESS | 21084 | __metrics 22:15:27 ERROR - PROCESS | 21084 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 22:15:28 INFO - TEST-INFO | 21084: exit 0 22:15:28 INFO - Browser initialized. 22:15:28 INFO - Running cycle 1/1 for kraken test... 22:15:28 INFO - TEST-INFO | started process 21205 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcWgBAU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:15:30 INFO - PROCESS | 21205 | 22:15:30 INFO - PROCESS | 21205 | (process:21265): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 22:15:40 INFO - PROCESS | 21205 | RSS: Main: 167116800 22:15:40 INFO - PROCESS | 21205 | 22:15:42 INFO - PROCESS | 21205 | Cycle 1(1): loaded http://localhost:47704/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47704/tests/kraken/driver.html?testName=audio-beat-detection) 22:15:43 INFO - PROCESS | 21205 | RSS: Main: 172032000 22:15:43 INFO - PROCESS | 21205 | 22:15:46 INFO - PROCESS | 21205 | Cycle 1(1): loaded http://localhost:47704/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47704/tests/kraken/driver.html?testName=audio-dft) 22:15:46 INFO - PROCESS | 21205 | RSS: Main: 171347968 22:15:46 INFO - PROCESS | 21205 | 22:15:49 INFO - PROCESS | 21205 | Cycle 1(1): loaded http://localhost:47704/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47704/tests/kraken/driver.html?testName=audio-fft) 22:15:50 INFO - PROCESS | 21205 | RSS: Main: 165748736 22:15:50 INFO - PROCESS | 21205 | 22:15:52 INFO - PROCESS | 21205 | Cycle 1(1): loaded http://localhost:47704/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47704/tests/kraken/driver.html?testName=audio-oscillator) 22:15:53 INFO - PROCESS | 21205 | RSS: Main: 166739968 22:15:53 INFO - PROCESS | 21205 | 22:15:55 INFO - PROCESS | 21205 | Cycle 1(1): loaded http://localhost:47704/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47704/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:15:55 INFO - PROCESS | 21205 | RSS: Main: 167174144 22:15:55 INFO - PROCESS | 21205 | 22:15:58 INFO - PROCESS | 21205 | Cycle 1(1): loaded http://localhost:47704/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47704/tests/kraken/driver.html?testName=imaging-darkroom) 22:15:59 INFO - PROCESS | 21205 | RSS: Main: 166694912 22:15:59 INFO - PROCESS | 21205 | 22:16:02 INFO - PROCESS | 21205 | Cycle 1(1): loaded http://localhost:47704/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47704/tests/kraken/driver.html?testName=imaging-desaturate) 22:16:03 INFO - PROCESS | 21205 | RSS: Main: 165036032 22:16:03 INFO - PROCESS | 21205 | 22:16:06 INFO - PROCESS | 21205 | Cycle 1(1): loaded http://localhost:47704/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47704/tests/kraken/driver.html?testName=json-parse-financial) 22:16:07 INFO - PROCESS | 21205 | RSS: Main: 167149568 22:16:07 INFO - PROCESS | 21205 | 22:16:08 INFO - PROCESS | 21205 | Cycle 1(1): loaded http://localhost:47704/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47704/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:16:09 INFO - PROCESS | 21205 | RSS: Main: 166993920 22:16:09 INFO - PROCESS | 21205 | 22:16:11 INFO - PROCESS | 21205 | Cycle 1(1): loaded http://localhost:47704/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47704/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:16:11 INFO - PROCESS | 21205 | RSS: Main: 167391232 22:16:11 INFO - PROCESS | 21205 | 22:16:13 INFO - PROCESS | 21205 | Cycle 1(1): loaded http://localhost:47704/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47704/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:16:14 INFO - PROCESS | 21205 | RSS: Main: 167452672 22:16:14 INFO - PROCESS | 21205 | 22:16:16 INFO - PROCESS | 21205 | Cycle 1(1): loaded http://localhost:47704/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47704/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:16:17 INFO - PROCESS | 21205 | RSS: Main: 168026112 22:16:17 INFO - PROCESS | 21205 | 22:16:20 INFO - PROCESS | 21205 | Cycle 1(1): loaded http://localhost:47704/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47704/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:16:20 INFO - PROCESS | 21205 | RSS: Main: 167731200 22:16:20 INFO - PROCESS | 21205 | 22:16:22 INFO - PROCESS | 21205 | Cycle 1(1): loaded http://localhost:47704/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47704/tests/kraken/driver.html?testName=ai-astar) 22:16:22 INFO - PROCESS | 21205 | RSS: Main: 168497152 22:16:22 INFO - PROCESS | 21205 | 22:16:22 INFO - PROCESS | 21205 | __start_tp_report 22:16:22 INFO - PROCESS | 21205 | _x_x_mozilla_page_load 22:16:22 INFO - PROCESS | 21205 | _x_x_mozilla_page_load_details 22:16:22 INFO - PROCESS | 21205 | |i|pagename|runs| 22:16:22 INFO - PROCESS | 21205 | |0;ai-astar;111;106;111;111;111;110;111;109;110;110 22:16:22 INFO - PROCESS | 21205 | |1;audio-beat-detection;152;123;156;179;132;157;149;131;184;125 22:16:22 INFO - PROCESS | 21205 | |2;audio-dft;162;164;162;160;162;163;167;166;163;167 22:16:22 INFO - PROCESS | 21205 | |3;audio-fft;76;75;74;169;75;78;73;75;155;74 22:16:22 INFO - PROCESS | 21205 | |4;audio-oscillator;83;83;164;83;83;82;142;84;84;139 22:16:22 INFO - PROCESS | 21205 | |5;imaging-gaussian-blur;119;117;117;118;117;117;117;117;117;118 22:16:22 INFO - PROCESS | 21205 | |6;imaging-darkroom;146;148;147;146;147;149;147;146;147;147 22:16:22 INFO - PROCESS | 21205 | |7;imaging-desaturate;96;96;97;95;95;95;96;96;95;95 22:16:22 INFO - PROCESS | 21205 | |8;json-parse-financial;57;56;55;56;55;59;57;54;55;55 22:16:22 INFO - PROCESS | 21205 | |9;json-stringify-tinderbox;60;61;60;61;61;61;61;61;61;61 22:16:22 INFO - PROCESS | 21205 | |10;stanford-crypto-aes;84;79;85;78;79;80;85;81;103;84 22:16:22 INFO - PROCESS | 21205 | |11;stanford-crypto-ccm;134;122;126;124;118;130;126;127;135;127 22:16:22 INFO - PROCESS | 21205 | |12;stanford-crypto-pbkdf2;159;160;163;159;159;165;163;162;157;160 22:16:22 INFO - PROCESS | 21205 | |13;stanford-crypto-sha256-iterative;62;63;71;66;62;63;61;63;62;61 22:16:22 INFO - PROCESS | 21205 | __end_tp_report 22:16:22 INFO - PROCESS | 21205 | __start_cc_report 22:16:22 INFO - PROCESS | 21205 | _x_x_mozilla_cycle_collect,861 22:16:22 INFO - PROCESS | 21205 | __end_cc_report 22:16:22 INFO - PROCESS | 21205 | __startTimestamp1464326182825__endTimestamp 22:16:22 INFO - PROCESS | 21205 | 22:16:22 INFO - PROCESS | 21205 | ------- Summary: start ------- 22:16:22 INFO - PROCESS | 21205 | Number of tests: 14 22:16:22 INFO - PROCESS | 21205 | 22:16:22 INFO - PROCESS | 21205 | [#0] ai-astar Cycles:10 Average:110.00 Median:111.00 stddev:1.56 (1.4%) stddev-sans-first:1.62 22:16:22 INFO - PROCESS | 21205 | Values: 111.0 106.0 111.0 111.0 111.0 110.0 111.0 109.0 110.0 110.0 22:16:22 INFO - PROCESS | 21205 | 22:16:22 INFO - PROCESS | 21205 | [#1] audio-beat-detection Cycles:10 Average:148.80 Median:154.00 stddev:21.37 (13.9%) stddev-sans-first:22.64 22:16:22 INFO - PROCESS | 21205 | Values: 152.0 123.0 156.0 179.0 132.0 157.0 149.0 131.0 184.0 125.0 22:16:22 INFO - PROCESS | 21205 | 22:16:22 INFO - PROCESS | 21205 | [#2] audio-dft Cycles:10 Average:163.60 Median:163.50 stddev:2.37 (1.4%) stddev-sans-first:2.44 22:16:22 INFO - PROCESS | 21205 | Values: 162.0 164.0 162.0 160.0 162.0 163.0 167.0 166.0 163.0 167.0 22:16:22 INFO - PROCESS | 21205 | 22:16:22 INFO - PROCESS | 21205 | [#3] audio-fft Cycles:10 Average:92.40 Median:75.00 stddev:36.85 (49.1%) stddev-sans-first:38.61 22:16:22 INFO - PROCESS | 21205 | Values: 76.0 75.0 74.0 169.0 75.0 78.0 73.0 75.0 155.0 74.0 22:16:22 INFO - PROCESS | 21205 | 22:16:22 INFO - PROCESS | 21205 | [#4] audio-oscillator Cycles:10 Average:102.70 Median:83.00 stddev:32.15 (38.7%) stddev-sans-first:33.30 22:16:22 INFO - PROCESS | 21205 | Values: 83.0 83.0 164.0 83.0 83.0 82.0 142.0 84.0 84.0 139.0 22:16:22 INFO - PROCESS | 21205 | 22:16:22 INFO - PROCESS | 21205 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:117.00 stddev:0.70 (0.6%) stddev-sans-first:0.44 22:16:22 INFO - PROCESS | 21205 | Values: 119.0 117.0 117.0 118.0 117.0 117.0 117.0 117.0 117.0 118.0 22:16:22 INFO - PROCESS | 21205 | 22:16:22 INFO - PROCESS | 21205 | [#6] imaging-darkroom Cycles:10 Average:147.00 Median:147.00 stddev:0.94 (0.6%) stddev-sans-first:0.93 22:16:22 INFO - PROCESS | 21205 | Values: 146.0 148.0 147.0 146.0 147.0 149.0 147.0 146.0 147.0 147.0 22:16:22 INFO - PROCESS | 21205 | 22:16:22 INFO - PROCESS | 21205 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.70 (0.7%) stddev-sans-first:0.73 22:16:22 INFO - PROCESS | 21205 | Values: 96.0 96.0 97.0 95.0 95.0 95.0 96.0 96.0 95.0 95.0 22:16:22 INFO - PROCESS | 21205 | 22:16:22 INFO - PROCESS | 21205 | [#8] json-parse-financial Cycles:10 Average:55.90 Median:56.00 stddev:1.45 (2.6%) stddev-sans-first:1.48 22:16:22 INFO - PROCESS | 21205 | Values: 57.0 56.0 55.0 56.0 55.0 59.0 57.0 54.0 55.0 55.0 22:16:22 INFO - PROCESS | 21205 | 22:16:22 INFO - PROCESS | 21205 | [#9] json-stringify-tinderbox Cycles:10 Average:60.80 Median:61.00 stddev:0.42 (0.7%) stddev-sans-first:0.33 22:16:22 INFO - PROCESS | 21205 | Values: 60.0 61.0 60.0 61.0 61.0 61.0 61.0 61.0 61.0 61.0 22:16:22 INFO - PROCESS | 21205 | 22:16:22 INFO - PROCESS | 21205 | [#10] stanford-crypto-aes Cycles:10 Average:83.80 Median:82.50 stddev:7.25 (8.8%) stddev-sans-first:7.69 22:16:22 INFO - PROCESS | 21205 | Values: 84.0 79.0 85.0 78.0 79.0 80.0 85.0 81.0 103.0 84.0 22:16:22 INFO - PROCESS | 21205 | 22:16:22 INFO - PROCESS | 21205 | [#11] stanford-crypto-ccm Cycles:10 Average:126.90 Median:127.00 stddev:5.15 (4.1%) stddev-sans-first:4.78 22:16:22 INFO - PROCESS | 21205 | Values: 134.0 122.0 126.0 124.0 118.0 130.0 126.0 127.0 135.0 127.0 22:16:22 INFO - PROCESS | 21205 | 22:16:22 INFO - PROCESS | 21205 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.70 Median:161.00 stddev:2.45 (1.5%) stddev-sans-first:2.52 22:16:22 INFO - PROCESS | 21205 | Values: 159.0 160.0 163.0 159.0 159.0 165.0 163.0 162.0 157.0 160.0 22:16:22 INFO - PROCESS | 21205 | 22:16:22 INFO - PROCESS | 21205 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.40 Median:63.00 stddev:3.03 (4.8%) stddev-sans-first:3.17 22:16:22 INFO - PROCESS | 21205 | Values: 62.0 63.0 71.0 66.0 62.0 63.0 61.0 63.0 62.0 61.0 22:16:22 INFO - PROCESS | 21205 | -------- Summary: end -------- 22:16:22 INFO - PROCESS | 21205 | 22:16:23 INFO - TEST-INFO | 21205: exit 0 22:16:23 INFO - TEST-OK | kraken | took 61568ms 22:16:23 INFO - SUITE-END | took 1171s 22:16:23 INFO - Completed test suite (00:19:32) 22:16:23 INFO - javascript benchmark 22:16:24 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7123.358993201224, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3090.582771325871, 3139.3093519425747, 3162.3359094590137, 3171.2864605463774, 3185.2196211928067, 5420.783168673258, 5450.591205659572, 5450.645708028976, 5464.09842376008, 5494.835154945358, 5287.180487024508, 5348.893022139555, 5410.729463526818, 5439.347278326596, 5450.56395488361, 4879.1705410080285, 4934.654574179809, 5026.145555255615, 5070.61970352225, 5115.411727651312, 884.4383079712458, 4854.441739199984, 4916.0905232532095, 4972.627052971024, 5008.2738002989545, 4902.828401005965, 4930.359053323081, 4936.3829521309835, 4970.552650261476, 4972.751362431882, 4986.077575648516, 4989.925151122736, 4993.325901003391, 5009.824656137054, 5011.123053465629, 4904.828331008398, 4913.336699545552, 4924.433690125646, 4939.456659767423, 4961.280614310941, 5299.390570084451, 5342.1185504392115, 5368.946310536884, 5380.058489764315, 5396.622236443451, 5687.772489100473, 5734.655920644775, 5826.941730582682, 5868.2371291732225, 5869.8239052828485, 5820.214271073435, 5823.2138661280605, 5850.785013603591, 5854.853628659275, 5877.706114694248, 5466.726663666801, 5484.067708489566, 5489.231507588981, 5495.505404513613, 5502.257195278627, 5755.510781583613, 5962.314333851663, 5974.163617093611, 5976.8804623908145, 6003.159557661931, 5777.8555536111935, 5794.188813566104, 5797.681127538026, 5816.854578635568, 5838.766449342063, 5840.3575606683235, 5843.474087332161, 5844.357120716718, 5853.0, 5869.383714709894, 5534.640248383842, 5598.664080155204, 5762.884742305214, 5844.532437404998, 5872.265966754156, 5729.88540229193, 5768.884622307531, 5771.942280577225, 5776.0, 5779.2775903012125, 4405.493368262627, 4413.955860441419, 4418.624416924597, 4420.336949457607, 4459.130469558405, 3835.4438606401914, 3916.5104361954754, 3922.6077392260545, 3950.762954222698, 3972.880813575597, 5430.402655707869, 5437.945620543823, 5477.726113694379, 5509.3664228613425, 5518.53092487135, 5670.518005969457, 5809.68046757424, 5826.504747096459, 5826.796062137805, 5843.707814609253, 5428.240046393508, 5482.369527504308, 5512.944870551243, 5545.112781954868, 5568.220449137124, 5016.824411145592, 5023.271625614266, 5035.395752509722, 5048.040872234264, 5069.163588008011, 5998.1002849572915, 6051.697415129226, 6054.334023257438, 6070.423309785563, 6071.544634152457, 5671.631343962712, 5785.190073389813, 5808.593398462067, 5849.853753656193, 5927.703614819242, 6034.788782392595, 6037.909431358621, 6038.909416358671, 6040.456358927718, 6055.9091613626715, 5759.452851979056, 5776.162456443876, 5779.393163717918, 5780.132980053026, 5787.768489260382, 5636.520895723909, 5853.414658534112, 5864.970675146597, 5900.940990590039, 5920.467157955804, 5716.171155182558, 5732.856678583069, 5734.54123670097, 5757.91363129545, 5768.682722450306, 5529.695866727368, 5667.376588575171, 5695.430456954271, 5704.258446401941, 5735.713214339183, 5468.507834294933, 5486.643368181056, 5498.505134537911, 5513.641613295123, 5514.255575497417, 5627.718614069362, 5642.210090587239, 5683.062294721325, 5683.7442315095095, 5696.715164241688, 5469.425710300361, 5544.112941929272, 5570.637908535932, 5581.7209139543675, 5584.301962254718], "value": 5328.0360728670785, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [576.1846986514083, 617.9474744646704, 625.9061140828875, 633.8763941031498, 639.4756299834137, 31671.36657266856, 42387.0, 43081.569184308144, 43131.13737725244, 47106.293405598946, 42565.0, 42623.360649590206, 42717.0, 43025.92435189122, 43049.7847510762, 8747.562621868912, 8890.466572005667, 8931.687390941319, 8955.462672239686, 8959.328050396214, 8796.252318552899, 8854.114588541159, 8916.01923788386, 8936.017038125801, 8959.865602015974, 8824.911750882473, 8842.602082906253, 8982.550872456384, 8985.820283594325, 9006.639734410615, 8899.95550022249, 8902.243309318716, 8941.0, 8958.820823583557, 8960.417572857743, 8822.514761688104, 8831.293496520328, 8893.955530222373, 8919.509426981513, 8937.329700272441, 41870.58129418697, 42260.0, 42524.0, 42591.14817703629, 42634.78682606567, 3606.6213047629885, 3622.0, 3639.636036396339, 3810.4474851146706, 3859.614038596146, 32782.0, 33093.33813323744, 33176.0, 33266.0, 33445.331093377994, 4354.325079612665, 4468.687191896569, 4513.458384993789, 4569.748663823489, 4628.074385122955, 346046.0, 346569.0, 347527.0, 348684.0, 349738.0, 34367.656323436444, 35412.29175416477, 35444.64555354465, 37032.814835925645, 62104.37895620986, 36161.0, 36752.08119797026, 36823.631763682555, 36913.0, 37029.81485092611, 14848.480303189552, 14863.405463781544, 14939.925300373428, 14988.700225995419, 15036.624084397978, 12303.323317217639, 12386.5664701735, 12402.441890114966, 12459.626211213677, 12462.127651064338, 8345.248927596545, 8399.160083991674, 8414.326853851677, 8423.0, 8439.324854011664, 3239.627442844056, 3251.219707270285, 3309.4351877294807, 3321.5848018997626, 3345.1971526833872, 1059.078601616583, 1063.8563793887881, 1110.2672236323988, 1166.1691936971413, 1184.875588063241, 33109.0, 33145.83427082897, 33521.0, 33718.8314058433, 34028.149296267795, 1133.5125895864858, 1148.242160174281, 1167.3404526442532, 1195.7548702515962, 1244.9502019919282, 17143.314267429414, 17461.301547938194, 17635.801853882138, 17706.645867082585, 17782.822171778374, 512249.0, 516151.0, 518783.0, 518885.0, 520590.0, 57159.428405716244, 57797.71101144468, 57990.71004645034, 58087.70956145192, 58244.0, 1346.4614154338342, 1381.7236552689503, 1390.5967269491734, 1407.8451370349253, 1413.6607214268706, 31000.379992400478, 31875.0, 32136.678633214306, 32656.0, 33090.834545827114, 50397.0, 50648.240276396624, 50679.74660126676, 50691.0, 51204.48795511997, 450199.0, 452582.0, 459682.0, 462081.0, 464417.0, 27494.725052749218, 27896.721032789414, 28135.0, 28327.15018549447, 28386.574201386582, 42756.35865461958, 45153.322700160184, 46519.53480465152, 46606.0, 46655.766721166176, 38373.808130959165, 39775.60224397835, 39994.800025999684, 40182.598174019055, 40651.0, 38207.752341051324, 38723.612763872, 38863.80568097141, 38938.0, 39608.40587391134, 36477.45283820798, 39857.80071099626, 41977.790111049246, 42301.0, 43228.78385608052, 34649.82675086609, 37976.05059873525, 38309.4253586202, 38410.66857888368, 38570.421443677806, 29053.273668158465, 29248.853755731085, 29321.56017659694, 29668.0, 29697.554536681535], "value": 18858.908863718443, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [382.43781640987737, 390.9960900390995, 391.129736336651, 400.73551456039013, 416.0472517933932, 13650.590482285548, 16563.751543726838, 17760.911195444038, 17799.644007119867, 17806.91096544517, 17237.396691115813, 18193.90903045483, 18611.90694046528, 19196.712049319238, 19208.711869321938, 5172.40517340506, 5277.762500687479, 5351.518363347298, 5366.329208848894, 5369.785208591652, 5297.496737809902, 5306.522412982831, 5311.654742441749, 5555.0, 5895.174675545427, 5926.970365148169, 5930.436608522184, 5950.37521060289, 5975.790847320344, 5993.160957465958, 5770.6249093808765, 5893.086571581412, 6421.165248517709, 6494.058361537551, 6507.707153178071, 5725.141228815669, 5752.741126649311, 5766.88466230673, 5773.076307790733, 5808.680522571257, 21090.3672889812, 21796.89101554482, 22186.112555497763, 22605.321840344815, 22658.546829063493, 2337.883105844701, 2583.6253743207317, 2633.5522961096467, 2739.58906164075, 2786.1084452975056, 9822.361546499455, 9875.555599998017, 10509.211809114347, 11554.942225288904, 13778.586642400744, 1916.319706504185, 1991.5660724278641, 2000.7699114601862, 2038.9694154587544, 2066.617675729995, 79889.60055199687, 82753.58623206845, 83453.58273208595, 84438.57780711057, 84462.93222406675, 11016.0, 11111.611093611846, 11113.277636953571, 11258.774824503627, 11379.886201138048, 13304.933475332755, 13957.0, 15512.844871551366, 15614.609634759221, 15632.92183539075, 7862.174471680506, 7909.327707144842, 7995.760127196193, 8070.636821343053, 8170.550619715973, 7580.54516728998, 7654.693812247448, 7664.9616751917, 7717.459777815499, 7823.335016523545, 4687.531246875285, 4722.409698787652, 4723.078999595046, 4759.619230461555, 4767.332573439721, 1910.617876424693, 1939.6120775844888, 1939.7575303087115, 1971.8957383865081, 1977.317825350252, 1012.3773879064322, 1027.291169093323, 1031.1493018259966, 1061.2571200159919, 1088.3306766338803, 18820.153093110843, 19310.32413865508, 19626.464384389186, 19667.21331146738, 19742.309019184548, 1013.5692330759398, 1028.3572767020612, 1031.200819364983, 1031.4533297352416, 1069.7539565899888, 10169.593216271414, 10913.454327283764, 10952.945235273774, 10987.285826421257, 10992.615258466076, 454342.0, 466399.0, 469824.0, 478601.0, 481048.0, 93247.0, 95430.0, 95918.56122158174, 95998.0, 96433.51783241039, 991.2070343724992, 1010.8281592129356, 1013.6502906497246, 1014.0619926567895, 1021.9846702299471, 16899.577510562336, 17144.0, 17207.397741079003, 17364.305427782747, 17645.911770441067, 29391.706082939752, 29868.253293667833, 30674.846625766728, 35192.47211291884, 37382.439263410524, 52997.73501132624, 55632.443675562725, 56968.715156423954, 57925.71037144787, 58126.709366452895, 8079.192080791874, 8511.74464766058, 8591.097934716765, 8662.740117796477, 8865.0, 9584.467717255377, 13328.733425331633, 13455.517903479295, 13602.659933501742, 13744.244066576433, 11458.541658333574, 11834.289942603471, 11936.104792140797, 11991.580294689644, 12125.27248365101, 11560.826587601025, 11582.362970036393, 11732.296062236293, 11803.940980295043, 12045.879541204826, 11748.118891083373, 11755.235909665844, 11863.288202707865, 11903.166778325434, 11950.820737689115, 7480.0, 7814.179511151247, 8460.788480288042, 8487.066422693622, 8747.212750852454, 11897.345645989553, 12069.0, 12146.514139434677, 12174.391280435766, 12206.389680515762], "value": 9170.094112328523, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1459.233902201344, 1511.10844601685, 1644.6299582593917, 1819.4086921750434, 1827.9634407311846, 7568.318851303396, 8363.372747043966, 8439.789005274872, 8933.151350621689, 8947.55262236888, 8582.742517724462, 8747.737567872959, 8848.247898928583, 8850.77873053174, 8852.77868053299, 2354.8940297686604, 2390.4740956989435, 2395.9161429349974, 2399.748026457223, 2401.3756423329974, 2321.5240875620543, 2322.129201549419, 2323.5933711600487, 2349.6005679034606, 2350.165691179632, 2348.5420343033115, 2360.291912426274, 2387.6299173628117, 2403.170906037414, 2412.445137618349, 2362.9291121266306, 2385.1294277588727, 2389.390705370137, 2402.3994001499627, 2407.205622144697, 2311.907523699067, 2315.8610483371053, 2330.93007209784, 2339.7894189522854, 2339.894704738291, 8643.0, 8659.307255419615, 8701.47791132534, 8722.607482663296, 8728.821609082755, 5221.503957124067, 5253.6322457428, 5298.947010529922, 5330.92003619946, 5396.244525766396, 3376.898693039213, 3418.1454636340914, 3468.9479657805155, 3469.774464659789, 3482.3905816482015, 1209.105262106044, 1212.1696637803134, 1214.7206142587254, 1223.455562274788, 1227.1348699167154, 12078.154529182873, 12079.09406794494, 12093.697657558543, 12117.818232726517, 12128.272303661808, 4406.3170208617075, 4576.931346029813, 4623.953760462419, 4646.163690535668, 4665.440147182292, 10201.693949181536, 10206.4386458744, 10213.846792298122, 10215.7446063849, 10226.130778883879, 5235.345581802275, 5235.502627250406, 5253.816116435906, 5263.105272103751, 5271.6309858310315, 4217.936730949038, 4781.904361912742, 4790.784414701347, 4923.138450771101, 4926.433460152057, 3999.5000624921886, 4061.268971585084, 4111.0, 4112.403701463271, 4118.938215926763, 1330.7937269723209, 1332.5602551158095, 1343.4424713743688, 1350.8108864758942, 1351.4053816320788, 902.2105657549644, 1008.193445243802, 1023.9846402303972, 1026.0509029148009, 1049.532957833772, 6090.939090609126, 6191.9690401547705, 6278.121063051177, 6290.748370065146, 6290.905636415458, 460.5233583241329, 470.1818835226749, 470.96703230773517, 480.3659169895774, 481.6676493219737, 4220.6412454941055, 4270.231358355463, 4271.31658934569, 4293.957060429419, 4324.848630297987, 10743.24797264184, 10858.402787846744, 11046.613368532062, 11049.944750276358, 11055.0, 10563.841542376871, 10731.141508679288, 10765.515551800188, 10882.183836212316, 10888.346699198073, 8011.679532818738, 8050.798730031679, 8084.151164127799, 8132.430729848854, 8180.67277308901, 5882.1470886722045, 5888.499477544457, 5909.202257695156, 6045.939540604538, 6106.511479081574, 9552.283578731762, 10005.54975026111, 10008.599656013677, 10032.347897386646, 10103.444310562989, 9999.55002024896, 10140.188784897338, 10191.184705223712, 10264.486775661337, 10295.330803497749, 6905.482088843256, 7517.887231691419, 7587.279208475186, 7594.126675432396, 7860.84278314442, 8516.829663406574, 8590.78523036929, 8596.0, 8697.391182617155, 8705.347098967477, 7566.281203285679, 7779.066512018594, 7826.686932522863, 7829.1779363168325, 7903.051633803981, 7626.847463050819, 7719.961400192963, 7739.7678069658, 7841.451098423056, 7847.646855891385, 6944.583325000516, 6990.161180658353, 7020.157581090302, 7051.224365319708, 7068.363847253772, 5166.844994650167, 5280.683159010472, 5399.649022813504, 5413.269208656781, 5424.159255315432, 5201.817936372209, 5273.5781137509675, 5308.389535203347, 5397.352317721741, 5464.726763661881], "value": 4606.864500162094, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [321.7667191286318, 334.6185348702479, 338.4770529531873, 339.8148009334912, 340.64232555816386, 5473.425290344516, 5617.522510586605, 5722.284714410699, 5779.450952159544, 5783.45057219564, 5532.585056120787, 5613.382527921925, 5641.435856414367, 5643.463870932255, 5650.237217975572, 4379.58393952574, 4394.033312671223, 4396.274614688573, 4404.471463424377, 4414.558544145576, 4148.813303401339, 4356.455443069616, 4359.760213188273, 4421.867343979686, 4444.555544445546, 4267.701260911737, 4270.743755374672, 4276.636485898703, 4283.957160428387, 4288.206681763883, 4283.892902677427, 4300.827966881337, 4308.784560771949, 4359.149965756678, 4374.518802931675, 3542.2738338640515, 3770.5852356240794, 3771.6039815819217, 3772.3775577030033, 3775.6790672792845, 5440.319960004999, 5441.0, 5453.563714902798, 5471.5896307777075, 5546.0, 4892.730899800509, 4926.285688575136, 4930.605551555867, 4931.876703082416, 4941.160002799496, 5583.497485226349, 5894.646321220697, 5894.764209431661, 5904.852378690524, 5919.852003699942, 4208.579142085798, 4214.473190851144, 4225.535191128974, 4239.27932251518, 4240.533541310453, 6187.721552530102, 6191.845203869894, 6201.689915504252, 6208.937910620881, 6210.7515699371515, 4097.467329247179, 4240.664190779895, 4256.659467242614, 4272.359146128106, 4274.5939135782055, 4248.299030659907, 4268.59448352406, 4275.615194632436, 4310.159518893785, 4318.114786468766, 4956.975215123901, 4968.403791545038, 4994.975025124923, 5002.1496345621335, 5007.273945277914, 5815.680137592389, 5970.940290597038, 5987.161797348374, 5997.460228579449, 6063.332583539562, 1463.948761793332, 1486.5317425011087, 1490.5528341497507, 1495.5438591229563, 1495.8728508076936, 916.504854368932, 930.6370515498961, 942.4251206763869, 945.652445265494, 959.5825815770023, 4967.90064198714, 5026.59787217029, 5055.216441451581, 5098.9490105098475, 5128.282040514257, 5437.755301011464, 5440.075187218104, 5445.346558412936, 5467.812874850092, 5479.945200548023, 5030.346055012825, 5036.244563315532, 5128.435872054071, 5146.974265128651, 5207.281597072957, 2923.693012233685, 2927.653279491458, 2934.884743797386, 2951.631046119235, 2963.2443726849947, 5478.643888147258, 5511.173324001432, 5532.944670553324, 5662.490375866192, 5681.34664513578, 5246.68832791802, 5525.309336332958, 5531.25328080712, 5550.47270509301, 5603.170398948505, 5510.283663123768, 5521.371195497338, 5595.929506082694, 5650.830475085754, 5683.687397193194, 5237.952409518035, 5404.432534583812, 5439.864003399788, 5478.424765399575, 5552.0, 5276.366835979554, 5480.890382192254, 5483.424240454695, 5484.424135465878, 5485.985092757853, 5483.698396588226, 5519.254900588369, 5540.418256083214, 5552.528579926404, 6047.848803779941, 4126.66986641062, 4262.403263543169, 4273.508546517191, 4282.743035417885, 4286.442762440863, 6111.633302001716, 6113.480354169767, 6123.14276001369, 6148.292946311231, 6162.414570615784, 5675.68783716883, 5821.0, 5894.6757928314355, 5962.25471816023, 5967.283925928917, 5870.412958704095, 5889.705514724161, 5891.528677705859, 5912.586118971631, 5917.1715959766525, 5707.157647880581, 5771.7114144293455, 5793.204106726928, 5806.535477161901, 5832.679202643895, 5711.600187986967, 5886.793962211302, 5902.852428689317, 5960.254968128984, 5967.76128954837, 5741.425857414225, 5811.750473648186, 5820.817193552418, 5821.738021788945, 5824.650520968756], "value": 4343.501516384391, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [758.6434375843352, 817.8282560662261, 827.8923739913812, 831.6831683168313, 843.1863251961855, 14562.490312839052, 15424.61438464039, 15455.30451129699, 15465.768013479792, 15476.38094476221, 13980.37088331025, 14176.50382236622, 14422.206778627171, 14432.5670229893, 14490.927545362258, 794.2097612875198, 807.0597753617044, 813.1137060603941, 818.4557269415832, 819.2217393476192, 835.1439774231401, 836.2724429746129, 838.2288294768828, 840.4999025579771, 840.5461051032435, 869.0006492533573, 875.995620021899, 881.299367003234, 881.7310720230328, 884.1909652667802, 869.8782170496104, 871.9389642725012, 876.3733930239878, 876.8903887014123, 876.9693060742875, 630.7350912616712, 631.0219160301514, 633.5375176121457, 638.2149955554694, 638.9137466442018, 14808.111513309235, 14907.850921490755, 14924.62688432787, 14968.17675027873, 15149.242537873173, 14042.227677477735, 14092.2953852308, 14098.577042688736, 14098.859011409857, 14200.928995354958, 11597.536098556047, 11709.590164344292, 11727.648170554812, 11957.701057473545, 12075.154739168262, 3838.500994870649, 3890.1247219375414, 3942.9014274643364, 4048.4534587830562, 4053.128577355853, 60721.69639151776, 61211.69394153045, 61310.38689613091, 61414.69292653553, 61594.0, 10849.457527123612, 10992.835107473395, 11122.55509779616, 11168.93895079966, 11814.763704725858, 19917.502062448264, 20039.899800501196, 20084.0, 20122.597548048958, 20209.292674756314, 8188.631511581993, 8446.155384461505, 8532.061473237938, 8722.86915696265, 8731.083236260101, 4744.715317080986, 4792.544708252711, 4826.251930950638, 4832.685875418157, 5040.672356296829, 3606.495090687306, 3697.242065376591, 3703.777773333609, 3711.0722319420147, 3714.665680088805, 626.0827887145354, 657.1883723601348, 659.2616269777784, 659.82184810101, 663.9236487803868, 705.9188193357727, 750.3097150621442, 768.1166658342838, 782.7534326687075, 792.3146478296347, 9766.121049105615, 9850.950745246228, 9996.700098997042, 10150.289479736495, 10213.897861021444, 632.2223664892208, 701.2741812224324, 754.9622518874035, 767.8980662748974, 772.3589420780851, 4613.746243956614, 4689.226277664147, 4691.81232750693, 4708.858734237979, 4794.9280760788615, 72424.27575724175, 72831.63584182151, 73171.2682873175, 74499.25500745031, 74971.0, 56926.715366423734, 57401.0, 58612.0, 64546.35453645497, 65936.34063659397, 53579.19631205535, 54235.18647220295, 54892.72553637286, 55100.0, 56052.0, 9908.455034972858, 9962.103410693073, 9994.350367226107, 10090.798184036132, 10208.0, 36762.26475470529, 36887.44668830023, 37293.81353093217, 37312.253754925296, 37411.43882841814, 45365.0, 47240.0, 47508.52491475179, 48034.75982620064, 48654.75672621614, 11771.0, 11990.880091198977, 12536.0, 12616.306103164414, 12792.424340904496, 13422.530211442552, 13740.0, 13909.51316703951, 14242.145471271757, 14620.853791462374, 12871.485140594272, 13067.542636007694, 13085.803712944124, 13097.41061652209, 13164.670883227996, 12649.93675031619, 13540.729185416434, 13812.447502100205, 13825.654358641115, 14346.784798228244, 11353.148513861328, 11725.941370293094, 11819.527218911491, 11827.467763950472, 11843.0, 10700.197485188486, 10718.946405267923, 10895.0, 10897.618583349546, 11238.606648767254, 11498.655040348804, 11525.538978440769, 11610.0, 11798.292102473879, 11844.881551184379], "value": 7085.400910209755, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1529.0000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 106.0, 111.0, 111.0, 111.0, 110.0, 111.0, 109.0, 110.0, 110.0], "value": 110.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 123.0, 156.0, 179.0, 132.0, 157.0, 149.0, 131.0, 184.0, 125.0], "value": 148.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 164.0, 162.0, 160.0, 162.0, 163.0, 167.0, 166.0, 163.0, 167.0], "value": 163.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 74.0, 169.0, 75.0, 78.0, 73.0, 75.0, 155.0, 74.0], "value": 92.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 164.0, 83.0, 83.0, 82.0, 142.0, 84.0, 84.0, 139.0], "value": 102.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 117.0, 117.0, 118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0], "value": 117.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 148.0, 147.0, 146.0, 147.0, 149.0, 147.0, 146.0, 147.0, 147.0], "value": 147.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 97.0, 95.0, 95.0, 95.0, 96.0, 96.0, 95.0, 95.0], "value": 95.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 56.0, 55.0, 56.0, 55.0, 59.0, 57.0, 54.0, 55.0, 55.0], "value": 55.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 60.0, 61.0, 61.0, 61.0, 61.0, 61.0, 61.0, 61.0], "value": 60.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 79.0, 85.0, 78.0, 79.0, 80.0, 85.0, 81.0, 103.0, 84.0], "value": 83.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 122.0, 126.0, 124.0, 118.0, 130.0, 126.0, 127.0, 135.0, 127.0], "value": 126.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 160.0, 163.0, 159.0, 159.0, 165.0, 163.0, 162.0, 157.0, 160.0], "value": 160.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 71.0, 66.0, 62.0, 63.0, 61.0, 63.0, 62.0, 61.0], "value": 63.4, "unit": "score"}]}]} 22:16:24 INFO - Return code: 0 22:16:24 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 22:16:24 ERROR - # TBPL SUCCESS # 22:16:24 INFO - Running post-action listener: _resource_record_post_action 22:16:24 INFO - ##### 22:16:24 INFO - ##### Finished run-tests step (success) 22:16:24 INFO - ##### 22:16:24 INFO - Running post-run listener: _resource_record_post_run 22:16:24 INFO - Total resource usage - Wall time: 1190s; CPU: 14.0%; Read bytes: 16384; Write bytes: 539308032; Read time: 444; Write time: 668936 22:16:24 INFO - TinderboxPrint: CPU usage
13.5% 22:16:24 INFO - TinderboxPrint: I/O read bytes / time
16,384 / 444 22:16:24 INFO - TinderboxPrint: I/O write bytes / time
539,308,032 / 668,936 22:16:24 INFO - TinderboxPrint: CPU idle
8,208.5 (86.5%) 22:16:24 INFO - TinderboxPrint: CPU user
1,227.7 (12.9%) 22:16:24 INFO - TinderboxPrint: Swap in / out
0 / 0 22:16:24 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 4096; Write bytes: 247173120; Read time: 192; Write time: 349020 22:16:24 INFO - run-tests - Wall time: 1173s; CPU: 14.0%; Read bytes: 12288; Write bytes: 292134912; Read time: 252; Write time: 319916 22:16:24 INFO - Running post-run listener: _upload_blobber_files 22:16:24 INFO - Blob upload gear active. 22:16:24 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 22:16:24 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 22:16:24 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'] 22:16:24 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 22:16:25 INFO - (blobuploader) - INFO - Open directory for files ... 22:16:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 22:16:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:16:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:16:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 22:16:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:16:26 INFO - (blobuploader) - INFO - Done attempting. 22:16:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 22:16:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:16:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:16:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 22:16:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:16:26 INFO - (blobuploader) - INFO - Done attempting. 22:16:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 22:16:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:16:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:16:31 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 22:16:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:16:31 INFO - (blobuploader) - INFO - Done attempting. 22:16:31 INFO - (blobuploader) - INFO - Iteration through files over. 22:16:31 INFO - Return code: 0 22:16:31 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 22:16:31 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 22:16:31 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/d82c490901ddc05ce69f080a490ea92b83ae5dec2d86f2806365a5d88ac40c05e32a7997c783e3020120a4630db2ce1ae9ab0c60b418becf444f43d2d98ca8a1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/05372e48c141d9c05dd074667486efc908fa2c5d6b15d00e6aba74f10c5eea8a1d8099154c9ed0cb5ab8843285dad277c160635b26439abaae41e6cf846a2795", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/fb130f29f871a8471c377c5d6b38c74b9542680266a9f341d98b1f8ecba7dd06c36397e9706b9e5116ea0329b89e60fdb82581bb66994faefef0d6b5663fa350"} 22:16:31 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 22:16:31 INFO - Writing to file /builds/slave/test/properties/blobber_files 22:16:31 INFO - Contents: 22:16:31 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/d82c490901ddc05ce69f080a490ea92b83ae5dec2d86f2806365a5d88ac40c05e32a7997c783e3020120a4630db2ce1ae9ab0c60b418becf444f43d2d98ca8a1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/05372e48c141d9c05dd074667486efc908fa2c5d6b15d00e6aba74f10c5eea8a1d8099154c9ed0cb5ab8843285dad277c160635b26439abaae41e6cf846a2795", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/fb130f29f871a8471c377c5d6b38c74b9542680266a9f341d98b1f8ecba7dd06c36397e9706b9e5116ea0329b89e60fdb82581bb66994faefef0d6b5663fa350"} 22:16:31 INFO - Running post-run listener: copy_logs_to_upload_dir 22:16:31 INFO - Copying logs to upload dir... 22:16:31 INFO - mkdir: /builds/slave/test/build/upload/logs 22:16:31 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1241.660747 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-05-26 22:16:31.570982) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-26 22:16:31.574198) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=fa44defc139c4ba8574fe040000001db-1464319772.313099-1720444971 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/d82c490901ddc05ce69f080a490ea92b83ae5dec2d86f2806365a5d88ac40c05e32a7997c783e3020120a4630db2ce1ae9ab0c60b418becf444f43d2d98ca8a1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/05372e48c141d9c05dd074667486efc908fa2c5d6b15d00e6aba74f10c5eea8a1d8099154c9ed0cb5ab8843285dad277c160635b26439abaae41e6cf846a2795", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/fb130f29f871a8471c377c5d6b38c74b9542680266a9f341d98b1f8ecba7dd06c36397e9706b9e5116ea0329b89e60fdb82581bb66994faefef0d6b5663fa350"} build_url:https://queue.taskcluster.net/v1/task/eu6p6VfbS-WZaixceNt6BA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011450 build_url: 'https://queue.taskcluster.net/v1/task/eu6p6VfbS-WZaixceNt6BA/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/d82c490901ddc05ce69f080a490ea92b83ae5dec2d86f2806365a5d88ac40c05e32a7997c783e3020120a4630db2ce1ae9ab0c60b418becf444f43d2d98ca8a1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/05372e48c141d9c05dd074667486efc908fa2c5d6b15d00e6aba74f10c5eea8a1d8099154c9ed0cb5ab8843285dad277c160635b26439abaae41e6cf846a2795", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/fb130f29f871a8471c377c5d6b38c74b9542680266a9f341d98b1f8ecba7dd06c36397e9706b9e5116ea0329b89e60fdb82581bb66994faefef0d6b5663fa350"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-26 22:16:31.599489) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 22:16:31.599908) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=fa44defc139c4ba8574fe040000001db-1464319772.313099-1720444971 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004505 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 22:16:31.685818) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-26 22:16:31.686124) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-26 22:16:31.686421) ========= ========= Total master_lag: 0.19 =========