builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-038 starttime: 1470157882.74 results: success (0) buildid: 20160802073043 builduid: 6da4f24ab129423fa0b13059ade654cc revision: 02f8c8bd057d7ccc5096c880ec3458174008426c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-02 10:11:22.739067) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-02 10:11:22.739614) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-02 10:11:22.739977) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-02 10:11:22.755210) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-02 10:11:22.755547) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8783db0840cc980e80bb0bd400000236-1470157881.965974-768360645 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-02 10:11:22-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.7M=0s 2016-08-02 10:11:22 (46.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.111061 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-02 10:11:22.881039) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-02 10:11:22.881390) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8783db0840cc980e80bb0bd400000236-1470157881.965974-768360645 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017374 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-02 10:11:22.931380) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-02 10:11:22.931877) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 02f8c8bd057d7ccc5096c880ec3458174008426c --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 02f8c8bd057d7ccc5096c880ec3458174008426c --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8783db0840cc980e80bb0bd400000236-1470157881.965974-768360645 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-02 10:11:23,040 truncating revision to first 12 chars 2016-08-02 10:11:23,040 Setting DEBUG logging. 2016-08-02 10:11:23,040 attempt 1/10 2016-08-02 10:11:23,040 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/02f8c8bd057d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-02 10:11:23,337 unpacking tar archive at: mozilla-inbound-02f8c8bd057d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.640102 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-02 10:11:23.592969) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-02 10:11:23.593323) ========= script_repo_revision: 02f8c8bd057d7ccc5096c880ec3458174008426c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-02 10:11:23.593769) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-02 10:11:23.594102) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-02 10:11:23.606401) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-08-02 10:11:23.606741) ========= /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=8783db0840cc980e80bb0bd400000236-1470157881.965974-768360645 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:11:23 INFO - MultiFileLogger online at 20160802 10:11:23 in /builds/slave/test 10:11:23 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 10:11:23 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:11:23 INFO - {'append_to_log': False, 10:11:23 INFO - 'base_work_dir': '/builds/slave/test', 10:11:23 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 10:11:23 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:11:23 INFO - 'branch': 'Mozilla-Inbound', 10:11:23 INFO - 'buildbot_json_path': 'buildprops.json', 10:11:23 INFO - 'config_files': ('talos/linux_config.py',), 10:11:23 INFO - 'default_actions': ('clobber', 10:11:23 INFO - 'read-buildbot-config', 10:11:23 INFO - 'download-and-extract', 10:11:23 INFO - 'populate-webroot', 10:11:23 INFO - 'create-virtualenv', 10:11:23 INFO - 'install', 10:11:23 INFO - 'run-tests'), 10:11:23 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:11:23 INFO - 'download_minidump_stackwalk': True, 10:11:23 INFO - 'download_symbols': 'ondemand', 10:11:23 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:11:23 INFO - 'tooltool.py': '/tools/tooltool.py', 10:11:23 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:11:23 INFO - '/tools/misc-python/virtualenv.py')}, 10:11:23 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:11:23 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:11:23 INFO - 'installer_path': 'installer.exe', 10:11:23 INFO - 'log_level': 'info', 10:11:23 INFO - 'log_name': 'talos', 10:11:23 INFO - 'log_to_console': True, 10:11:23 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:11:23 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:11:23 INFO - 'opt_config_files': (), 10:11:23 INFO - 'pip_index': False, 10:11:23 INFO - 'sps_profile': False, 10:11:23 INFO - 'sps_profile_interval': 0, 10:11:23 INFO - 'suite': 'dromaeojs-e10s', 10:11:23 INFO - 'system_bits': '32', 10:11:23 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:11:23 INFO - 'title': 'talos-linux64-ix-038', 10:11:23 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:11:23 INFO - 'use_talos_json': True, 10:11:23 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:11:23 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:11:23 INFO - 'work_dir': 'build'} 10:11:23 INFO - [mozharness: 2016-08-02 17:11:23.801209Z] Running clobber step. 10:11:23 INFO - Running pre-action listener: _resource_record_pre_action 10:11:23 INFO - Running main action method: clobber 10:11:23 INFO - rmtree: /builds/slave/test/build 10:11:23 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:11:24 INFO - Running post-action listener: _resource_record_post_action 10:11:24 INFO - [mozharness: 2016-08-02 17:11:24.774553Z] Finished clobber step (success) 10:11:24 INFO - [mozharness: 2016-08-02 17:11:24.774653Z] Running read-buildbot-config step. 10:11:24 INFO - Running pre-action listener: _resource_record_pre_action 10:11:24 INFO - Running main action method: read_buildbot_config 10:11:24 INFO - Using buildbot properties: 10:11:24 INFO - { 10:11:24 INFO - "project": "", 10:11:24 INFO - "product": "firefox", 10:11:24 INFO - "script_repo_revision": "production", 10:11:24 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 10:11:24 INFO - "repository": "", 10:11:24 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 10:11:24 INFO - "buildid": "20160802073043", 10:11:24 INFO - "pgo_build": "True", 10:11:24 INFO - "basedir": "/builds/slave/test", 10:11:24 INFO - "buildnumber": 1113, 10:11:24 INFO - "slavename": "talos-linux64-ix-038", 10:11:24 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 10:11:24 INFO - "platform": "ubuntu64_hw", 10:11:24 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 10:11:24 INFO - "branch": "mozilla-inbound", 10:11:24 INFO - "repo_path": "integration/mozilla-inbound", 10:11:24 INFO - "revision": "02f8c8bd057d7ccc5096c880ec3458174008426c", 10:11:24 INFO - "stage_platform": "linux64-pgo", 10:11:24 INFO - "builduid": "6da4f24ab129423fa0b13059ade654cc", 10:11:24 INFO - "slavebuilddir": "test" 10:11:24 INFO - } 10:11:24 INFO - Found installer url https://queue.taskcluster.net/v1/task/LR04O9UVQyev69cM2RUEAg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 10:11:24 INFO - Running post-action listener: _resource_record_post_action 10:11:24 INFO - [mozharness: 2016-08-02 17:11:24.777066Z] Finished read-buildbot-config step (success) 10:11:24 INFO - [mozharness: 2016-08-02 17:11:24.777155Z] Running download-and-extract step. 10:11:24 INFO - Running pre-action listener: _resource_record_pre_action 10:11:24 INFO - Running main action method: download_and_extract 10:11:24 INFO - mkdir: /builds/slave/test/build/tests 10:11: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')]} 10:11:24 INFO - https://queue.taskcluster.net/v1/task/LR04O9UVQyev69cM2RUEAg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 10:11:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LR04O9UVQyev69cM2RUEAg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 10:11:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LR04O9UVQyev69cM2RUEAg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 10:11:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LR04O9UVQyev69cM2RUEAg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 10:11:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LR04O9UVQyev69cM2RUEAg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 10:11:25 INFO - Downloaded 1361 bytes. 10:11:25 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 10:11:25 INFO - Using the following test package requirements: 10:11:25 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 10:11:25 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:11:25 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:11:25 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:11:25 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 10:11:25 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:11:25 INFO - u'jsshell-linux-x86_64.zip'], 10:11:25 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:11:25 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:11:25 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 10:11:25 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:11:25 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:11:25 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:11:25 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:11:25 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:11:25 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:11:25 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:11:25 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:11:25 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:11:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:11:25 INFO - https://queue.taskcluster.net/v1/task/LR04O9UVQyev69cM2RUEAg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:11:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LR04O9UVQyev69cM2RUEAg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 10:11:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LR04O9UVQyev69cM2RUEAg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 10:11:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LR04O9UVQyev69cM2RUEAg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 10:11:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LR04O9UVQyev69cM2RUEAg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:11:26 INFO - Downloaded 21810577 bytes. 10:11:26 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:11:26 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 10:11:27 INFO - Return code: 0 10:11:27 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 10:11: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')]} 10:11:27 INFO - https://queue.taskcluster.net/v1/task/LR04O9UVQyev69cM2RUEAg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:11:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LR04O9UVQyev69cM2RUEAg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 10:11:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LR04O9UVQyev69cM2RUEAg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 10:11:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LR04O9UVQyev69cM2RUEAg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 10:11:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LR04O9UVQyev69cM2RUEAg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:11:28 INFO - Downloaded 21810577 bytes. 10:11:28 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:11:28 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 10:11:30 INFO - Return code: 0 10:11: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')]} 10:11:30 INFO - https://queue.taskcluster.net/v1/task/LR04O9UVQyev69cM2RUEAg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 10:11:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LR04O9UVQyev69cM2RUEAg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 10:11:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LR04O9UVQyev69cM2RUEAg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 10:11:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LR04O9UVQyev69cM2RUEAg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 10:11:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LR04O9UVQyev69cM2RUEAg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 10:11:30 INFO - Downloaded 14413723 bytes. 10:11:30 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:11:30 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 10:11:31 INFO - Return code: 0 10:11:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:11:31 INFO - https://queue.taskcluster.net/v1/task/LR04O9UVQyev69cM2RUEAg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 10:11:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LR04O9UVQyev69cM2RUEAg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 10:11:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LR04O9UVQyev69cM2RUEAg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 10:11:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LR04O9UVQyev69cM2RUEAg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 10:11:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LR04O9UVQyev69cM2RUEAg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 10:11:33 INFO - Downloaded 59402475 bytes. 10:11:33 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LR04O9UVQyev69cM2RUEAg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 10:11:33 INFO - mkdir: /builds/slave/test/properties 10:11:33 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:11:33 INFO - Writing to file /builds/slave/test/properties/build_url 10:11:33 INFO - Contents: 10:11:33 INFO - build_url:https://queue.taskcluster.net/v1/task/LR04O9UVQyev69cM2RUEAg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 10:11:33 INFO - Running post-action listener: _resource_record_post_action 10:11:33 INFO - Running post-action listener: set_extra_try_arguments 10:11:33 INFO - [mozharness: 2016-08-02 17:11:33.702326Z] Finished download-and-extract step (success) 10:11:33 INFO - [mozharness: 2016-08-02 17:11:33.702613Z] Running populate-webroot step. 10:11:33 INFO - Running pre-action listener: _resource_record_pre_action 10:11:33 INFO - Running main action method: populate_webroot 10:11:33 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:11:33 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:11:33 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:11:33 INFO - '--tppagecycles', 10:11:33 INFO - '7'], 10:11:33 INFO - 'tests': ['tsvgm']}}, 10:11:33 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:11:33 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:11:33 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:11:33 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:11:33 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:11:33 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:11:33 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:11:33 INFO - 'talos_options': ['--disable-e10s'], 10:11:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:11:33 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:11:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:11:33 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:11:33 INFO - 'talos_options': ['--disable-e10s'], 10:11:33 INFO - 'tests': ['damp', 'tps']}, 10:11:33 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:11:33 INFO - 'tests': ['damp', 'tps']}, 10:11:33 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:11:33 INFO - 'tests': ['dromaeo_dom']}, 10:11:33 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:11:33 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:11:33 INFO - 'tests': ['basic_compositor_video']}, 10:11:33 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:11:33 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:11:33 INFO - 'tests': ['a11yr', 10:11:33 INFO - 'ts_paint', 10:11:33 INFO - 'tpaint', 10:11:33 INFO - 'sessionrestore', 10:11:33 INFO - 'sessionrestore_no_auto_restore', 10:11:33 INFO - 'tabpaint']}, 10:11:33 INFO - 'other-e10s': {'tests': ['a11yr', 10:11:33 INFO - 'ts_paint', 10:11:33 INFO - 'tpaint', 10:11:33 INFO - 'sessionrestore', 10:11:33 INFO - 'sessionrestore_no_auto_restore', 10:11:33 INFO - 'tabpaint']}, 10:11:33 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:11:33 INFO - 'ts_paint', 10:11:33 INFO - 'tpaint', 10:11:33 INFO - 'sessionrestore', 10:11:33 INFO - 'sessionrestore_no_auto_restore', 10:11:33 INFO - 'tabpaint']}, 10:11:33 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:11:33 INFO - 'ts_paint', 10:11:33 INFO - 'tpaint', 10:11:33 INFO - 'sessionrestore', 10:11:33 INFO - 'sessionrestore_no_auto_restore', 10:11:33 INFO - 'tabpaint']}, 10:11:33 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:11:33 INFO - 'tests': ['a11yr', 10:11:33 INFO - 'ts_paint', 10:11:33 INFO - 'tpaint', 10:11:33 INFO - 'sessionrestore', 10:11:33 INFO - 'sessionrestore_no_auto_restore', 10:11:33 INFO - 'tabpaint']}, 10:11:33 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:11:33 INFO - 'tests': ['a11yr', 10:11:33 INFO - 'ts_paint', 10:11:33 INFO - 'tpaint', 10:11:33 INFO - 'sessionrestore', 10:11:33 INFO - 'sessionrestore_no_auto_restore', 10:11:33 INFO - 'tabpaint']}, 10:11:33 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:11:33 INFO - 'tests': ['tsvgx', 10:11:33 INFO - 'tsvgr_opacity', 10:11:33 INFO - 'tart', 10:11:33 INFO - 'tscrollx', 10:11:33 INFO - 'cart']}, 10:11:33 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:11:33 INFO - 'tsvgr_opacity', 10:11:33 INFO - 'tart', 10:11:33 INFO - 'tscrollx', 10:11:33 INFO - 'cart']}, 10:11:33 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:11:33 INFO - 'talos_options': ['--disable-e10s'], 10:11:33 INFO - 'tests': ['tp5o']}, 10:11:33 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:11:33 INFO - 'tests': ['tp5o']}, 10:11:33 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:11:33 INFO - 'talos_options': ['--disable-e10s', 10:11:33 INFO - '--xperf_path', 10:11:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:11:33 INFO - 'tests': ['tp5n']}, 10:11:33 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:11:33 INFO - 'talos_options': ['--xperf_path', 10:11:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:11:33 INFO - 'tests': ['tp5n']}}, 10:11:33 INFO - 'talos.zip': {'path': '', 10:11:33 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:11:33 INFO - Running post-action listener: _resource_record_post_action 10:11:33 INFO - [mozharness: 2016-08-02 17:11:33.718409Z] Finished populate-webroot step (success) 10:11:33 INFO - [mozharness: 2016-08-02 17:11:33.718501Z] Running create-virtualenv step. 10:11:33 INFO - Running pre-action listener: _resource_record_pre_action 10:11:33 INFO - Running main action method: create_virtualenv 10:11:33 INFO - Creating virtualenv /builds/slave/test/build/venv 10:11:33 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 10:11:33 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:11:33 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:11:33 INFO - Using real prefix '/usr' 10:11:33 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:11:34 INFO - Installing distribute.............................................................................................................................................................................................done. 10:11:36 INFO - Installing pip.................done. 10:11:36 INFO - Return code: 0 10:11:36 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:11:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:11:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:11:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:11:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:11:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:11:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:11:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x212d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x235c400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23eb570>, '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 0x23ec470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23ec900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1470157881.965974-768360645', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:11:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 10:11:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 10:11:36 INFO - Using env: {'DISPLAY': ':0', 10:11:36 INFO - 'HOME': '/home/cltbld', 10:11:36 INFO - 'LANG': 'en_US.UTF-8', 10:11:36 INFO - 'LANGUAGE': 'en_US:en', 10:11:36 INFO - 'LOGNAME': 'cltbld', 10:11:36 INFO - 'MAIL': '/var/mail/cltbld', 10:11:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:11:36 INFO - 'MOZ_NO_REMOTE': '1', 10:11:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:11:36 INFO - 'NO_EM_RESTART': '1', 10:11:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:11:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:11:36 INFO - 'PWD': '/builds/slave/test', 10:11:36 INFO - 'SHELL': '/bin/bash', 10:11:36 INFO - 'SHLVL': '1', 10:11:36 INFO - 'TERM': 'linux', 10:11:36 INFO - 'TMOUT': '86400', 10:11:36 INFO - 'USER': 'cltbld', 10:11:36 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1470157881.965974-768360645', 10:11:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:11:36 INFO - '_': '/tools/buildbot/bin/python'} 10:11:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:11:36 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 10:11:36 INFO - Cleaning up... 10:11:36 INFO - Return code: 0 10:11:36 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:11:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:11:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:11:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:11:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:11:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:11:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:11:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x212d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x235c400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23eb570>, '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 0x23ec470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23ec900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1470157881.965974-768360645', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:11:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 10:11:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 10:11:36 INFO - Using env: {'DISPLAY': ':0', 10:11:36 INFO - 'HOME': '/home/cltbld', 10:11:36 INFO - 'LANG': 'en_US.UTF-8', 10:11:36 INFO - 'LANGUAGE': 'en_US:en', 10:11:36 INFO - 'LOGNAME': 'cltbld', 10:11:36 INFO - 'MAIL': '/var/mail/cltbld', 10:11:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:11:36 INFO - 'MOZ_NO_REMOTE': '1', 10:11:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:11:36 INFO - 'NO_EM_RESTART': '1', 10:11:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:11:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:11:36 INFO - 'PWD': '/builds/slave/test', 10:11:36 INFO - 'SHELL': '/bin/bash', 10:11:36 INFO - 'SHLVL': '1', 10:11:36 INFO - 'TERM': 'linux', 10:11:36 INFO - 'TMOUT': '86400', 10:11:36 INFO - 'USER': 'cltbld', 10:11:36 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1470157881.965974-768360645', 10:11:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:11:36 INFO - '_': '/tools/buildbot/bin/python'} 10:11:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:11:36 INFO - Downloading/unpacking psutil>=3.1.1 10:11:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:11:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:11:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:11:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:11:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:11:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:11:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:11:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:11:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:11:38 INFO - Installing collected packages: psutil 10:11:38 INFO - Running setup.py install for psutil 10:11:38 INFO - building 'psutil._psutil_linux' extension 10:11:38 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 10:11:38 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 10:11:38 INFO - building 'psutil._psutil_posix' extension 10:11:38 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 10:11:39 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 10:11:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:11:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:11:39 INFO - Successfully installed psutil 10:11:39 INFO - Cleaning up... 10:11:39 INFO - Return code: 0 10:11:39 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:11:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:11:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:11:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:11:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:11:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:11:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:11:39 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 0x212d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x235c400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23eb570>, '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 0x23ec470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23ec900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1470157881.965974-768360645', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:11:39 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 10:11:39 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 10:11:39 INFO - Using env: {'DISPLAY': ':0', 10:11:39 INFO - 'HOME': '/home/cltbld', 10:11:39 INFO - 'LANG': 'en_US.UTF-8', 10:11:39 INFO - 'LANGUAGE': 'en_US:en', 10:11:39 INFO - 'LOGNAME': 'cltbld', 10:11:39 INFO - 'MAIL': '/var/mail/cltbld', 10:11:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:11:39 INFO - 'MOZ_NO_REMOTE': '1', 10:11:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:11:39 INFO - 'NO_EM_RESTART': '1', 10:11:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:11:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:11:39 INFO - 'PWD': '/builds/slave/test', 10:11:39 INFO - 'SHELL': '/bin/bash', 10:11:39 INFO - 'SHLVL': '1', 10:11:39 INFO - 'TERM': 'linux', 10:11:39 INFO - 'TMOUT': '86400', 10:11:39 INFO - 'USER': 'cltbld', 10:11:39 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1470157881.965974-768360645', 10:11:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:11:39 INFO - '_': '/tools/buildbot/bin/python'} 10:11:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:11:39 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:11:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:11:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:11:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:11:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:11:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:11:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:11:41 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:11:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:11:41 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:11:41 INFO - Installing collected packages: mozsystemmonitor 10:11:41 INFO - Running setup.py install for mozsystemmonitor 10:11:41 INFO - Successfully installed mozsystemmonitor 10:11:41 INFO - Cleaning up... 10:11:41 INFO - Return code: 0 10:11:41 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:11:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:11:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:11:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:11:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:11:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:11:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:11:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x212d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x235c400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23eb570>, '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 0x23ec470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23ec900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1470157881.965974-768360645', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:11:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 10:11:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 10:11:41 INFO - Using env: {'DISPLAY': ':0', 10:11:41 INFO - 'HOME': '/home/cltbld', 10:11:41 INFO - 'LANG': 'en_US.UTF-8', 10:11:41 INFO - 'LANGUAGE': 'en_US:en', 10:11:41 INFO - 'LOGNAME': 'cltbld', 10:11:41 INFO - 'MAIL': '/var/mail/cltbld', 10:11:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:11:41 INFO - 'MOZ_NO_REMOTE': '1', 10:11:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:11:41 INFO - 'NO_EM_RESTART': '1', 10:11:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:11:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:11:41 INFO - 'PWD': '/builds/slave/test', 10:11:41 INFO - 'SHELL': '/bin/bash', 10:11:41 INFO - 'SHLVL': '1', 10:11:41 INFO - 'TERM': 'linux', 10:11:41 INFO - 'TMOUT': '86400', 10:11:41 INFO - 'USER': 'cltbld', 10:11:41 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1470157881.965974-768360645', 10:11:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:11:41 INFO - '_': '/tools/buildbot/bin/python'} 10:11:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:11:41 INFO - Downloading/unpacking jsonschema==2.5.1 10:11:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:11:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:11:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:11:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:11:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:11:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:11:43 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:11:43 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:11:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:11:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:11:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:11:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:11:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:11:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:11:43 INFO - Downloading functools32-3.2.3-2.tar.gz 10:11:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:11:43 INFO - warning: no files found matching '*.txt' 10:11:43 INFO - no previously-included directories found matching 'build' 10:11:43 INFO - no previously-included directories found matching 'dist' 10:11:43 INFO - no previously-included directories found matching '.git*' 10:11:43 INFO - Installing collected packages: jsonschema, functools32 10:11:43 INFO - Running setup.py install for functools32 10:11:44 INFO - warning: no files found matching '*.txt' 10:11:44 INFO - no previously-included directories found matching 'build' 10:11:44 INFO - no previously-included directories found matching 'dist' 10:11:44 INFO - no previously-included directories found matching '.git*' 10:11:44 INFO - Successfully installed jsonschema functools32 10:11:44 INFO - Cleaning up... 10:11:44 INFO - Return code: 0 10:11:44 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:11:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:11:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:11:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:11:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:11:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:11:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:11:44 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', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x212d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x235c400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23eb570>, '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 0x23ec470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23ec900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1470157881.965974-768360645', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:11:44 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', 'functools32==3.2.3-2'] in /builds/slave/test/build 10:11:44 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 functools32==3.2.3-2 10:11:44 INFO - Using env: {'DISPLAY': ':0', 10:11:44 INFO - 'HOME': '/home/cltbld', 10:11:44 INFO - 'LANG': 'en_US.UTF-8', 10:11:44 INFO - 'LANGUAGE': 'en_US:en', 10:11:44 INFO - 'LOGNAME': 'cltbld', 10:11:44 INFO - 'MAIL': '/var/mail/cltbld', 10:11:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:11:44 INFO - 'MOZ_NO_REMOTE': '1', 10:11:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:11:44 INFO - 'NO_EM_RESTART': '1', 10:11:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:11:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:11:44 INFO - 'PWD': '/builds/slave/test', 10:11:44 INFO - 'SHELL': '/bin/bash', 10:11:44 INFO - 'SHLVL': '1', 10:11:44 INFO - 'TERM': 'linux', 10:11:44 INFO - 'TMOUT': '86400', 10:11:44 INFO - 'USER': 'cltbld', 10:11:44 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1470157881.965974-768360645', 10:11:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:11:44 INFO - '_': '/tools/buildbot/bin/python'} 10:11:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:11:44 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:11:44 INFO - Cleaning up... 10:11:44 INFO - Return code: 0 10:11:44 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:11:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:11:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:11:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:11:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:11:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:11:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:11:44 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 0x212d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x235c400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23eb570>, '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 0x23ec470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23ec900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1470157881.965974-768360645', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:11:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 10:11:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 10:11:44 INFO - Using env: {'DISPLAY': ':0', 10:11:44 INFO - 'HOME': '/home/cltbld', 10:11:44 INFO - 'LANG': 'en_US.UTF-8', 10:11:44 INFO - 'LANGUAGE': 'en_US:en', 10:11:44 INFO - 'LOGNAME': 'cltbld', 10:11:44 INFO - 'MAIL': '/var/mail/cltbld', 10:11:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:11:44 INFO - 'MOZ_NO_REMOTE': '1', 10:11:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:11:44 INFO - 'NO_EM_RESTART': '1', 10:11:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:11:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:11:44 INFO - 'PWD': '/builds/slave/test', 10:11:44 INFO - 'SHELL': '/bin/bash', 10:11:44 INFO - 'SHLVL': '1', 10:11:44 INFO - 'TERM': 'linux', 10:11:44 INFO - 'TMOUT': '86400', 10:11:44 INFO - 'USER': 'cltbld', 10:11:44 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1470157881.965974-768360645', 10:11:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:11:44 INFO - '_': '/tools/buildbot/bin/python'} 10:11:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:11:44 INFO - Downloading/unpacking blobuploader==1.2.4 10:11:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:11:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:11:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:11:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:11:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:11:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:11:46 INFO - Downloading blobuploader-1.2.4.tar.gz 10:11:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:11:46 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:11:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:11:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:11:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:11:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:11:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:11:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:11:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:11:47 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:11:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:11:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:11:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:11:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:11:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:11:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:11:47 INFO - Downloading docopt-0.6.1.tar.gz 10:11:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:11:47 INFO - Installing collected packages: blobuploader, requests, docopt 10:11:47 INFO - Running setup.py install for blobuploader 10:11:47 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:11:47 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:11:47 INFO - Running setup.py install for requests 10:11:47 INFO - Running setup.py install for docopt 10:11:47 INFO - Successfully installed blobuploader requests docopt 10:11:47 INFO - Cleaning up... 10:11:47 INFO - Return code: 0 10:11:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:11:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:11:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:11:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:11:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:11:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:11:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:11:47 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 0x212d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x235c400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23eb570>, '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 0x23ec470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23ec900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1470157881.965974-768360645', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:11:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 10:11:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:11:47 INFO - Using env: {'DISPLAY': ':0', 10:11:47 INFO - 'HOME': '/home/cltbld', 10:11:47 INFO - 'LANG': 'en_US.UTF-8', 10:11:47 INFO - 'LANGUAGE': 'en_US:en', 10:11:47 INFO - 'LOGNAME': 'cltbld', 10:11:47 INFO - 'MAIL': '/var/mail/cltbld', 10:11:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:11:47 INFO - 'MOZ_NO_REMOTE': '1', 10:11:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:11:47 INFO - 'NO_EM_RESTART': '1', 10:11:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:11:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:11:47 INFO - 'PWD': '/builds/slave/test', 10:11:47 INFO - 'SHELL': '/bin/bash', 10:11:47 INFO - 'SHLVL': '1', 10:11:47 INFO - 'TERM': 'linux', 10:11:47 INFO - 'TMOUT': '86400', 10:11:47 INFO - 'USER': 'cltbld', 10:11:47 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1470157881.965974-768360645', 10:11:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:11:47 INFO - '_': '/tools/buildbot/bin/python'} 10:11:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:11:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:11:48 INFO - Running setup.py (path:/tmp/pip-kbyUWX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:11:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:11:48 INFO - Running setup.py (path:/tmp/pip-qQYGs8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:11:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:11:48 INFO - Running setup.py (path:/tmp/pip-TDSCHb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:11:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:11:48 INFO - Running setup.py (path:/tmp/pip-vzfTLh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:11:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:11:48 INFO - Running setup.py (path:/tmp/pip-AiAzwV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:11:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:11:48 INFO - Running setup.py (path:/tmp/pip-I_4saa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:11:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:11:48 INFO - Running setup.py (path:/tmp/pip-1VQtN8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:11:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:11:48 INFO - Running setup.py (path:/tmp/pip-o6VurM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:11:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:11:48 INFO - Running setup.py (path:/tmp/pip-oc8WDb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:11:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:11:48 INFO - Running setup.py (path:/tmp/pip-ZuK2R4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:11:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:11:48 INFO - Running setup.py (path:/tmp/pip-qsGMPw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:11:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:11:49 INFO - Running setup.py (path:/tmp/pip-E3IkFL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:11:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:11:49 INFO - Running setup.py (path:/tmp/pip-mE2gYG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:11:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:11:49 INFO - Running setup.py (path:/tmp/pip-aRIbB8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:11:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:11:49 INFO - Running setup.py (path:/tmp/pip-hwQdXv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:11:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:11:49 INFO - Running setup.py (path:/tmp/pip-Ubk5uz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:11:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:11:49 INFO - Running setup.py (path:/tmp/pip-yjfxbu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:11:49 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:11:49 INFO - Running setup.py install for manifestparser 10:11:49 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:11:49 INFO - Running setup.py install for mozcrash 10:11:49 INFO - Running setup.py install for mozdebug 10:11:49 INFO - Running setup.py install for mozdevice 10:11:49 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:11:49 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:11:49 INFO - Running setup.py install for mozfile 10:11:49 INFO - Running setup.py install for mozhttpd 10:11:50 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:11:50 INFO - Running setup.py install for mozinfo 10:11:50 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:11:50 INFO - Running setup.py install for mozInstall 10:11:50 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:11:50 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:11:50 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:11:50 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:11:50 INFO - Running setup.py install for mozleak 10:11:50 INFO - Running setup.py install for mozlog 10:11:50 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:11:50 INFO - Running setup.py install for moznetwork 10:11:50 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:11:50 INFO - Running setup.py install for mozprocess 10:11:50 INFO - Running setup.py install for mozprofile 10:11:50 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:11:50 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:11:50 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:11:50 INFO - Running setup.py install for mozrunner 10:11:50 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:11:50 INFO - Running setup.py install for mozscreenshot 10:11:50 INFO - Running setup.py install for moztest 10:11:51 INFO - Running setup.py install for mozversion 10:11:51 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:11:51 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:11:51 INFO - Cleaning up... 10:11:51 INFO - Return code: 0 10:11:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:11: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')]} 10:11:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:11:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:11: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')]} 10:11:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:11:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:11:51 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 0x212d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x235c400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23eb570>, '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 0x23ec470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23ec900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1470157881.965974-768360645', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:11:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 10:11:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:11:51 INFO - Using env: {'DISPLAY': ':0', 10:11:51 INFO - 'HOME': '/home/cltbld', 10:11:51 INFO - 'LANG': 'en_US.UTF-8', 10:11:51 INFO - 'LANGUAGE': 'en_US:en', 10:11:51 INFO - 'LOGNAME': 'cltbld', 10:11:51 INFO - 'MAIL': '/var/mail/cltbld', 10:11:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:11:51 INFO - 'MOZ_NO_REMOTE': '1', 10:11:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:11:51 INFO - 'NO_EM_RESTART': '1', 10:11:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:11:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:11:51 INFO - 'PWD': '/builds/slave/test', 10:11:51 INFO - 'SHELL': '/bin/bash', 10:11:51 INFO - 'SHLVL': '1', 10:11:51 INFO - 'TERM': 'linux', 10:11:51 INFO - 'TMOUT': '86400', 10:11:51 INFO - 'USER': 'cltbld', 10:11:51 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1470157881.965974-768360645', 10:11:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:11:51 INFO - '_': '/tools/buildbot/bin/python'} 10:11:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:11:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:11:51 INFO - Running setup.py (path:/tmp/pip-0ZpDBf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:11:51 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 10:11:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:11:51 INFO - Running setup.py (path:/tmp/pip-6cGhAf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:11:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:11:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:11:51 INFO - Running setup.py (path:/tmp/pip-nkYaMi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:11:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 10:11:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:11:51 INFO - Running setup.py (path:/tmp/pip-QsD4b7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:11:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:11:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:11:51 INFO - Running setup.py (path:/tmp/pip-6FVKFr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:11:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 10:11:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:11:51 INFO - Running setup.py (path:/tmp/pip-GXAJoU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:11:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 10:11:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:11:51 INFO - Running setup.py (path:/tmp/pip-pqnkyP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:11:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 10:11:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:11:51 INFO - Running setup.py (path:/tmp/pip-AOqPhE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:11:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 10:11:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:11:52 INFO - Running setup.py (path:/tmp/pip-1iirGJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:11:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 10:11:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:11:52 INFO - Running setup.py (path:/tmp/pip-HMkued-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:11:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:11:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:11:52 INFO - Running setup.py (path:/tmp/pip-onnroR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:11:52 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 10:11:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:11:52 INFO - Running setup.py (path:/tmp/pip-OJrSqf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:11:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 10:11:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:11:52 INFO - Running setup.py (path:/tmp/pip-wVSOfX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:11:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 10:11:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:11:52 INFO - Running setup.py (path:/tmp/pip-LEG72V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:11:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 10:11:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:11:52 INFO - Running setup.py (path:/tmp/pip-esQj5v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:11:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 10:11:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:11:52 INFO - Running setup.py (path:/tmp/pip-rtlW_H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:11:52 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 10:11:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:11:52 INFO - Running setup.py (path:/tmp/pip-TsUQ52-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:11:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 10:11:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:11:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:11:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 10:11:52 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:11:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:11:52 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:11:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:11:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:11:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:11:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:11:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:11:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:11:54 INFO - Downloading blessings-1.6.tar.gz 10:11:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:11:54 INFO - Installing collected packages: blessings 10:11:54 INFO - Running setup.py install for blessings 10:11:54 INFO - Successfully installed blessings 10:11:54 INFO - Cleaning up... 10:11:54 INFO - Return code: 0 10:11:54 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:11:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:11:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:11:55 INFO - Reading from file tmpfile_stdout 10:11:55 INFO - Current package versions: 10:11:55 INFO - argparse == 1.2.1 10:11:55 INFO - blessings == 1.6 10:11:55 INFO - blobuploader == 1.2.4 10:11:55 INFO - docopt == 0.6.1 10:11:55 INFO - functools32 == 3.2.3-2 10:11:55 INFO - jsonschema == 2.5.1 10:11:55 INFO - manifestparser == 1.1 10:11:55 INFO - mozInstall == 1.12 10:11:55 INFO - mozcrash == 0.17 10:11:55 INFO - mozdebug == 0.1 10:11:55 INFO - mozdevice == 0.48 10:11:55 INFO - mozfile == 1.2 10:11:55 INFO - mozhttpd == 0.7 10:11:55 INFO - mozinfo == 0.9 10:11:55 INFO - mozleak == 0.1 10:11:55 INFO - mozlog == 3.3 10:11:55 INFO - moznetwork == 0.27 10:11:55 INFO - mozprocess == 0.23 10:11:55 INFO - mozprofile == 0.28 10:11:55 INFO - mozrunner == 6.12 10:11:55 INFO - mozscreenshot == 0.1 10:11:55 INFO - mozsystemmonitor == 0.3 10:11:55 INFO - moztest == 0.7 10:11:55 INFO - mozversion == 1.4 10:11:55 INFO - psutil == 3.1.1 10:11:55 INFO - requests == 1.2.3 10:11:55 INFO - wsgiref == 0.1.2 10:11:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:11:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:11:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:11:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:11:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:11:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:11:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:11:55 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 0x212d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x235c400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23eb570>, '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 0x23ec470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23ec900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1470157881.965974-768360645', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:11:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 10:11:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:11:55 INFO - Using env: {'DISPLAY': ':0', 10:11:55 INFO - 'HOME': '/home/cltbld', 10:11:55 INFO - 'LANG': 'en_US.UTF-8', 10:11:55 INFO - 'LANGUAGE': 'en_US:en', 10:11:55 INFO - 'LOGNAME': 'cltbld', 10:11:55 INFO - 'MAIL': '/var/mail/cltbld', 10:11:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:11:55 INFO - 'MOZ_NO_REMOTE': '1', 10:11:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:11:55 INFO - 'NO_EM_RESTART': '1', 10:11:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:11:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:11:55 INFO - 'PWD': '/builds/slave/test', 10:11:55 INFO - 'SHELL': '/bin/bash', 10:11:55 INFO - 'SHLVL': '1', 10:11:55 INFO - 'TERM': 'linux', 10:11:55 INFO - 'TMOUT': '86400', 10:11:55 INFO - 'USER': 'cltbld', 10:11:55 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1470157881.965974-768360645', 10:11:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:11:55 INFO - '_': '/tools/buildbot/bin/python'} 10:11:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:11:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 10:11:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 10:11:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 10:11:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 10:11:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 10:11:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 10:11:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 10:11:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 10:11:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 10:11:55 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 10:11:55 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 10:11:55 INFO - Cleaning up... 10:11:55 INFO - Return code: 0 10:11:55 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:11:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:11:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:11:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:11:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:11:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:11:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:11:55 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 0x212d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x235c400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23eb570>, '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 0x23ec470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23ec900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1470157881.965974-768360645', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:11:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 10:11:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 10:11:55 INFO - Using env: {'DISPLAY': ':0', 10:11:55 INFO - 'HOME': '/home/cltbld', 10:11:55 INFO - 'LANG': 'en_US.UTF-8', 10:11:55 INFO - 'LANGUAGE': 'en_US:en', 10:11:55 INFO - 'LOGNAME': 'cltbld', 10:11:55 INFO - 'MAIL': '/var/mail/cltbld', 10:11:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:11:55 INFO - 'MOZ_NO_REMOTE': '1', 10:11:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:11:55 INFO - 'NO_EM_RESTART': '1', 10:11:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:11:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:11:55 INFO - 'PWD': '/builds/slave/test', 10:11:55 INFO - 'SHELL': '/bin/bash', 10:11:55 INFO - 'SHLVL': '1', 10:11:55 INFO - 'TERM': 'linux', 10:11:55 INFO - 'TMOUT': '86400', 10:11:55 INFO - 'USER': 'cltbld', 10:11:55 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1470157881.965974-768360645', 10:11:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:11:55 INFO - '_': '/tools/buildbot/bin/python'} 10:11:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:11:55 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:11:55 INFO - Cleaning up... 10:11:55 INFO - Return code: 0 10:11:55 INFO - Running post-action listener: _resource_record_post_action 10:11:55 INFO - Running post-action listener: _start_resource_monitoring 10:11:55 INFO - Starting resource monitoring. 10:11:55 INFO - [mozharness: 2016-08-02 17:11:55.477839Z] Finished create-virtualenv step (success) 10:11:55 INFO - [mozharness: 2016-08-02 17:11:55.478318Z] Running install step. 10:11:55 INFO - Running pre-action listener: _resource_record_pre_action 10:11:55 INFO - Running main action method: install 10:11:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:11:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:11:55 INFO - Reading from file tmpfile_stdout 10:11:55 INFO - Detecting whether we're running mozinstall >=1.0... 10:11:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:11:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:11:55 INFO - Reading from file tmpfile_stdout 10:11:55 INFO - Output received: 10:11:55 INFO - Usage: mozinstall [options] installer 10:11:55 INFO - Options: 10:11:55 INFO - -h, --help show this help message and exit 10:11:55 INFO - -d DEST, --destination=DEST 10:11:55 INFO - Directory to install application into. [default: 10:11:55 INFO - "/builds/slave/test"] 10:11:55 INFO - --app=APP Application being installed. [default: firefox] 10:11:55 INFO - mkdir: /builds/slave/test/build/application 10:11:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 10:11:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 10:12:13 INFO - Reading from file tmpfile_stdout 10:12:13 INFO - Output received: 10:12:13 INFO - /builds/slave/test/build/application/firefox/firefox 10:12:13 INFO - Running post-action listener: _resource_record_post_action 10:12:13 INFO - [mozharness: 2016-08-02 17:12:13.049773Z] Finished install step (success) 10:12:13 INFO - [mozharness: 2016-08-02 17:12:13.050051Z] Running run-tests step. 10:12:13 INFO - Running pre-action listener: _resource_record_pre_action 10:12:13 INFO - Running main action method: run_tests 10:12:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:12:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:12:13 INFO - Python 2.7.3 10:12:13 INFO - Return code: 0 10:12:13 INFO - grabbing minidump binary from tooltool 10:12:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:12:13 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 0x23eb570>, '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 0x23ec470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23ec900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:12:13 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 10:12:13 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 10:12:13 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 10:12:13 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:12:13 INFO - Return code: 0 10:12:13 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:12:13 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:12:13 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:12:13 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:12:13 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:12:13 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/LR04O9UVQyev69cM2RUEAg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-038', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 10:12:13 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/LR04O9UVQyev69cM2RUEAg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-038 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 10:12:13 INFO - Using env: {'DISPLAY': ':0', 10:12:13 INFO - 'HOME': '/home/cltbld', 10:12:13 INFO - 'LANG': 'en_US.UTF-8', 10:12:13 INFO - 'LANGUAGE': 'en_US:en', 10:12:13 INFO - 'LOGNAME': 'cltbld', 10:12:13 INFO - 'MAIL': '/var/mail/cltbld', 10:12:13 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:12:13 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:12:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:12:13 INFO - 'MOZ_NO_REMOTE': '1', 10:12:13 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:12:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:12:13 INFO - 'NO_EM_RESTART': '1', 10:12:13 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:12:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:12:13 INFO - 'PWD': '/builds/slave/test', 10:12:13 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:12:13 INFO - 'SHELL': '/bin/bash', 10:12:13 INFO - 'SHLVL': '1', 10:12:13 INFO - 'TERM': 'linux', 10:12:13 INFO - 'TMOUT': '86400', 10:12:13 INFO - 'USER': 'cltbld', 10:12:13 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1470157881.965974-768360645', 10:12:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:12:13 INFO - '_': '/tools/buildbot/bin/python'} 10:12:13 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/LR04O9UVQyev69cM2RUEAg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-038', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 10:12:13 INFO - mozversion application_buildid: 20160802073043 10:12:13 INFO - mozversion application_changeset: 02f8c8bd057d7ccc5096c880ec3458174008426c 10:12:13 INFO - mozversion application_display_name: Nightly 10:12:13 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:12:13 INFO - mozversion application_name: Firefox 10:12:13 INFO - mozversion application_remotingname: firefox 10:12:13 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 10:12:13 INFO - mozversion application_vendor: Mozilla 10:12:13 INFO - mozversion application_version: 51.0a1 10:12:13 INFO - mozversion platform_buildid: 20160802073043 10:12:13 INFO - mozversion platform_changeset: 02f8c8bd057d7ccc5096c880ec3458174008426c 10:12:13 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 10:12:13 INFO - mozversion platform_version: 51.0a1 10:12:13 INFO - using testdate: 1470157933 10:12:13 INFO - actual date: 1470157933 10:12:13 INFO - starting webserver on 'localhost:52664' 10:12:13 INFO - SUITE-START | Running 2 tests 10:12:13 INFO - TEST-START | dromaeo_css 10:12:13 INFO - operating with platform_type : linux_ 10:12:13 INFO - Initialising browser for dromaeo_css test... 10:12:13 INFO - TEST-INFO | started process 20003 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGFud9y/profile http://localhost:52664/getInfo.html) 10:12:18 INFO - PROCESS | 20003 | __metrics Screen width/height:1600/1200 10:12:18 INFO - PROCESS | 20003 | colorDepth:24 10:12:18 INFO - PROCESS | 20003 | Browser inner width/height: 1024/697 10:12:18 INFO - PROCESS | 20003 | __metrics 10:12:19 ERROR - PROCESS | 20003 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 10:12:20 INFO - TEST-INFO | 20003: exit 0 10:12:20 INFO - Browser initialized. 10:12:20 INFO - Running cycle 1/1 for dromaeo_css test... 10:12:20 INFO - TEST-INFO | started process 20121 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGFud9y/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:12:32 INFO - PROCESS | 20121 | RSS: Main: 163008512 10:12:32 INFO - PROCESS | 20121 | 10:13:21 INFO - PROCESS | 20121 | 1470158001974 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 10:15:30 INFO - PROCESS | 20121 | Cycle 1(1): loaded http://localhost:52664/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52664/tests/dromaeo/cssquery-ext.html) 10:15:31 INFO - PROCESS | 20121 | RSS: Main: 169369600 10:15:31 INFO - PROCESS | 20121 | 10:18:33 INFO - PROCESS | 20121 | Cycle 1(1): loaded http://localhost:52664/tests/dromaeo/cssquery-ext.html (next: http://localhost:52664/tests/dromaeo/cssquery-jquery.html) 10:18:34 INFO - PROCESS | 20121 | RSS: Main: 166998016 10:18:34 INFO - PROCESS | 20121 | 10:21:36 INFO - PROCESS | 20121 | Cycle 1(1): loaded http://localhost:52664/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52664/tests/dromaeo/cssquery-mootools.html) 10:21:37 INFO - PROCESS | 20121 | RSS: Main: 170229760 10:21:37 INFO - PROCESS | 20121 | 10:24:39 INFO - PROCESS | 20121 | Cycle 1(1): loaded http://localhost:52664/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52664/tests/dromaeo/cssquery-prototype.html) 10:24:39 INFO - PROCESS | 20121 | RSS: Main: 163971072 10:24:39 INFO - PROCESS | 20121 | 10:27:42 INFO - PROCESS | 20121 | Cycle 1(1): loaded http://localhost:52664/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52664/tests/dromaeo/cssquery-yui.html) 10:27:42 INFO - PROCESS | 20121 | RSS: Main: 166510592 10:27:42 INFO - PROCESS | 20121 | 10:30:45 INFO - PROCESS | 20121 | Cycle 1(1): loaded http://localhost:52664/tests/dromaeo/cssquery-yui.html (next: http://localhost:52664/tests/dromaeo/cssquery-dojo.html) 10:30:45 INFO - PROCESS | 20121 | RSS: Main: 169553920 10:30:45 INFO - PROCESS | 20121 | 10:30:45 INFO - PROCESS | 20121 | __start_tp_report 10:30:45 INFO - PROCESS | 20121 | _x_x_mozilla_page_load 10:30:45 INFO - PROCESS | 20121 | _x_x_mozilla_page_load_details 10:30:45 INFO - PROCESS | 20121 | |i|pagename|runs| 10:30:45 INFO - PROCESS | 20121 | |0;dojo.html;3080.491718866387;3082.3064810417645;3111.704388083132;3114.987629020569;3121.9219519512008;5327.440618735035;5357.30355053843;5396.622236443451;5410.729463526827;5481.725913704318;5328.280682107914;5403.918941215875;5409.648372855761;5419.051665958451;5484.314460692413;4663.743494107823;4869.586085182755;4984.675996060263;5020.272060551218;5060.746962651852;5012.548870601645;5038.571721403667;5050.393952725678;5084.771185296652;5092;4776.307435421879;4793.880152996168;4859.611231101503;4883.755812209375;4900.166971614834;4812.542808433193;4900.460949295574;4905.484924082992;4935.3090567320605;4940.555350018516;4833.250846118822;4863.367762190928;4878.853634390938;4884.731339776311;4933.260010998343;5262.2632831403635;5285.286486324336;5336.5351221012515;5372.838814835562;5403.081476149064;5692.316921969349;5762;5765.6540607563265;5802.82591522255;5815.9709201453725;5807.245058142456;5809.883802323972;5816.156657284712;5816.680082595455;5823.796167134173;5254.395744489432;5349.331333583302;5360.571154307646;5362.410134885159;5374.274472946141;5861.179434879035;5993.101034844721;6001.639901605918;6003.099535069775;6037.275526936708;5734.053881109654;5734.369219385864;5748.45389687979;5752.654840709571;5765.884682306414;5535.169724541351;5706.457886500776;5815.738291776795;5842.707864606753;5845.766169353264;5718.599698021182;5767.279090113736;5800.7099645018425;5845.970770146122;5854.356020837705;5759.1937128802;5783.421657834183;5824.126381042877;5825.912611310834;5835.037218858925;4330.870073897788;4428.977855110704;4488.910221795546;4497.572730590588;4540.318952157137;3935.409688546741;3994.7403418778267;4012.598740125964;4038.5355684096116;4049.8987525312104;5542.584306177053;5546.112621980464;5595.972020139955;5620.775168993277;5626.381098079208;5650.180723795027;5757.107648314518;5858.209141765892;5869.383714709979;5870.647761134345;5540.833774986757;5542.944570554243;5570.387257401682;5587.273654424899;5621.915671264935;5024.547790698854;5025.723585202776;5049.8737531562;5066.290719299301;5100.056489549445;5843.211166492554;5856.033754430557;6121.081837724377;6154.78458253959;6160.353162917829;5634.661920284796;5713.514351280188;5720.799772007959;5764.942350576441;5772.19189313488;5934.347221805684;5944.762209511571;5948.434898684618;5954.612950158399;5965.612235204698;5565.638233514808;5603.411641777555;5605.607607467601;5613.494785469327;5614.831555053355;5758.2514273144225;5772.9711351442975;5829.621074630305;5833.212516310244;5880.235569376125;5631.183478395692;5659.037963546125;5665.12190610456;5669.858253543694;5691.630044047124;5502.944970550403;5612.859678507906;5635.577331700057;5644.887102258014;5658.773649053992;5636.971815140898;5647.322321321303;5649.37856835756;5673.035583950656;5708.143778433268;5649.745761440663;5698.20225168485;5717.342505611908;5726.79956201531;5747.655140691572;5408.053590621704;5488.1493368527945;5547.972260138674;5598;5608.495235428831 10:30:45 INFO - PROCESS | 20121 | |1;ext.html;546.2056727756676;576.9787476167184;580.0631979353343;599.6821684507212;612.9632222066679;39718.801405993;44895.326570101395;44943;44950.10099798002;45046.774766126204;44850;45420.54579454204;45432.545674543246;45463.77268113663;45593.316100258526;8901.777455563613;9030.096990300983;9065.093490650948;9067.319951003668;9067.54662266884;8901.287896968259;8936.240419564312;8976.192142707156;9002.369834111614;9010.954945225298;8994.730158095268;9031.142041506046;9038.502882341469;9042.909570904305;9084.091590840897;8956.820863582725;8973.32700047499;9001.594928228245;9016.143466370684;9023.954880225558;8894.644214231423;8914.821703565956;8984.775380615472;8992.910070899337;8998.820023599557;42762;43090.35364469535;43140.35289470661;43188.56811431877;43232;3529.7176225901867;3636.2909232699635;3636.5817930938015;4019.417184508259;4176.1230141670285;33766.1558461038;33834.83082584596;33846.1538461538;34134.6586534134;35419.11452213689;4293.162833247518;4362.8036738346855;4403.581659742319;4497.685162038659;4550.431196100488;345772;353082;354266;355431;358237.9999999974;60479.395206048255;60745.69627151836;60811.69594152001;60825.39174608286;60920.39079609236;36799.4480082799;37088.07279818026;37368;40079.39880901789;40252.19495610071;15326.463573774865;15411.15238661862;15509.5347139586;15519.689606208038;15526.9223653881;11388.316700997966;11530.654080377435;11548.711282218012;11569.710757231136;11603.129765267639;19582.902085489768;19622.607547848962;19772.813631182176;19895.801041989685;20021.29925452602;7084.893726594105;7227.7831665050135;7352.033604746107;7359.411247100219;7429.739959101514;971.4511301114848;1017.4556612212431;1055.757175849559;1092.3882625729616;1106.983395249072;35235.471467928;35279.64720352815;35617.28765424677;35681;35697.28605427877;1095.6932059023486;1136.5113001409472;1142.280363371071;1168.696139003865;1205.5539450403232;17585;18252.817471825376;18277.908610456863;18377;18456.630867382577;585518;589085;593143;594314;597015;63116.368836311965;63548.04677929835;63653.681731591045;63668;63963.680181599724;1323.3184909771476;1345.8990575706666;1361.2445092973296;1378.3590630356932;1380.0132904972993;33128.83435582807;34044.65955340415;34054.14864628404;34558.65441345655;34653.48019779655;56181.71909140428;56933;56991.715041424526;57050.714746426005;57087.42912570821;482318.2956767024;486325;491825;492079;495913;46510;46766.53233467758;46786.532134678215;47367.28949065698;48109.75945120252;49965.50034499754;51140.232896507325;51192.488075120265;51786;52248.38758062006;42437.57562424336;44289;44413;45171.096578068915;45785.542144579464;43506.78246608747;43738.56261437345;44783.55216447794;45575.31637025514;45884.770576146904;41034.589654103074;43732.56267437285;43803;44006;44141.33787993118;34390.82804586061;39407.40888886726;40342.39486407765;40394.39408408935;40677.389839151845;30092.85824771839;30346.84826575853;30382.39235215239;30565.694343056286;30857.148571085807 10:30:45 INFO - PROCESS | 20121 | |2;jquery.html;393.89167978805824;398.6870306809154;400.569387907999;403.94748682671246;425.7913622325062;14208.928955355208;18622;18673;20375.28686495973;20482.2831200908;19075.71386429201;19410.90294548529;19435.222591096375;19775.802241977577;19837;5735.684537350444;5753.280839895013;5757.510611598019;5803.738831752581;5847.502962248214;5437.34751829781;5787.594868359217;5850.180974663551;5857.443542863442;5862.443067908542;5671.979043772119;5718.914216286759;5772.711364431782;5772.971135144318;5784.479396854283;5704.344000439961;5712.685802280873;5732.197492351074;5771.88456230873;5805.622634528763;5596.832095037155;5599.832005039855;5630.436956304377;5696.800611978602;5726.226959360516;13593.660158496017;13595;13663.658408539866;22493.826419923345;22602.32193034195;2208.1719355241785;2231.319447568491;2263.5133446309123;2269.171752310395;2355.2934119764004;9581.664641737505;9816;9831.360961537548;9970.700878973643;10034.24743144267;1836.1370156026646;1841.7329487224276;1872.0171909747355;1878.1266710979323;1942.6988816733428;83451.5827420859;83455.582722086;86553;87648.56175719145;88007;10777;10811.675649730521;11065.170112241614;11218;11250.156238282161;15480.767788483181;15504.922475387777;15520.456784012506;15523.379064837505;15670.451534196249;7404.629768511553;7442.255774422514;7573.2048134945035;7600.771976840703;7760.262775036363;6793.252742198354;6982.825429364307;7148.320909513588;7174.139103307636;7220.74727384539;4589.059242855206;4597.264437690021;4611.561901619408;4640.95359046412;4779.474257831635;1895.4124221491381;1927.267638297438;1952.4142757172792;2006.147387360366;2010.8190262876412;830;940.219617717293;988.6687959533493;1038.8389799581078;1050.8423736439595;18568.628627427377;19124.521886952938;19500.902495487433;19903.502412439804;20007.199712011647;962.821877952581;966.8743063401713;977.750673578233;1009.3439264478001;1023.3194925374692;10520.210984176065;10698.358098514114;10930.945345273381;11004.119670426508;11600.187986841009;520272;532607;539417;547858;552023;88384.5580772092;90293;94543;97211;99656.5017174924;1004;1029.4183786160795;1030.5929157982555;1039.3815679670736;1043.5147656339839;17400.82599173992;17510.562235944202;18299;18413;18437.17032733557;42557.36163957605;42814.143717126106;43597.56402435935;43697.78151109224;44304.11391772211;60783;61178.082328765995;61643;61729.38270617416;62042.37957620366;8419.789505262417;8576.699815506427;8726.389152759246;8809.07504711996;8830.293576513735;12285.447154878231;13061.608151755463;13220.471181152647;13414.932925335312;13584.252866092065;11580.015698665371;11602.47788849487;11627.18609697347;11630.592929247436;12036.458359373673;11405.543778248777;11610.303381797119;11645.59240426581;11744.88255117472;11845.23006004607;11123.165762567678;11922.701932451411;11935;12134.211276267015;12225.938870305592;7185.245549217257;7631.007968963999;7711.228877112244;7856.882146767917;8268.875966860382;10531.210159237935;11572.768544628892;11686.883131168579;11786.764264714486;11908.166428349932 10:30:45 INFO - PROCESS | 20121 | |3;mootools.html;1464.8754855837258;1482.414446293714;1605.7511085781707;1747.4670225581192;1782.0644161815053;7687.961560192205;8471.957640211798;8664.090270521583;9338.81322373553;9348.392354496962;8600.698975535857;8941.329400294971;8994.460332380046;9003.414778039423;9025.2328552073;2351.3533778211;2410.301012706313;2420.8426452280632;2424.2969538833718;2426.5632186206476;2401.9639705404434;2428.2229686500327;2433.452473193535;2454.864982425966;2457.287386657867;2388.426777573379;2404.410919324759;2424.1515469585593;2456.91400800972;2469.3085935937966;2377.3581133094053;2393.4734358441115;2396.424858034068;2407.5546023985617;2408.8313818032743;2347.7065366829147;2361.9527609447887;2373.6083546214854;2378.0368950575044;2382.594958856981;9113;9244.352895297332;9249.953750231205;9253.6298548058;9259.02780208082;5389.67661940281;5558.610897237195;5558.6942718150485;5563.972180139114;5578.023845826964;3498.8600455981987;3519.894403167909;3533.840977156034;3551.627079156703;3618.3306088373733;1181.2440038375446;1188.679056654707;1188.8929996300374;1197.443188917149;1229.7909355409602;12616.179948303423;12669.683257918534;12686.111972161953;12727.299998500079;12734.61796146117;4664.024422388498;4678.485366609671;4787.952120478821;4878.121938051185;4934.333864928189;10699.144068474503;10737.892621073846;10773.78452430947;10778.676639700821;10793.298435601819;5466.671999680032;5485.61600687948;5491.341039075257;5497.945020549823;5507;4483.08096840147;4884;4941.308216849644;5001.724905130252;5001.874953126201;4063.035814052057;4106.7535947842625;4211.326187809936;4220.873373798791;4228.577142285808;1310.5478609879576;1333.4799428223;1337.2110454831695;1338.6385675867461;1345.3676771917183;823.3742355809508;845.5772113943028;922.8569571716395;969.4038166527675;993.8807343118727;6303.180586523723;6311.179546658905;6449.935500644933;6457.3865482779065;6581.506387020992;946.0633972367307;950.5247376311844;962.5572236771163;968.9806203875883;982.9262805289632;4268.210381079511;4444.933326000048;4490.842820501267;4532.773361331921;4574.817007319736;10640.89359106399;11018.44907754609;11053.723656908642;11067.50196241171;11108.277961932448;10736.194785391126;10817.513211905483;10896.40069796153;10965.232433729721;10974.122070234362;8407.075221725605;8434.114417986146;8470.745877623682;8492.490450573108;8498.575071246412;6299.802662803114;6328.14570033058;6335.2714437838395;6471.870562588628;6502.739890404331;10366.792664146826;10487.790244195226;10500.212484063879;10513.684589462327;10618.09746171584;10496.212784041074;10627.946860265649;10736.89263107359;10813.297135686154;10897.945510272399;6679.298673639198;7285.890711639224;7402.1117465904435;7516.736914207976;7643.082830060428;8868;8908.153725396078;8927;8981.416207946462;8984.82030359376;7687.846243074995;7880.448368614142;7913.762587122395;8046.356291496783;8134.267915887362;7783.649735761791;7850.33272171849;7899;7981.64082616272;7999.480033797785;7211.819704507429;7300.05099337104;7386.2244464332625;7391.8152046199275;7430.182679905314;5314.5216930476445;5347.705876176848;5356.705381204071;5438.809641662523;5467.7266136692215;5565.1374037024325;5583.581231407742;5655.88688226225;5696.174054761954;5780.797672081457 10:30:45 INFO - PROCESS | 20121 | |4;prototype.html;323.2968293960635;329.80541480526483;330.11364486354125;336.8113856240505;339.86654507218424;5391.245225668405;5549.445055494449;5572.3870374258795;5581.609287349882;5605.27131472908;5437.32033495813;5449.754761035753;5468.6171967962255;5490.56075513959;5520.530754885829;4062.451569038179;4175.728577642459;4235.576442355755;4258.169656916903;4283.464566929134;4263.12605915788;4264.765437900915;4265.1469706058915;4270.594293542109;4278.550752171024;4253.766042867641;4258.936115958263;4260.829566817323;4274.230638485072;4277.230098582254;3986;4209.6421804146685;4235;4265.616094551474;4280.229558679436;3728.8694895678523;3731.421629647382;3734.3651579231323;3745.9438108428394;3750.718696097804;5370.355557333106;5385.138377859524;5398.2982212312545;5440.619156659035;5458.399576046631;4662.883427914296;4871.610271178297;4874.634402419797;4895.339129217581;4915.754212289407;5632.267805185341;5638;5684.204211410406;5786.669066114817;5815.941840581582;4060.1270726793587;4069.9186016279805;4083.4278802660892;4089.89775255621;4092.7312533114828;5932.169496270526;5982.252218472691;5989.041753319491;6003.459688628001;6060.151578778975;4139.068709540329;4168.458100446923;4171.395147703566;4180.163967206571;4181.414601955728;4223.936640950388;4228.8308467660945;4230.809613567397;4248.491785416195;4263.658907287409;4681.204195286809;4800.35195248644;4848.515148485123;4891.877703057381;4913.31213630092;5691.4144089224355;5721.39925307845;5739.540836733051;5745;5760.279965004374;1428.5214453158308;1453.5421342277361;1454.7599646058493;1458.1761304862719;1462.3565631122271;928.4800511713327;937.6530683647094;937.7949335104358;957.2724729205854;982.2289502740315;5504.706393997408;5508.394076651565;5511.63790088046;5521.282233309644;5553.389127196006;5804.100364443518;5840.8539786504825;5856.912146317809;5883.411478900673;5884.264466941632;5364.463553644604;5414.675119492843;5458.945410545924;5481.033890628227;5521.3221587530015;3087.857492727705;3098.5042393216977;3104.099811054769;3137.4352616528786;3156.2267244525237;5934.821955341346;6076.817695469143;6113.694315284307;6178;6189.84525386869;6011.969940150271;6076.301225359052;6083.908741368883;6094.299155597163;6094.847628809227;6257.405546473078;6258.249010118815;6269.589342397924;6270.529710271748;6309.274433440213;5663.773449061991;5945.375735547878;5956.37458066914;5962.284525856925;5976.252968378953;5907;5940.821775346746;5948.4943779779205;5959.940400595939;5981.282246130492;6146.631202127886;6210.96495135158;6221.4089661482085;6266.717997690206;6307.738452309464;4206.978965105277;4256.807744011774;4265.76538290397;4294.3558466230315;4318.157959197926;5821.388754180919;5915.733791979285;5955.642661440154;5961.940380596138;5999.790007349722;5589.441055894541;5646.176911544228;5767.8558036049435;5801.013827649225;5822.0787140244465;5785.074388097884;5804.1874137619925;5814.30228372598;5834.416558344132;5843.860447212753;5555.555555555465;5678.3186017678145;5731.226284451545;5754.741036653277;5821.27234095738;5787.363390027178;5795.594308398372;5823.708814559171;5847.8245652630485;5868.94131058701;5715.942550628147;5762.6830524319885;5775.797847075332;5790.594658373873;5794.652320860761 10:30:45 INFO - PROCESS | 20121 | |5;yui.html;744.4007573903006;764.6864785437972;775.7750252426797;783.5181363461469;884.394189979864;14137.575872723823;14742;15145.924270378646;15256.69486610267;15280.235988200573;13987.300634968262;14078.718425631481;14134.50529231477;14145.080569762958;14147.221902795342;800.9959950200241;811.3184924663282;812.8618134917049;814.340384288728;814.7311387242196;834.2158371131147;841.8274253777961;844.5523872347635;844.5861527851339;845.2603971524916;864.7967727584013;865.6148014133713;872.7556284240422;873.3493547307233;874.3922973533397;861.7759382560516;862.7454900804278;863.2619110660421;863.7970077031893;866.9003064647583;635.7711223959371;635.9236891572995;636.0618088319692;637.8788030274279;637.8851806674796;15024.17367044812;15317.540473785804;15343;15349.769753453707;15374.077555346716;13804.37880295379;13939.721205575832;14369.64075898111;14536.34586443602;14591.708165836624;12849.743005139939;12952.676183095404;13064.608061758163;13094.86905130946;13204.933975330157;3589.138606734391;3628.367234744371;3651.94522082169;3664.9816750916075;3756.5679946806194;92301.53849230778;92426;95487.52256238744;97897;98032.50983745107;11147.609833655946;11466.770664586662;11656;12277.324747138815;12735.363231838372;22664.773352266595;22673.659895101588;22829.429264268194;22844.086236550353;22855.428614284778;8305.335573154132;8383.329333653293;8413.915860841436;9091.772705682411;9167.587458564381;4471.619912307425;4605.723656580616;4658.440987081572;4744.003759210605;4744.7627618618935;3456.585209774843;3534.5581802274714;3557.324108419392;3562.1806984393734;3566.3045706087064;585.73934599103;585.8418227078665;597.6384287506083;612.1980205930246;614.3487902823022;631.2992578238152;688.5180373738403;708.5131189524805;725.1660590321068;735.7498450526847;9490;9617.519124043909;9693.515324233902;10109.949450252701;10332.793344133226;722.4834243515911;725.1914115760889;754.8943147959291;755.7619349904762;755.973540926076;4150.605692459211;4318.287482565404;4328.7402755834755;4369.650427965755;4433.224185767478;127654;128659;137249.45128017856;138390.30804845912;139058;92817;93961.5301923486;95321;104784;116433;88807;90919.54540227388;92957.5352123235;95056.92016178703;97114.5144274274;9911.256655750703;10019.348742331726;10232.283740138118;10476.565970125308;10634.41510716918;51003.23495147502;53045.469545304055;53155;53712.63500377348;53888.19167712566;74487.25512744804;75587.24412756022;80693.59653201696;82377.58811205905;83903.28773698212;11912.880871191177;12120.33338166374;12162.695932601755;12288.569900053455;12380.257184568594;14851.396781007143;14878.702425951637;15083.54749357521;15370.923145384202;15379.38482460689;14305.213213272953;14494.275286235857;14517.274136293354;14857.18285494265;15287;14309.713805723619;14643.780343294646;14664.853351466776;14670.63323416923;14909.850901490847;12705.491780328683;13115.147515411467;13224.801627975781;13263.734725305247;13282.269475178959;11180;11221.326720396803;11301.773964520828;11383.146264030065;11486.13853960973;10866.07638350749;10973.122150228122;11017.173711971795;11315.377654229096;11418.543258269576 10:30:45 INFO - PROCESS | 20121 | __end_tp_report 10:30:45 INFO - PROCESS | 20121 | __start_cc_report 10:30:45 INFO - PROCESS | 20121 | _x_x_mozilla_cycle_collect,318 10:30:45 INFO - PROCESS | 20121 | __end_cc_report 10:30:45 INFO - PROCESS | 20121 | __startTimestamp1470159045753__endTimestamp 10:30:45 INFO - PROCESS | 20121 | 10:30:45 INFO - PROCESS | 20121 | ------- Summary: start ------- 10:30:45 INFO - PROCESS | 20121 | Number of tests: 6 10:30:45 INFO - PROCESS | 20121 | 10:30:45 INFO - PROCESS | 20121 | [#0] dojo.html Cycles:165 Average:5381.84 Median:5612.86 stddev:611.47 (10.9%) stddev-sans-first:586.09 10:30:45 INFO - PROCESS | 20121 | Values: 3080.5 3082.3 3111.7 3115.0 3121.9 5327.4 5357.3 5396.6 5410.7 5481.7 5328.3 5403.9 5409.6 5419.1 5484.3 4663.7 4869.6 4984.7 5020.3 5060.7 5012.5 5038.6 5050.4 5084.8 5092.0 4776.3 4793.9 4859.6 4883.8 4900.2 4812.5 4900.5 4905.5 4935.3 4940.6 4833.3 4863.4 4878.9 4884.7 4933.3 5262.3 5285.3 5336.5 5372.8 5403.1 5692.3 5762.0 5765.7 5802.8 5816.0 5807.2 5809.9 5816.2 5816.7 5823.8 5254.4 5349.3 5360.6 5362.4 5374.3 5861.2 5993.1 6001.6 6003.1 6037.3 5734.1 5734.4 5748.5 5752.7 5765.9 5535.2 5706.5 5815.7 5842.7 5845.8 5718.6 5767.3 5800.7 5846.0 5854.4 5759.2 5783.4 5824.1 5825.9 5835.0 4330.9 4429.0 4488.9 4497.6 4540.3 3935.4 3994.7 4012.6 4038.5 4049.9 5542.6 5546.1 5596.0 5620.8 5626.4 5650.2 5757.1 5858.2 5869.4 5870.6 5540.8 5542.9 5570.4 5587.3 5621.9 5024.5 5025.7 5049.9 5066.3 5100.1 5843.2 5856.0 6121.1 6154.8 6160.4 5634.7 5713.5 5720.8 5764.9 5772.2 5934.3 5944.8 5948.4 5954.6 5965.6 5565.6 5603.4 5605.6 5613.5 5614.8 5758.3 5773.0 5829.6 5833.2 5880.2 5631.2 5659.0 5665.1 5669.9 5691.6 5502.9 5612.9 5635.6 5644.9 5658.8 5637.0 5647.3 5649.4 5673.0 5708.1 5649.7 5698.2 5717.3 5726.8 5747.7 5408.1 5488.1 5548.0 5598.0 5608.5 10:30:45 INFO - PROCESS | 20121 | 10:30:45 INFO - PROCESS | 20121 | [#1] ext.html Cycles:180 Average:64456.36 Median:44215.17 stddev:129677.35 (293.3%) stddev-sans-first:129952.35 10:30:45 INFO - PROCESS | 20121 | Values: 546.2 577.0 580.1 599.7 613.0 39718.8 44895.3 44943.0 44950.1 45046.8 44850.0 45420.5 45432.5 45463.8 45593.3 8901.8 9030.1 9065.1 9067.3 9067.5 8901.3 8936.2 8976.2 9002.4 9011.0 8994.7 9031.1 9038.5 9042.9 9084.1 8956.8 8973.3 9001.6 9016.1 9024.0 8894.6 8914.8 8984.8 8992.9 8998.8 42762.0 43090.4 43140.4 43188.6 43232.0 3529.7 3636.3 3636.6 4019.4 4176.1 33766.2 33834.8 33846.2 34134.7 35419.1 4293.2 4362.8 4403.6 4497.7 4550.4 345772.0 353082.0 354266.0 355431.0 358238.0 60479.4 60745.7 60811.7 60825.4 60920.4 36799.4 37088.1 37368.0 40079.4 40252.2 15326.5 15411.2 15509.5 15519.7 15526.9 11388.3 11530.7 11548.7 11569.7 11603.1 19582.9 19622.6 19772.8 19895.8 20021.3 7084.9 7227.8 7352.0 7359.4 7429.7 971.5 1017.5 1055.8 1092.4 1107.0 35235.5 35279.6 35617.3 35681.0 35697.3 1095.7 1136.5 1142.3 1168.7 1205.6 17585.0 18252.8 18277.9 18377.0 18456.6 585518.0 589085.0 593143.0 594314.0 597015.0 63116.4 63548.0 63653.7 63668.0 63963.7 1323.3 1345.9 1361.2 1378.4 1380.0 33128.8 34044.7 34054.1 34558.7 34653.5 56181.7 56933.0 56991.7 57050.7 57087.4 482318.3 486325.0 491825.0 492079.0 495913.0 46510.0 46766.5 46786.5 47367.3 48109.8 49965.5 51140.2 51192.5 51786.0 52248.4 42437.6 44289.0 44413.0 45171.1 45785.5 43506.8 43738.6 44783.6 45575.3 45884.8 41034.6 43732.6 43803.0 44006.0 44141.3 34390.8 39407.4 40342.4 40394.4 40677.4 30092.9 30346.8 30382.4 30565.7 30857.1 10:30:45 INFO - PROCESS | 20121 | 10:30:45 INFO - PROCESS | 20121 | [#2] jquery.html Cycles:180 Average:30465.79 Median:396.29 stddev:88753.25 (22396.1%) stddev-sans-first:88973.51 10:30:45 INFO - PROCESS | 20121 | Values: 393.9 398.7 400.6 403.9 425.8 14208.9 18622.0 18673.0 20375.3 20482.3 19075.7 19410.9 19435.2 19775.8 19837.0 5735.7 5753.3 5757.5 5803.7 5847.5 5437.3 5787.6 5850.2 5857.4 5862.4 5672.0 5718.9 5772.7 5773.0 5784.5 5704.3 5712.7 5732.2 5771.9 5805.6 5596.8 5599.8 5630.4 5696.8 5726.2 13593.7 13595.0 13663.7 22493.8 22602.3 2208.2 2231.3 2263.5 2269.2 2355.3 9581.7 9816.0 9831.4 9970.7 10034.2 1836.1 1841.7 1872.0 1878.1 1942.7 83451.6 83455.6 86553.0 87648.6 88007.0 10777.0 10811.7 11065.2 11218.0 11250.2 15480.8 15504.9 15520.5 15523.4 15670.5 7404.6 7442.3 7573.2 7600.8 7760.3 6793.3 6982.8 7148.3 7174.1 7220.7 4589.1 4597.3 4611.6 4641.0 4779.5 1895.4 1927.3 1952.4 2006.1 2010.8 830.0 940.2 988.7 1038.8 1050.8 18568.6 19124.5 19500.9 19903.5 20007.2 962.8 966.9 977.8 1009.3 1023.3 10520.2 10698.4 10930.9 11004.1 11600.2 520272.0 532607.0 539417.0 547858.0 552023.0 88384.6 90293.0 94543.0 97211.0 99656.5 1004.0 1029.4 1030.6 1039.4 1043.5 17400.8 17510.6 18299.0 18413.0 18437.2 42557.4 42814.1 43597.6 43697.8 44304.1 60783.0 61178.1 61643.0 61729.4 62042.4 8419.8 8576.7 8726.4 8809.1 8830.3 12285.4 13061.6 13220.5 13414.9 13584.3 11580.0 11602.5 11627.2 11630.6 12036.5 11405.5 11610.3 11645.6 11744.9 11845.2 11123.2 11922.7 11935.0 12134.2 12225.9 7185.2 7631.0 7711.2 7856.9 8268.9 10531.2 11572.8 11686.9 11786.8 11908.2 10:30:45 INFO - PROCESS | 20121 | 10:30:45 INFO - PROCESS | 20121 | [#3] mootools.html Cycles:180 Average:5999.40 Median:4909.17 stddev:3369.80 (68.6%) stddev-sans-first:3362.03 10:30:45 INFO - PROCESS | 20121 | Values: 1464.9 1482.4 1605.8 1747.5 1782.1 7688.0 8472.0 8664.1 9338.8 9348.4 8600.7 8941.3 8994.5 9003.4 9025.2 2351.4 2410.3 2420.8 2424.3 2426.6 2402.0 2428.2 2433.5 2454.9 2457.3 2388.4 2404.4 2424.2 2456.9 2469.3 2377.4 2393.5 2396.4 2407.6 2408.8 2347.7 2362.0 2373.6 2378.0 2382.6 9113.0 9244.4 9250.0 9253.6 9259.0 5389.7 5558.6 5558.7 5564.0 5578.0 3498.9 3519.9 3533.8 3551.6 3618.3 1181.2 1188.7 1188.9 1197.4 1229.8 12616.2 12669.7 12686.1 12727.3 12734.6 4664.0 4678.5 4788.0 4878.1 4934.3 10699.1 10737.9 10773.8 10778.7 10793.3 5466.7 5485.6 5491.3 5497.9 5507.0 4483.1 4884.0 4941.3 5001.7 5001.9 4063.0 4106.8 4211.3 4220.9 4228.6 1310.5 1333.5 1337.2 1338.6 1345.4 823.4 845.6 922.9 969.4 993.9 6303.2 6311.2 6449.9 6457.4 6581.5 946.1 950.5 962.6 969.0 982.9 4268.2 4444.9 4490.8 4532.8 4574.8 10640.9 11018.4 11053.7 11067.5 11108.3 10736.2 10817.5 10896.4 10965.2 10974.1 8407.1 8434.1 8470.7 8492.5 8498.6 6299.8 6328.1 6335.3 6471.9 6502.7 10366.8 10487.8 10500.2 10513.7 10618.1 10496.2 10627.9 10736.9 10813.3 10897.9 6679.3 7285.9 7402.1 7516.7 7643.1 8868.0 8908.2 8927.0 8981.4 8984.8 7687.8 7880.4 7913.8 8046.4 8134.3 7783.6 7850.3 7899.0 7981.6 7999.5 7211.8 7300.1 7386.2 7391.8 7430.2 5314.5 5347.7 5356.7 5438.8 5467.7 5565.1 5583.6 5655.9 5696.2 5780.8 10:30:45 INFO - PROCESS | 20121 | 10:30:45 INFO - PROCESS | 20121 | [#4] prototype.html Cycles:180 Average:4858.99 Median:5551.42 stddev:1450.63 (26.1%) stddev-sans-first:1414.19 10:30:45 INFO - PROCESS | 20121 | Values: 323.3 329.8 330.1 336.8 339.9 5391.2 5549.4 5572.4 5581.6 5605.3 5437.3 5449.8 5468.6 5490.6 5520.5 4062.5 4175.7 4235.6 4258.2 4283.5 4263.1 4264.8 4265.1 4270.6 4278.6 4253.8 4258.9 4260.8 4274.2 4277.2 3986.0 4209.6 4235.0 4265.6 4280.2 3728.9 3731.4 3734.4 3745.9 3750.7 5370.4 5385.1 5398.3 5440.6 5458.4 4662.9 4871.6 4874.6 4895.3 4915.8 5632.3 5638.0 5684.2 5786.7 5815.9 4060.1 4069.9 4083.4 4089.9 4092.7 5932.2 5982.3 5989.0 6003.5 6060.2 4139.1 4168.5 4171.4 4180.2 4181.4 4223.9 4228.8 4230.8 4248.5 4263.7 4681.2 4800.4 4848.5 4891.9 4913.3 5691.4 5721.4 5739.5 5745.0 5760.3 1428.5 1453.5 1454.8 1458.2 1462.4 928.5 937.7 937.8 957.3 982.2 5504.7 5508.4 5511.6 5521.3 5553.4 5804.1 5840.9 5856.9 5883.4 5884.3 5364.5 5414.7 5458.9 5481.0 5521.3 3087.9 3098.5 3104.1 3137.4 3156.2 5934.8 6076.8 6113.7 6178.0 6189.8 6012.0 6076.3 6083.9 6094.3 6094.8 6257.4 6258.2 6269.6 6270.5 6309.3 5663.8 5945.4 5956.4 5962.3 5976.3 5907.0 5940.8 5948.5 5959.9 5981.3 6146.6 6211.0 6221.4 6266.7 6307.7 4207.0 4256.8 4265.8 4294.4 4318.2 5821.4 5915.7 5955.6 5961.9 5999.8 5589.4 5646.2 5767.9 5801.0 5822.1 5785.1 5804.2 5814.3 5834.4 5843.9 5555.6 5678.3 5731.2 5754.7 5821.3 5787.4 5795.6 5823.7 5847.8 5868.9 5715.9 5762.7 5775.8 5790.6 5794.7 10:30:45 INFO - PROCESS | 20121 | 10:30:45 INFO - PROCESS | 20121 | [#5] yui.html Cycles:180 Average:22377.71 Median:3658.46 stddev:33568.50 (917.6%) stddev-sans-first:33623.37 10:30:45 INFO - PROCESS | 20121 | Values: 744.4 764.7 775.8 783.5 884.4 14137.6 14742.0 15145.9 15256.7 15280.2 13987.3 14078.7 14134.5 14145.1 14147.2 801.0 811.3 812.9 814.3 814.7 834.2 841.8 844.6 844.6 845.3 864.8 865.6 872.8 873.3 874.4 861.8 862.7 863.3 863.8 866.9 635.8 635.9 636.1 637.9 637.9 15024.2 15317.5 15343.0 15349.8 15374.1 13804.4 13939.7 14369.6 14536.3 14591.7 12849.7 12952.7 13064.6 13094.9 13204.9 3589.1 3628.4 3651.9 3665.0 3756.6 92301.5 92426.0 95487.5 97897.0 98032.5 11147.6 11466.8 11656.0 12277.3 12735.4 22664.8 22673.7 22829.4 22844.1 22855.4 8305.3 8383.3 8413.9 9091.8 9167.6 4471.6 4605.7 4658.4 4744.0 4744.8 3456.6 3534.6 3557.3 3562.2 3566.3 585.7 585.8 597.6 612.2 614.3 631.3 688.5 708.5 725.2 735.7 9490.0 9617.5 9693.5 10109.9 10332.8 722.5 725.2 754.9 755.8 756.0 4150.6 4318.3 4328.7 4369.7 4433.2 127654.0 128659.0 137249.5 138390.3 139058.0 92817.0 93961.5 95321.0 104784.0 116433.0 88807.0 90919.5 92957.5 95056.9 97114.5 9911.3 10019.3 10232.3 10476.6 10634.4 51003.2 53045.5 53155.0 53712.6 53888.2 74487.3 75587.2 80693.6 82377.6 83903.3 11912.9 12120.3 12162.7 12288.6 12380.3 14851.4 14878.7 15083.5 15370.9 15379.4 14305.2 14494.3 14517.3 14857.2 15287.0 14309.7 14643.8 14664.9 14670.6 14909.9 12705.5 13115.1 13224.8 13263.7 13282.3 11180.0 11221.3 11301.8 11383.1 11486.1 10866.1 10973.1 11017.2 11315.4 11418.5 10:30:45 INFO - PROCESS | 20121 | -------- Summary: end -------- 10:30:45 INFO - PROCESS | 20121 | 10:30:46 INFO - TEST-INFO | 20121: exit 0 10:30:46 INFO - TEST-OK | dromaeo_css | took 1113273ms 10:30:46 INFO - TEST-START | kraken 10:30:46 INFO - operating with platform_type : linux_ 10:30:46 INFO - Initialising browser for kraken test... 10:30:46 INFO - TEST-INFO | started process 20370 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVy4dPZ/profile http://localhost:52664/getInfo.html) 10:30:51 INFO - PROCESS | 20370 | __metrics Screen width/height:1600/1200 10:30:51 INFO - PROCESS | 20370 | colorDepth:24 10:30:51 INFO - PROCESS | 20370 | Browser inner width/height: 1024/697 10:30:51 INFO - PROCESS | 20370 | __metrics 10:30:52 ERROR - PROCESS | 20370 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 10:30:53 INFO - TEST-INFO | 20370: exit 0 10:30:53 INFO - Browser initialized. 10:30:53 INFO - Running cycle 1/1 for kraken test... 10:30:53 INFO - TEST-INFO | started process 20491 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVy4dPZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:31:04 INFO - PROCESS | 20491 | RSS: Main: 162926592 10:31:04 INFO - PROCESS | 20491 | 10:31:07 INFO - PROCESS | 20491 | Cycle 1(1): loaded http://localhost:52664/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52664/tests/kraken/driver.html?testName=audio-beat-detection) 10:31:08 INFO - PROCESS | 20491 | RSS: Main: 168521728 10:31:08 INFO - PROCESS | 20491 | 10:31:10 INFO - PROCESS | 20491 | Cycle 1(1): loaded http://localhost:52664/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52664/tests/kraken/driver.html?testName=audio-dft) 10:31:11 INFO - PROCESS | 20491 | RSS: Main: 167538688 10:31:11 INFO - PROCESS | 20491 | 10:31:14 INFO - PROCESS | 20491 | Cycle 1(1): loaded http://localhost:52664/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52664/tests/kraken/driver.html?testName=audio-fft) 10:31:15 INFO - PROCESS | 20491 | RSS: Main: 163225600 10:31:15 INFO - PROCESS | 20491 | 10:31:17 INFO - PROCESS | 20491 | Cycle 1(1): loaded http://localhost:52664/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52664/tests/kraken/driver.html?testName=audio-oscillator) 10:31:17 INFO - PROCESS | 20491 | RSS: Main: 164675584 10:31:17 INFO - PROCESS | 20491 | 10:31:20 INFO - PROCESS | 20491 | Cycle 1(1): loaded http://localhost:52664/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52664/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:31:20 INFO - PROCESS | 20491 | RSS: Main: 165154816 10:31:20 INFO - PROCESS | 20491 | 10:31:23 INFO - PROCESS | 20491 | Cycle 1(1): loaded http://localhost:52664/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52664/tests/kraken/driver.html?testName=imaging-darkroom) 10:31:24 INFO - PROCESS | 20491 | RSS: Main: 164769792 10:31:24 INFO - PROCESS | 20491 | 10:31:27 INFO - PROCESS | 20491 | Cycle 1(1): loaded http://localhost:52664/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52664/tests/kraken/driver.html?testName=imaging-desaturate) 10:31:28 INFO - PROCESS | 20491 | RSS: Main: 163102720 10:31:28 INFO - PROCESS | 20491 | 10:31:31 INFO - PROCESS | 20491 | Cycle 1(1): loaded http://localhost:52664/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52664/tests/kraken/driver.html?testName=json-parse-financial) 10:31:31 INFO - PROCESS | 20491 | RSS: Main: 164454400 10:31:31 INFO - PROCESS | 20491 | 10:31:33 INFO - PROCESS | 20491 | Cycle 1(1): loaded http://localhost:52664/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52664/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:31:34 INFO - PROCESS | 20491 | RSS: Main: 164716544 10:31:34 INFO - PROCESS | 20491 | 10:31:35 INFO - PROCESS | 20491 | Cycle 1(1): loaded http://localhost:52664/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52664/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:31:36 INFO - PROCESS | 20491 | RSS: Main: 164839424 10:31:36 INFO - PROCESS | 20491 | 10:31:38 INFO - PROCESS | 20491 | Cycle 1(1): loaded http://localhost:52664/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52664/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:31:39 INFO - PROCESS | 20491 | RSS: Main: 165392384 10:31:39 INFO - PROCESS | 20491 | 10:31:41 INFO - PROCESS | 20491 | Cycle 1(1): loaded http://localhost:52664/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52664/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:31:42 INFO - PROCESS | 20491 | RSS: Main: 165351424 10:31:42 INFO - PROCESS | 20491 | 10:31:45 INFO - PROCESS | 20491 | Cycle 1(1): loaded http://localhost:52664/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52664/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:31:45 INFO - PROCESS | 20491 | RSS: Main: 165822464 10:31:45 INFO - PROCESS | 20491 | 10:31:47 INFO - PROCESS | 20491 | Cycle 1(1): loaded http://localhost:52664/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52664/tests/kraken/driver.html?testName=ai-astar) 10:31:47 INFO - PROCESS | 20491 | RSS: Main: 166387712 10:31:47 INFO - PROCESS | 20491 | 10:31:47 INFO - PROCESS | 20491 | __start_tp_report 10:31:47 INFO - PROCESS | 20491 | _x_x_mozilla_page_load 10:31:47 INFO - PROCESS | 20491 | _x_x_mozilla_page_load_details 10:31:47 INFO - PROCESS | 20491 | |i|pagename|runs| 10:31:47 INFO - PROCESS | 20491 | |0;ai-astar;103;113;106;112;114;113;112;113;112;111 10:31:47 INFO - PROCESS | 20491 | |1;audio-beat-detection;146;120;145;175;121;148;153;119;192;120 10:31:47 INFO - PROCESS | 20491 | |2;audio-dft;163;163;164;162;162;162;170;164;161;160 10:31:47 INFO - PROCESS | 20491 | |3;audio-fft;76;76;74;179;81;75;75;77;163;82 10:31:47 INFO - PROCESS | 20491 | |4;audio-oscillator;86;83;164;84;84;84;152;84;84;142 10:31:47 INFO - PROCESS | 20491 | |5;imaging-gaussian-blur;118;118;117;118;117;117;118;118;118;118 10:31:47 INFO - PROCESS | 20491 | |6;imaging-darkroom;146;148;148;147;147;147;148;147;148;147 10:31:47 INFO - PROCESS | 20491 | |7;imaging-desaturate;95;95;95;95;96;96;95;97;96;96 10:31:47 INFO - PROCESS | 20491 | |8;json-parse-financial;59;52;51;52;52;53;52;51;52;53 10:31:47 INFO - PROCESS | 20491 | |9;json-stringify-tinderbox;63;63;62;62;66;62;62;63;63;63 10:31:47 INFO - PROCESS | 20491 | |10;stanford-crypto-aes;82;75;75;75;86;75;82;76;81;76 10:31:47 INFO - PROCESS | 20491 | |11;stanford-crypto-ccm;131;120;134;131;125;126;135;123;163;132 10:31:47 INFO - PROCESS | 20491 | |12;stanford-crypto-pbkdf2;161;161;160;164;161;164;161;159;161;159 10:31:47 INFO - PROCESS | 20491 | |13;stanford-crypto-sha256-iterative;66;65;64;74;64;66;65;62;66;63 10:31:47 INFO - PROCESS | 20491 | __end_tp_report 10:31:47 INFO - PROCESS | 20491 | __start_cc_report 10:31:47 INFO - PROCESS | 20491 | _x_x_mozilla_cycle_collect,859 10:31:47 INFO - PROCESS | 20491 | __end_cc_report 10:31:47 INFO - PROCESS | 20491 | __startTimestamp1470159107853__endTimestamp 10:31:47 INFO - PROCESS | 20491 | 10:31:47 INFO - PROCESS | 20491 | ------- Summary: start ------- 10:31:47 INFO - PROCESS | 20491 | Number of tests: 14 10:31:47 INFO - PROCESS | 20491 | 10:31:47 INFO - PROCESS | 20491 | [#0] ai-astar Cycles:10 Average:110.90 Median:112.50 stddev:3.54 (3.1%) stddev-sans-first:2.33 10:31:47 INFO - PROCESS | 20491 | Values: 103.0 113.0 106.0 112.0 114.0 113.0 112.0 113.0 112.0 111.0 10:31:47 INFO - PROCESS | 20491 | 10:31:47 INFO - PROCESS | 20491 | [#1] audio-beat-detection Cycles:10 Average:143.90 Median:147.00 stddev:25.11 (17.1%) stddev-sans-first:26.62 10:31:47 INFO - PROCESS | 20491 | Values: 146.0 120.0 145.0 175.0 121.0 148.0 153.0 119.0 192.0 120.0 10:31:47 INFO - PROCESS | 20491 | 10:31:47 INFO - PROCESS | 20491 | [#2] audio-dft Cycles:10 Average:163.10 Median:163.00 stddev:2.73 (1.7%) stddev-sans-first:2.89 10:31:47 INFO - PROCESS | 20491 | Values: 163.0 163.0 164.0 162.0 162.0 162.0 170.0 164.0 161.0 160.0 10:31:47 INFO - PROCESS | 20491 | 10:31:47 INFO - PROCESS | 20491 | [#3] audio-fft Cycles:10 Average:95.80 Median:76.00 stddev:39.90 (52.5%) stddev-sans-first:41.67 10:31:47 INFO - PROCESS | 20491 | Values: 76.0 76.0 74.0 179.0 81.0 75.0 75.0 77.0 163.0 82.0 10:31:47 INFO - PROCESS | 20491 | 10:31:47 INFO - PROCESS | 20491 | [#4] audio-oscillator Cycles:10 Average:104.70 Median:84.00 stddev:33.51 (39.9%) stddev-sans-first:34.86 10:31:47 INFO - PROCESS | 20491 | Values: 86.0 83.0 164.0 84.0 84.0 84.0 152.0 84.0 84.0 142.0 10:31:47 INFO - PROCESS | 20491 | 10:31:47 INFO - PROCESS | 20491 | [#5] imaging-gaussian-blur Cycles:10 Average:117.70 Median:118.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 10:31:47 INFO - PROCESS | 20491 | Values: 118.0 118.0 117.0 118.0 117.0 117.0 118.0 118.0 118.0 118.0 10:31:47 INFO - PROCESS | 20491 | 10:31:47 INFO - PROCESS | 20491 | [#6] imaging-darkroom Cycles:10 Average:147.30 Median:147.50 stddev:0.67 (0.5%) stddev-sans-first:0.53 10:31:47 INFO - PROCESS | 20491 | Values: 146.0 148.0 148.0 147.0 147.0 147.0 148.0 147.0 148.0 147.0 10:31:47 INFO - PROCESS | 20491 | 10:31:47 INFO - PROCESS | 20491 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.70 (0.7%) stddev-sans-first:0.71 10:31:47 INFO - PROCESS | 20491 | Values: 95.0 95.0 95.0 95.0 96.0 96.0 95.0 97.0 96.0 96.0 10:31:47 INFO - PROCESS | 20491 | 10:31:47 INFO - PROCESS | 20491 | [#8] json-parse-financial Cycles:10 Average:52.70 Median:52.00 stddev:2.31 (4.4%) stddev-sans-first:0.71 10:31:47 INFO - PROCESS | 20491 | Values: 59.0 52.0 51.0 52.0 52.0 53.0 52.0 51.0 52.0 53.0 10:31:47 INFO - PROCESS | 20491 | 10:31:47 INFO - PROCESS | 20491 | [#9] json-stringify-tinderbox Cycles:10 Average:62.90 Median:63.00 stddev:1.20 (1.9%) stddev-sans-first:1.27 10:31:47 INFO - PROCESS | 20491 | Values: 63.0 63.0 62.0 62.0 66.0 62.0 62.0 63.0 63.0 63.0 10:31:47 INFO - PROCESS | 20491 | 10:31:47 INFO - PROCESS | 20491 | [#10] stanford-crypto-aes Cycles:10 Average:78.30 Median:78.50 stddev:4.06 (5.2%) stddev-sans-first:4.08 10:31:47 INFO - PROCESS | 20491 | Values: 82.0 75.0 75.0 75.0 86.0 75.0 82.0 76.0 81.0 76.0 10:31:47 INFO - PROCESS | 20491 | 10:31:47 INFO - PROCESS | 20491 | [#11] stanford-crypto-ccm Cycles:10 Average:132.00 Median:131.50 stddev:11.95 (9.1%) stddev-sans-first:12.67 10:31:47 INFO - PROCESS | 20491 | Values: 131.0 120.0 134.0 131.0 125.0 126.0 135.0 123.0 163.0 132.0 10:31:47 INFO - PROCESS | 20491 | 10:31:47 INFO - PROCESS | 20491 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.10 Median:161.00 stddev:1.73 (1.1%) stddev-sans-first:1.83 10:31:47 INFO - PROCESS | 20491 | Values: 161.0 161.0 160.0 164.0 161.0 164.0 161.0 159.0 161.0 159.0 10:31:47 INFO - PROCESS | 20491 | 10:31:47 INFO - PROCESS | 20491 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.50 Median:65.50 stddev:3.27 (5.0%) stddev-sans-first:3.47 10:31:47 INFO - PROCESS | 20491 | Values: 66.0 65.0 64.0 74.0 64.0 66.0 65.0 62.0 66.0 63.0 10:31:47 INFO - PROCESS | 20491 | -------- Summary: end -------- 10:31:47 INFO - PROCESS | 20491 | 10:31:48 INFO - TEST-INFO | 20491: exit 0 10:31:48 INFO - TEST-OK | kraken | took 62278ms 10:31:48 INFO - SUITE-END | took 1175s 10:31:49 INFO - Completed test suite (00:19:35) 10:31:49 INFO - javascript benchmark 10:31:49 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7417.745922200454, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3080.491718866387, 3082.3064810417645, 3111.704388083132, 3114.987629020569, 3121.9219519512008, 5327.440618735035, 5357.30355053843, 5396.622236443451, 5410.729463526827, 5481.725913704318, 5328.280682107914, 5403.918941215875, 5409.648372855761, 5419.051665958451, 5484.314460692413, 4663.743494107823, 4869.586085182755, 4984.675996060263, 5020.272060551218, 5060.746962651852, 5012.548870601645, 5038.571721403667, 5050.393952725678, 5084.771185296652, 5092.0, 4776.307435421879, 4793.880152996168, 4859.611231101503, 4883.755812209375, 4900.166971614834, 4812.542808433193, 4900.460949295574, 4905.484924082992, 4935.3090567320605, 4940.555350018516, 4833.250846118822, 4863.367762190928, 4878.853634390938, 4884.731339776311, 4933.260010998343, 5262.2632831403635, 5285.286486324336, 5336.5351221012515, 5372.838814835562, 5403.081476149064, 5692.316921969349, 5762.0, 5765.6540607563265, 5802.82591522255, 5815.9709201453725, 5807.245058142456, 5809.883802323972, 5816.156657284712, 5816.680082595455, 5823.796167134173, 5254.395744489432, 5349.331333583302, 5360.571154307646, 5362.410134885159, 5374.274472946141, 5861.179434879035, 5993.101034844721, 6001.639901605918, 6003.099535069775, 6037.275526936708, 5734.053881109654, 5734.369219385864, 5748.45389687979, 5752.654840709571, 5765.884682306414, 5535.169724541351, 5706.457886500776, 5815.738291776795, 5842.707864606753, 5845.766169353264, 5718.599698021182, 5767.279090113736, 5800.7099645018425, 5845.970770146122, 5854.356020837705, 5759.1937128802, 5783.421657834183, 5824.126381042877, 5825.912611310834, 5835.037218858925, 4330.870073897788, 4428.977855110704, 4488.910221795546, 4497.572730590588, 4540.318952157137, 3935.409688546741, 3994.7403418778267, 4012.598740125964, 4038.5355684096116, 4049.8987525312104, 5542.584306177053, 5546.112621980464, 5595.972020139955, 5620.775168993277, 5626.381098079208, 5650.180723795027, 5757.107648314518, 5858.209141765892, 5869.383714709979, 5870.647761134345, 5540.833774986757, 5542.944570554243, 5570.387257401682, 5587.273654424899, 5621.915671264935, 5024.547790698854, 5025.723585202776, 5049.8737531562, 5066.290719299301, 5100.056489549445, 5843.211166492554, 5856.033754430557, 6121.081837724377, 6154.78458253959, 6160.353162917829, 5634.661920284796, 5713.514351280188, 5720.799772007959, 5764.942350576441, 5772.19189313488, 5934.347221805684, 5944.762209511571, 5948.434898684618, 5954.612950158399, 5965.612235204698, 5565.638233514808, 5603.411641777555, 5605.607607467601, 5613.494785469327, 5614.831555053355, 5758.2514273144225, 5772.9711351442975, 5829.621074630305, 5833.212516310244, 5880.235569376125, 5631.183478395692, 5659.037963546125, 5665.12190610456, 5669.858253543694, 5691.630044047124, 5502.944970550403, 5612.859678507906, 5635.577331700057, 5644.887102258014, 5658.773649053992, 5636.971815140898, 5647.322321321303, 5649.37856835756, 5673.035583950656, 5708.143778433268, 5649.745761440663, 5698.20225168485, 5717.342505611908, 5726.79956201531, 5747.655140691572, 5408.053590621704, 5488.1493368527945, 5547.972260138674, 5598.0, 5608.495235428831], "value": 5340.460101699543, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [546.2056727756676, 576.9787476167184, 580.0631979353343, 599.6821684507212, 612.9632222066679, 39718.801405993, 44895.326570101395, 44943.0, 44950.10099798002, 45046.774766126204, 44850.0, 45420.54579454204, 45432.545674543246, 45463.77268113663, 45593.316100258526, 8901.777455563613, 9030.096990300983, 9065.093490650948, 9067.319951003668, 9067.54662266884, 8901.287896968259, 8936.240419564312, 8976.192142707156, 9002.369834111614, 9010.954945225298, 8994.730158095268, 9031.142041506046, 9038.502882341469, 9042.909570904305, 9084.091590840897, 8956.820863582725, 8973.32700047499, 9001.594928228245, 9016.143466370684, 9023.954880225558, 8894.644214231423, 8914.821703565956, 8984.775380615472, 8992.910070899337, 8998.820023599557, 42762.0, 43090.35364469535, 43140.35289470661, 43188.56811431877, 43232.0, 3529.7176225901867, 3636.2909232699635, 3636.5817930938015, 4019.417184508259, 4176.1230141670285, 33766.1558461038, 33834.83082584596, 33846.1538461538, 34134.6586534134, 35419.11452213689, 4293.162833247518, 4362.8036738346855, 4403.581659742319, 4497.685162038659, 4550.431196100488, 345772.0, 353082.0, 354266.0, 355431.0, 358237.9999999974, 60479.395206048255, 60745.69627151836, 60811.69594152001, 60825.39174608286, 60920.39079609236, 36799.4480082799, 37088.07279818026, 37368.0, 40079.39880901789, 40252.19495610071, 15326.463573774865, 15411.15238661862, 15509.5347139586, 15519.689606208038, 15526.9223653881, 11388.316700997966, 11530.654080377435, 11548.711282218012, 11569.710757231136, 11603.129765267639, 19582.902085489768, 19622.607547848962, 19772.813631182176, 19895.801041989685, 20021.29925452602, 7084.893726594105, 7227.7831665050135, 7352.033604746107, 7359.411247100219, 7429.739959101514, 971.4511301114848, 1017.4556612212431, 1055.757175849559, 1092.3882625729616, 1106.983395249072, 35235.471467928, 35279.64720352815, 35617.28765424677, 35681.0, 35697.28605427877, 1095.6932059023486, 1136.5113001409472, 1142.280363371071, 1168.696139003865, 1205.5539450403232, 17585.0, 18252.817471825376, 18277.908610456863, 18377.0, 18456.630867382577, 585518.0, 589085.0, 593143.0, 594314.0, 597015.0, 63116.368836311965, 63548.04677929835, 63653.681731591045, 63668.0, 63963.680181599724, 1323.3184909771476, 1345.8990575706666, 1361.2445092973296, 1378.3590630356932, 1380.0132904972993, 33128.83435582807, 34044.65955340415, 34054.14864628404, 34558.65441345655, 34653.48019779655, 56181.71909140428, 56933.0, 56991.715041424526, 57050.714746426005, 57087.42912570821, 482318.2956767024, 486325.0, 491825.0, 492079.0, 495913.0, 46510.0, 46766.53233467758, 46786.532134678215, 47367.28949065698, 48109.75945120252, 49965.50034499754, 51140.232896507325, 51192.488075120265, 51786.0, 52248.38758062006, 42437.57562424336, 44289.0, 44413.0, 45171.096578068915, 45785.542144579464, 43506.78246608747, 43738.56261437345, 44783.55216447794, 45575.31637025514, 45884.770576146904, 41034.589654103074, 43732.56267437285, 43803.0, 44006.0, 44141.33787993118, 34390.82804586061, 39407.40888886726, 40342.39486407765, 40394.39408408935, 40677.389839151845, 30092.85824771839, 30346.84826575853, 30382.39235215239, 30565.694343056286, 30857.148571085807], "value": 20900.71026831263, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [393.89167978805824, 398.6870306809154, 400.569387907999, 403.94748682671246, 425.7913622325062, 14208.928955355208, 18622.0, 18673.0, 20375.28686495973, 20482.2831200908, 19075.71386429201, 19410.90294548529, 19435.222591096375, 19775.802241977577, 19837.0, 5735.684537350444, 5753.280839895013, 5757.510611598019, 5803.738831752581, 5847.502962248214, 5437.34751829781, 5787.594868359217, 5850.180974663551, 5857.443542863442, 5862.443067908542, 5671.979043772119, 5718.914216286759, 5772.711364431782, 5772.971135144318, 5784.479396854283, 5704.344000439961, 5712.685802280873, 5732.197492351074, 5771.88456230873, 5805.622634528763, 5596.832095037155, 5599.832005039855, 5630.436956304377, 5696.800611978602, 5726.226959360516, 13593.660158496017, 13595.0, 13663.658408539866, 22493.826419923345, 22602.32193034195, 2208.1719355241785, 2231.319447568491, 2263.5133446309123, 2269.171752310395, 2355.2934119764004, 9581.664641737505, 9816.0, 9831.360961537548, 9970.700878973643, 10034.24743144267, 1836.1370156026646, 1841.7329487224276, 1872.0171909747355, 1878.1266710979323, 1942.6988816733428, 83451.5827420859, 83455.582722086, 86553.0, 87648.56175719145, 88007.0, 10777.0, 10811.675649730521, 11065.170112241614, 11218.0, 11250.156238282161, 15480.767788483181, 15504.922475387777, 15520.456784012506, 15523.379064837505, 15670.451534196249, 7404.629768511553, 7442.255774422514, 7573.2048134945035, 7600.771976840703, 7760.262775036363, 6793.252742198354, 6982.825429364307, 7148.320909513588, 7174.139103307636, 7220.74727384539, 4589.059242855206, 4597.264437690021, 4611.561901619408, 4640.95359046412, 4779.474257831635, 1895.4124221491381, 1927.267638297438, 1952.4142757172792, 2006.147387360366, 2010.8190262876412, 830.0, 940.219617717293, 988.6687959533493, 1038.8389799581078, 1050.8423736439595, 18568.628627427377, 19124.521886952938, 19500.902495487433, 19903.502412439804, 20007.199712011647, 962.821877952581, 966.8743063401713, 977.750673578233, 1009.3439264478001, 1023.3194925374692, 10520.210984176065, 10698.358098514114, 10930.945345273381, 11004.119670426508, 11600.187986841009, 520272.0, 532607.0, 539417.0, 547858.0, 552023.0, 88384.5580772092, 90293.0, 94543.0, 97211.0, 99656.5017174924, 1004.0, 1029.4183786160795, 1030.5929157982555, 1039.3815679670736, 1043.5147656339839, 17400.82599173992, 17510.562235944202, 18299.0, 18413.0, 18437.17032733557, 42557.36163957605, 42814.143717126106, 43597.56402435935, 43697.78151109224, 44304.11391772211, 60783.0, 61178.082328765995, 61643.0, 61729.38270617416, 62042.37957620366, 8419.789505262417, 8576.699815506427, 8726.389152759246, 8809.07504711996, 8830.293576513735, 12285.447154878231, 13061.608151755463, 13220.471181152647, 13414.932925335312, 13584.252866092065, 11580.015698665371, 11602.47788849487, 11627.18609697347, 11630.592929247436, 12036.458359373673, 11405.543778248777, 11610.303381797119, 11645.59240426581, 11744.88255117472, 11845.23006004607, 11123.165762567678, 11922.701932451411, 11935.0, 12134.211276267015, 12225.938870305592, 7185.245549217257, 7631.007968963999, 7711.228877112244, 7856.882146767917, 8268.875966860382, 10531.210159237935, 11572.768544628892, 11686.883131168579, 11786.764264714486, 11908.166428349932], "value": 9137.758019299425, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1464.8754855837258, 1482.414446293714, 1605.7511085781707, 1747.4670225581192, 1782.0644161815053, 7687.961560192205, 8471.957640211798, 8664.090270521583, 9338.81322373553, 9348.392354496962, 8600.698975535857, 8941.329400294971, 8994.460332380046, 9003.414778039423, 9025.2328552073, 2351.3533778211, 2410.301012706313, 2420.8426452280632, 2424.2969538833718, 2426.5632186206476, 2401.9639705404434, 2428.2229686500327, 2433.452473193535, 2454.864982425966, 2457.287386657867, 2388.426777573379, 2404.410919324759, 2424.1515469585593, 2456.91400800972, 2469.3085935937966, 2377.3581133094053, 2393.4734358441115, 2396.424858034068, 2407.5546023985617, 2408.8313818032743, 2347.7065366829147, 2361.9527609447887, 2373.6083546214854, 2378.0368950575044, 2382.594958856981, 9113.0, 9244.352895297332, 9249.953750231205, 9253.6298548058, 9259.02780208082, 5389.67661940281, 5558.610897237195, 5558.6942718150485, 5563.972180139114, 5578.023845826964, 3498.8600455981987, 3519.894403167909, 3533.840977156034, 3551.627079156703, 3618.3306088373733, 1181.2440038375446, 1188.679056654707, 1188.8929996300374, 1197.443188917149, 1229.7909355409602, 12616.179948303423, 12669.683257918534, 12686.111972161953, 12727.299998500079, 12734.61796146117, 4664.024422388498, 4678.485366609671, 4787.952120478821, 4878.121938051185, 4934.333864928189, 10699.144068474503, 10737.892621073846, 10773.78452430947, 10778.676639700821, 10793.298435601819, 5466.671999680032, 5485.61600687948, 5491.341039075257, 5497.945020549823, 5507.0, 4483.08096840147, 4884.0, 4941.308216849644, 5001.724905130252, 5001.874953126201, 4063.035814052057, 4106.7535947842625, 4211.326187809936, 4220.873373798791, 4228.577142285808, 1310.5478609879576, 1333.4799428223, 1337.2110454831695, 1338.6385675867461, 1345.3676771917183, 823.3742355809508, 845.5772113943028, 922.8569571716395, 969.4038166527675, 993.8807343118727, 6303.180586523723, 6311.179546658905, 6449.935500644933, 6457.3865482779065, 6581.506387020992, 946.0633972367307, 950.5247376311844, 962.5572236771163, 968.9806203875883, 982.9262805289632, 4268.210381079511, 4444.933326000048, 4490.842820501267, 4532.773361331921, 4574.817007319736, 10640.89359106399, 11018.44907754609, 11053.723656908642, 11067.50196241171, 11108.277961932448, 10736.194785391126, 10817.513211905483, 10896.40069796153, 10965.232433729721, 10974.122070234362, 8407.075221725605, 8434.114417986146, 8470.745877623682, 8492.490450573108, 8498.575071246412, 6299.802662803114, 6328.14570033058, 6335.2714437838395, 6471.870562588628, 6502.739890404331, 10366.792664146826, 10487.790244195226, 10500.212484063879, 10513.684589462327, 10618.09746171584, 10496.212784041074, 10627.946860265649, 10736.89263107359, 10813.297135686154, 10897.945510272399, 6679.298673639198, 7285.890711639224, 7402.1117465904435, 7516.736914207976, 7643.082830060428, 8868.0, 8908.153725396078, 8927.0, 8981.416207946462, 8984.82030359376, 7687.846243074995, 7880.448368614142, 7913.762587122395, 8046.356291496783, 8134.267915887362, 7783.649735761791, 7850.33272171849, 7899.0, 7981.64082616272, 7999.480033797785, 7211.819704507429, 7300.05099337104, 7386.2244464332625, 7391.8152046199275, 7430.182679905314, 5314.5216930476445, 5347.705876176848, 5356.705381204071, 5438.809641662523, 5467.7266136692215, 5565.1374037024325, 5583.581231407742, 5655.88688226225, 5696.174054761954, 5780.797672081457], "value": 4808.015419917718, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [323.2968293960635, 329.80541480526483, 330.11364486354125, 336.8113856240505, 339.86654507218424, 5391.245225668405, 5549.445055494449, 5572.3870374258795, 5581.609287349882, 5605.27131472908, 5437.32033495813, 5449.754761035753, 5468.6171967962255, 5490.56075513959, 5520.530754885829, 4062.451569038179, 4175.728577642459, 4235.576442355755, 4258.169656916903, 4283.464566929134, 4263.12605915788, 4264.765437900915, 4265.1469706058915, 4270.594293542109, 4278.550752171024, 4253.766042867641, 4258.936115958263, 4260.829566817323, 4274.230638485072, 4277.230098582254, 3986.0, 4209.6421804146685, 4235.0, 4265.616094551474, 4280.229558679436, 3728.8694895678523, 3731.421629647382, 3734.3651579231323, 3745.9438108428394, 3750.718696097804, 5370.355557333106, 5385.138377859524, 5398.2982212312545, 5440.619156659035, 5458.399576046631, 4662.883427914296, 4871.610271178297, 4874.634402419797, 4895.339129217581, 4915.754212289407, 5632.267805185341, 5638.0, 5684.204211410406, 5786.669066114817, 5815.941840581582, 4060.1270726793587, 4069.9186016279805, 4083.4278802660892, 4089.89775255621, 4092.7312533114828, 5932.169496270526, 5982.252218472691, 5989.041753319491, 6003.459688628001, 6060.151578778975, 4139.068709540329, 4168.458100446923, 4171.395147703566, 4180.163967206571, 4181.414601955728, 4223.936640950388, 4228.8308467660945, 4230.809613567397, 4248.491785416195, 4263.658907287409, 4681.204195286809, 4800.35195248644, 4848.515148485123, 4891.877703057381, 4913.31213630092, 5691.4144089224355, 5721.39925307845, 5739.540836733051, 5745.0, 5760.279965004374, 1428.5214453158308, 1453.5421342277361, 1454.7599646058493, 1458.1761304862719, 1462.3565631122271, 928.4800511713327, 937.6530683647094, 937.7949335104358, 957.2724729205854, 982.2289502740315, 5504.706393997408, 5508.394076651565, 5511.63790088046, 5521.282233309644, 5553.389127196006, 5804.100364443518, 5840.8539786504825, 5856.912146317809, 5883.411478900673, 5884.264466941632, 5364.463553644604, 5414.675119492843, 5458.945410545924, 5481.033890628227, 5521.3221587530015, 3087.857492727705, 3098.5042393216977, 3104.099811054769, 3137.4352616528786, 3156.2267244525237, 5934.821955341346, 6076.817695469143, 6113.694315284307, 6178.0, 6189.84525386869, 6011.969940150271, 6076.301225359052, 6083.908741368883, 6094.299155597163, 6094.847628809227, 6257.405546473078, 6258.249010118815, 6269.589342397924, 6270.529710271748, 6309.274433440213, 5663.773449061991, 5945.375735547878, 5956.37458066914, 5962.284525856925, 5976.252968378953, 5907.0, 5940.821775346746, 5948.4943779779205, 5959.940400595939, 5981.282246130492, 6146.631202127886, 6210.96495135158, 6221.4089661482085, 6266.717997690206, 6307.738452309464, 4206.978965105277, 4256.807744011774, 4265.76538290397, 4294.3558466230315, 4318.157959197926, 5821.388754180919, 5915.733791979285, 5955.642661440154, 5961.940380596138, 5999.790007349722, 5589.441055894541, 5646.176911544228, 5767.8558036049435, 5801.013827649225, 5822.0787140244465, 5785.074388097884, 5804.1874137619925, 5814.30228372598, 5834.416558344132, 5843.860447212753, 5555.555555555465, 5678.3186017678145, 5731.226284451545, 5754.741036653277, 5821.27234095738, 5787.363390027178, 5795.594308398372, 5823.708814559171, 5847.8245652630485, 5868.94131058701, 5715.942550628147, 5762.6830524319885, 5775.797847075332, 5790.594658373873, 5794.652320860761], "value": 4390.007119290095, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [744.4007573903006, 764.6864785437972, 775.7750252426797, 783.5181363461469, 884.394189979864, 14137.575872723823, 14742.0, 15145.924270378646, 15256.69486610267, 15280.235988200573, 13987.300634968262, 14078.718425631481, 14134.50529231477, 14145.080569762958, 14147.221902795342, 800.9959950200241, 811.3184924663282, 812.8618134917049, 814.340384288728, 814.7311387242196, 834.2158371131147, 841.8274253777961, 844.5523872347635, 844.5861527851339, 845.2603971524916, 864.7967727584013, 865.6148014133713, 872.7556284240422, 873.3493547307233, 874.3922973533397, 861.7759382560516, 862.7454900804278, 863.2619110660421, 863.7970077031893, 866.9003064647583, 635.7711223959371, 635.9236891572995, 636.0618088319692, 637.8788030274279, 637.8851806674796, 15024.17367044812, 15317.540473785804, 15343.0, 15349.769753453707, 15374.077555346716, 13804.37880295379, 13939.721205575832, 14369.64075898111, 14536.34586443602, 14591.708165836624, 12849.743005139939, 12952.676183095404, 13064.608061758163, 13094.86905130946, 13204.933975330157, 3589.138606734391, 3628.367234744371, 3651.94522082169, 3664.9816750916075, 3756.5679946806194, 92301.53849230778, 92426.0, 95487.52256238744, 97897.0, 98032.50983745107, 11147.609833655946, 11466.770664586662, 11656.0, 12277.324747138815, 12735.363231838372, 22664.773352266595, 22673.659895101588, 22829.429264268194, 22844.086236550353, 22855.428614284778, 8305.335573154132, 8383.329333653293, 8413.915860841436, 9091.772705682411, 9167.587458564381, 4471.619912307425, 4605.723656580616, 4658.440987081572, 4744.003759210605, 4744.7627618618935, 3456.585209774843, 3534.5581802274714, 3557.324108419392, 3562.1806984393734, 3566.3045706087064, 585.73934599103, 585.8418227078665, 597.6384287506083, 612.1980205930246, 614.3487902823022, 631.2992578238152, 688.5180373738403, 708.5131189524805, 725.1660590321068, 735.7498450526847, 9490.0, 9617.519124043909, 9693.515324233902, 10109.949450252701, 10332.793344133226, 722.4834243515911, 725.1914115760889, 754.8943147959291, 755.7619349904762, 755.973540926076, 4150.605692459211, 4318.287482565404, 4328.7402755834755, 4369.650427965755, 4433.224185767478, 127654.0, 128659.0, 137249.45128017856, 138390.30804845912, 139058.0, 92817.0, 93961.5301923486, 95321.0, 104784.0, 116433.0, 88807.0, 90919.54540227388, 92957.5352123235, 95056.92016178703, 97114.5144274274, 9911.256655750703, 10019.348742331726, 10232.283740138118, 10476.565970125308, 10634.41510716918, 51003.23495147502, 53045.469545304055, 53155.0, 53712.63500377348, 53888.19167712566, 74487.25512744804, 75587.24412756022, 80693.59653201696, 82377.58811205905, 83903.28773698212, 11912.880871191177, 12120.33338166374, 12162.695932601755, 12288.569900053455, 12380.257184568594, 14851.396781007143, 14878.702425951637, 15083.54749357521, 15370.923145384202, 15379.38482460689, 14305.213213272953, 14494.275286235857, 14517.274136293354, 14857.18285494265, 15287.0, 14309.713805723619, 14643.780343294646, 14664.853351466776, 14670.63323416923, 14909.850901490847, 12705.491780328683, 13115.147515411467, 13224.801627975781, 13263.734725305247, 13282.269475178959, 11180.0, 11221.326720396803, 11301.773964520828, 11383.146264030065, 11486.13853960973, 10866.07638350749, 10973.122150228122, 11017.173711971795, 11315.377654229096, 11418.543258269576], "value": 7737.0883582282195, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1531.5, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 113.0, 106.0, 112.0, 114.0, 113.0, 112.0, 113.0, 112.0, 111.0], "value": 110.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 120.0, 145.0, 175.0, 121.0, 148.0, 153.0, 119.0, 192.0, 120.0], "value": 143.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 164.0, 162.0, 162.0, 162.0, 170.0, 164.0, 161.0, 160.0], "value": 163.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 74.0, 179.0, 81.0, 75.0, 75.0, 77.0, 163.0, 82.0], "value": 95.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 83.0, 164.0, 84.0, 84.0, 84.0, 152.0, 84.0, 84.0, 142.0], "value": 104.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 118.0, 117.0, 117.0, 118.0, 118.0, 118.0, 118.0], "value": 117.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 148.0, 148.0, 147.0, 147.0, 147.0, 148.0, 147.0, 148.0, 147.0], "value": 147.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 96.0, 96.0, 95.0, 97.0, 96.0, 96.0], "value": 95.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 52.0, 51.0, 52.0, 52.0, 53.0, 52.0, 51.0, 52.0, 53.0], "value": 52.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 62.0, 62.0, 66.0, 62.0, 62.0, 63.0, 63.0, 63.0], "value": 62.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 75.0, 75.0, 75.0, 86.0, 75.0, 82.0, 76.0, 81.0, 76.0], "value": 78.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 120.0, 134.0, 131.0, 125.0, 126.0, 135.0, 123.0, 163.0, 132.0], "value": 132.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 160.0, 164.0, 161.0, 164.0, 161.0, 159.0, 161.0, 159.0], "value": 161.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 64.0, 74.0, 64.0, 66.0, 65.0, 62.0, 66.0, 63.0], "value": 65.5, "unit": "score"}]}]} 10:31:49 INFO - Return code: 0 10:31:49 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:31:49 ERROR - # TBPL SUCCESS # 10:31:49 INFO - Running post-action listener: _resource_record_post_action 10:31:49 INFO - [mozharness: 2016-08-02 17:31:49.174211Z] Finished run-tests step (success) 10:31:49 INFO - Running post-run listener: _resource_record_post_run 10:31:49 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 4096; Write bytes: 544235520; Read time: 16; Write time: 1347632 10:31:49 INFO - TinderboxPrint: CPU usage
13.4% 10:31:49 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 10:31:49 INFO - TinderboxPrint: I/O write bytes / time
544,235,520 / 1,347,632 10:31:49 INFO - TinderboxPrint: CPU idle
8,242.6 (86.6%) 10:31:49 INFO - TinderboxPrint: CPU user
1,209.1 (12.7%) 10:31:49 INFO - TinderboxPrint: Swap in / out
0 / 0 10:31:49 INFO - install - Wall time: 18s; CPU: 16.0%; Read bytes: 0; Write bytes: 253345792; Read time: 0; Write time: 593860 10:31:49 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 0; Write bytes: 287006720; Read time: 0; Write time: 753152 10:31:49 INFO - Running post-run listener: _upload_blobber_files 10:31:49 INFO - Blob upload gear active. 10:31:49 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:31:49 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 10:31:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:31:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:31:50 INFO - (blobuploader) - INFO - Open directory for files ... 10:31:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 10:31:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:31:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:31:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 10:31:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:31:51 INFO - (blobuploader) - INFO - Done attempting. 10:31:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:31:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:31:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:31:55 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:31:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:31:55 INFO - (blobuploader) - INFO - Done attempting. 10:31:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 10:31:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:31:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:31:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 10:31:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:31:56 INFO - (blobuploader) - INFO - Done attempting. 10:31:56 INFO - (blobuploader) - INFO - Iteration through files over. 10:31:56 INFO - Return code: 0 10:31:56 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:31:56 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:31:56 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c93b4503cface73d76e01b98c17f0495d27506bbed82e1f03aa5d7eac83953931bb222d6abfe2ffb295ed17aaac88e5b3edb070872051d353e7b8d68ac13a816", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/a5bb9475926620ca1f4524592f1602b1014473cd721e44a8ec2f13f96fa5c23143aca6cc2d4cacde718636e8850cacc97d43ce2d322a2761a8f78273b53427f8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c51c82432703e64adfb358ceeacdf54bd370443531fca193c1ae2f9955eea3af37ebc650f059ef5e9b92c30d4b156e2c2d3c22637b1b43d71fc2af16cc75f5f1"} 10:31:56 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:31:56 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:31:56 INFO - Contents: 10:31:56 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c93b4503cface73d76e01b98c17f0495d27506bbed82e1f03aa5d7eac83953931bb222d6abfe2ffb295ed17aaac88e5b3edb070872051d353e7b8d68ac13a816", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/a5bb9475926620ca1f4524592f1602b1014473cd721e44a8ec2f13f96fa5c23143aca6cc2d4cacde718636e8850cacc97d43ce2d322a2761a8f78273b53427f8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c51c82432703e64adfb358ceeacdf54bd370443531fca193c1ae2f9955eea3af37ebc650f059ef5e9b92c30d4b156e2c2d3c22637b1b43d71fc2af16cc75f5f1"} 10:31:56 INFO - Running post-run listener: copy_logs_to_upload_dir 10:31:56 INFO - Copying logs to upload dir... 10:31:56 INFO - mkdir: /builds/slave/test/build/upload/logs 10:31:56 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1232.913147 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-08-02 10:31:56.541028) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-02 10:31:56.544326) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8783db0840cc980e80bb0bd400000236-1470157881.965974-768360645 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/c93b4503cface73d76e01b98c17f0495d27506bbed82e1f03aa5d7eac83953931bb222d6abfe2ffb295ed17aaac88e5b3edb070872051d353e7b8d68ac13a816", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/a5bb9475926620ca1f4524592f1602b1014473cd721e44a8ec2f13f96fa5c23143aca6cc2d4cacde718636e8850cacc97d43ce2d322a2761a8f78273b53427f8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c51c82432703e64adfb358ceeacdf54bd370443531fca193c1ae2f9955eea3af37ebc650f059ef5e9b92c30d4b156e2c2d3c22637b1b43d71fc2af16cc75f5f1"} build_url:https://queue.taskcluster.net/v1/task/LR04O9UVQyev69cM2RUEAg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011423 build_url: 'https://queue.taskcluster.net/v1/task/LR04O9UVQyev69cM2RUEAg/artifacts/public/build/firefox-51.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/c93b4503cface73d76e01b98c17f0495d27506bbed82e1f03aa5d7eac83953931bb222d6abfe2ffb295ed17aaac88e5b3edb070872051d353e7b8d68ac13a816", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/a5bb9475926620ca1f4524592f1602b1014473cd721e44a8ec2f13f96fa5c23143aca6cc2d4cacde718636e8850cacc97d43ce2d322a2761a8f78273b53427f8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c51c82432703e64adfb358ceeacdf54bd370443531fca193c1ae2f9955eea3af37ebc650f059ef5e9b92c30d4b156e2c2d3c22637b1b43d71fc2af16cc75f5f1"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-02 10:31:56.573001) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-02 10:31:56.573792) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8783db0840cc980e80bb0bd400000236-1470157881.965974-768360645 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004480 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-02 10:31:56.656599) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-02 10:31:56.657331) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-02 10:31:56.657990) ========= ========= Total master_lag: 0.18 =========