builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-031 starttime: 1464930670.03 results: success (0) buildid: 20160602193138 builduid: 9a59e4d19a5a4d89b490b9986f12fa77 revision: c5c9bc65a408fa0c26ec742c0950b6fc484cb635 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-02 22:11:10.031529) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-02 22:11:10.032024) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-02 22:11:10.032311) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-02 22:11:10.047037) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 22:11:10.047410) ========= 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=db0483c52d987ecb441a263b000001ad-1464930669.597156-1532903752 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-02 22:11:10-- 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% 43.0M=0s 2016-06-02 22:11:10 (43.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.091104 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 22:11:10.152489) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 22:11:10.152814) ========= 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=db0483c52d987ecb441a263b000001ad-1464930669.597156-1532903752 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018561 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 22:11:10.202404) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-06-02 22:11:10.202820) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev c5c9bc65a408fa0c26ec742c0950b6fc484cb635 --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 c5c9bc65a408fa0c26ec742c0950b6fc484cb635 --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=db0483c52d987ecb441a263b000001ad-1464930669.597156-1532903752 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-02 22:11:10,461 truncating revision to first 12 chars 2016-06-02 22:11:10,461 Setting DEBUG logging. 2016-06-02 22:11:10,461 attempt 1/10 2016-06-02 22:11:10,461 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/c5c9bc65a408?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-02 22:11:11,894 unpacking tar archive at: mozilla-inbound-c5c9bc65a408/testing/mozharness/ program finished with exit code 0 elapsedTime=2.201781 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-06-02 22:11:12.417985) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-02 22:11:12.418316) ========= script_repo_revision: c5c9bc65a408fa0c26ec742c0950b6fc484cb635 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-02 22:11:12.418728) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-02 22:11:12.418996) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-02 22:11:12.426986) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-06-02 22:11:12.427264) ========= /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=db0483c52d987ecb441a263b000001ad-1464930669.597156-1532903752 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:11:12 INFO - MultiFileLogger online at 20160602 22:11:12 in /builds/slave/test 22:11:12 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 22:11:12 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 22:11:12 INFO - {'append_to_log': False, 22:11:12 INFO - 'base_work_dir': '/builds/slave/test', 22:11:12 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 22:11:12 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 22:11:12 INFO - 'branch': 'Mozilla-Inbound', 22:11:12 INFO - 'buildbot_json_path': 'buildprops.json', 22:11:12 INFO - 'config_files': ('talos/linux_config.py',), 22:11:12 INFO - 'default_actions': ('clobber', 22:11:12 INFO - 'read-buildbot-config', 22:11:12 INFO - 'download-and-extract', 22:11:12 INFO - 'populate-webroot', 22:11:12 INFO - 'create-virtualenv', 22:11:12 INFO - 'install', 22:11:12 INFO - 'run-tests'), 22:11:12 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:11:12 INFO - 'download_minidump_stackwalk': True, 22:11:12 INFO - 'download_symbols': 'ondemand', 22:11:12 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:11:12 INFO - 'tooltool.py': '/tools/tooltool.py', 22:11:12 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:11:12 INFO - '/tools/misc-python/virtualenv.py')}, 22:11:12 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:11:12 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:11:12 INFO - 'installer_path': 'installer.exe', 22:11:12 INFO - 'log_level': 'info', 22:11:12 INFO - 'log_name': 'talos', 22:11:12 INFO - 'log_to_console': True, 22:11:12 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:11:12 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:11:12 INFO - 'opt_config_files': (), 22:11:12 INFO - 'pip_index': False, 22:11:12 INFO - 'sps_profile': False, 22:11:12 INFO - 'sps_profile_interval': 0, 22:11:12 INFO - 'suite': 'dromaeojs-e10s', 22:11:12 INFO - 'system_bits': '32', 22:11:12 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:11:12 INFO - 'title': 'talos-linux64-ix-031', 22:11:12 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:11:12 INFO - 'use_talos_json': True, 22:11:12 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 22:11:12 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:11:12 INFO - 'work_dir': 'build'} 22:11:12 INFO - ##### 22:11:12 INFO - ##### Running clobber step. 22:11:12 INFO - ##### 22:11:12 INFO - Running pre-action listener: _resource_record_pre_action 22:11:12 INFO - Running main action method: clobber 22:11:12 INFO - rmtree: /builds/slave/test/build 22:11:12 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 22:11:13 INFO - Running post-action listener: _resource_record_post_action 22:11:13 INFO - ##### 22:11:13 INFO - ##### Finished clobber step (success) 22:11:13 INFO - ##### 22:11:13 INFO - ##### 22:11:13 INFO - ##### Running read-buildbot-config step. 22:11:13 INFO - ##### 22:11:13 INFO - Running pre-action listener: _resource_record_pre_action 22:11:13 INFO - Running main action method: read_buildbot_config 22:11:13 INFO - Using buildbot properties: 22:11:13 INFO - { 22:11:13 INFO - "project": "", 22:11:13 INFO - "product": "firefox", 22:11:13 INFO - "script_repo_revision": "production", 22:11:13 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 22:11:13 INFO - "repository": "", 22:11:13 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 22:11:13 INFO - "buildid": "20160602193138", 22:11:13 INFO - "pgo_build": "True", 22:11:13 INFO - "basedir": "/builds/slave/test", 22:11:13 INFO - "buildnumber": 783, 22:11:13 INFO - "slavename": "talos-linux64-ix-031", 22:11:13 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 22:11:13 INFO - "platform": "ubuntu64_hw", 22:11:13 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 22:11:13 INFO - "branch": "mozilla-inbound", 22:11:13 INFO - "repo_path": "integration/mozilla-inbound", 22:11:13 INFO - "revision": "c5c9bc65a408fa0c26ec742c0950b6fc484cb635", 22:11:13 INFO - "stage_platform": "linux64-pgo", 22:11:13 INFO - "builduid": "9a59e4d19a5a4d89b490b9986f12fa77", 22:11:13 INFO - "slavebuilddir": "test" 22:11:13 INFO - } 22:11:13 INFO - Found installer url https://queue.taskcluster.net/v1/task/cN-KpsgvRQKyhxA3iZAElA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 22:11:13 INFO - Running post-action listener: _resource_record_post_action 22:11:13 INFO - ##### 22:11:13 INFO - ##### Finished read-buildbot-config step (success) 22:11:13 INFO - ##### 22:11:13 INFO - ##### 22:11:13 INFO - ##### Running download-and-extract step. 22:11:13 INFO - ##### 22:11:13 INFO - Running pre-action listener: _resource_record_pre_action 22:11:13 INFO - Running main action method: download_and_extract 22:11:13 INFO - mkdir: /builds/slave/test/build/tests 22:11: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')]} 22:11:13 INFO - https://queue.taskcluster.net/v1/task/cN-KpsgvRQKyhxA3iZAElA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 22:11:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cN-KpsgvRQKyhxA3iZAElA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 22:11:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cN-KpsgvRQKyhxA3iZAElA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 22:11:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cN-KpsgvRQKyhxA3iZAElA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 22:11:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cN-KpsgvRQKyhxA3iZAElA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 22:11:15 INFO - Downloaded 1361 bytes. 22:11:15 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 22:11:15 INFO - Using the following test package requirements: 22:11:15 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 22:11:15 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 22:11:15 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 22:11:15 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 22:11:15 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 22:11:15 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 22:11:15 INFO - u'jsshell-linux-x86_64.zip'], 22:11:15 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 22:11:15 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 22:11:15 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 22:11:15 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 22:11:15 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 22:11:15 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 22:11:15 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 22:11:15 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 22:11:15 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 22:11:15 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 22:11:15 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 22:11:15 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:11:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:11:15 INFO - https://queue.taskcluster.net/v1/task/cN-KpsgvRQKyhxA3iZAElA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:11:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cN-KpsgvRQKyhxA3iZAElA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 22:11:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cN-KpsgvRQKyhxA3iZAElA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 22:11:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cN-KpsgvRQKyhxA3iZAElA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 22:11:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cN-KpsgvRQKyhxA3iZAElA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:11:16 INFO - Downloaded 24424251 bytes. 22:11:16 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 22:11:16 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 22:11:17 INFO - Return code: 0 22:11:17 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 22:11:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:11:17 INFO - https://queue.taskcluster.net/v1/task/cN-KpsgvRQKyhxA3iZAElA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:11:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cN-KpsgvRQKyhxA3iZAElA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 22:11:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cN-KpsgvRQKyhxA3iZAElA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 22:11:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cN-KpsgvRQKyhxA3iZAElA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 22:11:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cN-KpsgvRQKyhxA3iZAElA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:11:18 INFO - Downloaded 24424251 bytes. 22:11:18 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 22:11:18 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 22:11:20 INFO - Return code: 0 22:11:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:11:20 INFO - https://queue.taskcluster.net/v1/task/cN-KpsgvRQKyhxA3iZAElA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 22:11:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cN-KpsgvRQKyhxA3iZAElA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 22:11:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cN-KpsgvRQKyhxA3iZAElA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 22:11:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cN-KpsgvRQKyhxA3iZAElA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 22:11:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cN-KpsgvRQKyhxA3iZAElA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 22:11:21 INFO - Downloaded 10833369 bytes. 22:11:21 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 22:11:21 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 22:11:21 INFO - Return code: 0 22:11:21 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')]} 22:11:21 INFO - https://queue.taskcluster.net/v1/task/cN-KpsgvRQKyhxA3iZAElA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 22:11:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cN-KpsgvRQKyhxA3iZAElA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 22:11:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cN-KpsgvRQKyhxA3iZAElA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 22:11:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cN-KpsgvRQKyhxA3iZAElA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 22:11:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cN-KpsgvRQKyhxA3iZAElA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 22:11:22 INFO - Downloaded 59144868 bytes. 22:11:22 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/cN-KpsgvRQKyhxA3iZAElA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 22:11:22 INFO - mkdir: /builds/slave/test/properties 22:11:22 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:11:22 INFO - Writing to file /builds/slave/test/properties/build_url 22:11:22 INFO - Contents: 22:11:22 INFO - build_url:https://queue.taskcluster.net/v1/task/cN-KpsgvRQKyhxA3iZAElA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 22:11:23 INFO - Running post-action listener: _resource_record_post_action 22:11:23 INFO - Running post-action listener: set_extra_try_arguments 22:11:23 INFO - ##### 22:11:23 INFO - ##### Finished download-and-extract step (success) 22:11:23 INFO - ##### 22:11:23 INFO - ##### 22:11:23 INFO - ##### Running populate-webroot step. 22:11:23 INFO - ##### 22:11:23 INFO - Running pre-action listener: _resource_record_pre_action 22:11:23 INFO - Running main action method: populate_webroot 22:11:23 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:11:23 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:11:23 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:11:23 INFO - '--tppagecycles', 22:11:23 INFO - '7'], 22:11:23 INFO - 'tests': ['tsvgm']}}, 22:11:23 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 22:11:23 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:11:23 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 22:11:23 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 22:11:23 INFO - 'tests': ['dromaeo_css', 'kraken']}, 22:11:23 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 22:11:23 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:11:23 INFO - 'talos_options': ['--disable-e10s'], 22:11:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:11:23 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:11:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:11:23 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:11:23 INFO - 'talos_options': ['--disable-e10s'], 22:11:23 INFO - 'tests': ['damp', 'tps']}, 22:11:23 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:11:23 INFO - 'tests': ['damp', 'tps']}, 22:11:23 INFO - 'g3': {'talos_options': ['--disable-e10s'], 22:11:23 INFO - 'tests': ['dromaeo_dom']}, 22:11:23 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:11:23 INFO - 'other': {'talos_options': ['--disable-e10s'], 22:11:23 INFO - 'tests': ['a11yr', 22:11:23 INFO - 'ts_paint', 22:11:23 INFO - 'tpaint', 22:11:23 INFO - 'sessionrestore', 22:11:23 INFO - 'sessionrestore_no_auto_restore', 22:11:23 INFO - 'tabpaint']}, 22:11:23 INFO - 'other-e10s': {'tests': ['a11yr', 22:11:23 INFO - 'ts_paint', 22:11:23 INFO - 'tpaint', 22:11:23 INFO - 'sessionrestore', 22:11:23 INFO - 'sessionrestore_no_auto_restore', 22:11:23 INFO - 'tabpaint']}, 22:11:23 INFO - 'other-e10s_l64': {'tests': ['a11yr', 22:11:23 INFO - 'ts_paint', 22:11:23 INFO - 'tpaint', 22:11:23 INFO - 'sessionrestore', 22:11:23 INFO - 'sessionrestore_no_auto_restore', 22:11:23 INFO - 'tabpaint']}, 22:11:23 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 22:11:23 INFO - 'ts_paint', 22:11:23 INFO - 'tpaint', 22:11:23 INFO - 'sessionrestore', 22:11:23 INFO - 'sessionrestore_no_auto_restore', 22:11:23 INFO - 'tabpaint']}, 22:11:23 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 22:11:23 INFO - 'tests': ['a11yr', 22:11:23 INFO - 'ts_paint', 22:11:23 INFO - 'tpaint', 22:11:23 INFO - 'sessionrestore', 22:11:23 INFO - 'sessionrestore_no_auto_restore', 22:11:23 INFO - 'tabpaint']}, 22:11:23 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 22:11:23 INFO - 'tests': ['a11yr', 22:11:23 INFO - 'ts_paint', 22:11:23 INFO - 'tpaint', 22:11:23 INFO - 'sessionrestore', 22:11:23 INFO - 'sessionrestore_no_auto_restore', 22:11:23 INFO - 'tabpaint']}, 22:11:23 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 22:11:23 INFO - 'tests': ['tsvgx', 22:11:23 INFO - 'tsvgr_opacity', 22:11:23 INFO - 'tart', 22:11:23 INFO - 'tscrollx', 22:11:23 INFO - 'cart']}, 22:11:23 INFO - 'svgr-e10s': {'tests': ['tsvgx', 22:11:23 INFO - 'tsvgr_opacity', 22:11:23 INFO - 'tart', 22:11:23 INFO - 'tscrollx', 22:11:23 INFO - 'cart']}, 22:11:23 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:11:23 INFO - 'talos_options': ['--disable-e10s'], 22:11:23 INFO - 'tests': ['tp5o']}, 22:11:23 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:11:23 INFO - 'tests': ['tp5o']}, 22:11:23 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:11:23 INFO - 'talos_options': ['--disable-e10s', 22:11:23 INFO - '--xperf_path', 22:11:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:11:23 INFO - 'tests': ['tp5n']}, 22:11:23 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:11:23 INFO - 'talos_options': ['--xperf_path', 22:11:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:11:23 INFO - 'tests': ['tp5n']}}, 22:11:23 INFO - 'talos.zip': {'path': '', 22:11:23 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:11:23 INFO - Running post-action listener: _resource_record_post_action 22:11:23 INFO - ##### 22:11:23 INFO - ##### Finished populate-webroot step (success) 22:11:23 INFO - ##### 22:11:23 INFO - ##### 22:11:23 INFO - ##### Running create-virtualenv step. 22:11:23 INFO - ##### 22:11:23 INFO - Running pre-action listener: _resource_record_pre_action 22:11:23 INFO - Running main action method: create_virtualenv 22:11:23 INFO - Creating virtualenv /builds/slave/test/build/venv 22:11:23 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 22:11:23 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:11:23 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:11:23 INFO - Using real prefix '/usr' 22:11:23 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:11:24 INFO - Installing distribute.............................................................................................................................................................................................done. 22:11:26 INFO - Installing pip.................done. 22:11:26 INFO - Return code: 0 22:11:26 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:11:26 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')]} 22:11:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:11:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:11:26 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')]} 22:11:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:11:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:11:26 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 0x7f2100bbcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfd18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109e020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11302e0>, '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 0x109c140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109c5d0>, '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': 'db0483c52d987ecb441a263b000001ad-1464930669.597156-1532903752', '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 22:11:26 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 22:11:26 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 22:11:26 INFO - Using env: {'DISPLAY': ':0', 22:11:26 INFO - 'HOME': '/home/cltbld', 22:11:26 INFO - 'LANG': 'en_US.UTF-8', 22:11:26 INFO - 'LANGUAGE': 'en_US:en', 22:11:26 INFO - 'LOGNAME': 'cltbld', 22:11:26 INFO - 'MAIL': '/var/mail/cltbld', 22:11:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:11:26 INFO - 'MOZ_NO_REMOTE': '1', 22:11:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:11:26 INFO - 'NO_EM_RESTART': '1', 22:11:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:11:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:11:26 INFO - 'PWD': '/builds/slave/test', 22:11:26 INFO - 'SHELL': '/bin/bash', 22:11:26 INFO - 'SHLVL': '1', 22:11:26 INFO - 'TERM': 'linux', 22:11:26 INFO - 'TMOUT': '86400', 22:11:26 INFO - 'USER': 'cltbld', 22:11:26 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1464930669.597156-1532903752', 22:11:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:11:26 INFO - '_': '/tools/buildbot/bin/python'} 22:11:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:11:26 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 22:11:26 INFO - Cleaning up... 22:11:26 INFO - Return code: 0 22:11:26 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 22:11:26 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')]} 22:11:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:11:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:11:26 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')]} 22:11:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:11:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:11:26 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 0x7f2100bbcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfd18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109e020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11302e0>, '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 0x109c140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109c5d0>, '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': 'db0483c52d987ecb441a263b000001ad-1464930669.597156-1532903752', '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 22:11:26 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 22:11:26 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 22:11:26 INFO - Using env: {'DISPLAY': ':0', 22:11:26 INFO - 'HOME': '/home/cltbld', 22:11:26 INFO - 'LANG': 'en_US.UTF-8', 22:11:26 INFO - 'LANGUAGE': 'en_US:en', 22:11:26 INFO - 'LOGNAME': 'cltbld', 22:11:26 INFO - 'MAIL': '/var/mail/cltbld', 22:11:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:11:26 INFO - 'MOZ_NO_REMOTE': '1', 22:11:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:11:26 INFO - 'NO_EM_RESTART': '1', 22:11:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:11:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:11:26 INFO - 'PWD': '/builds/slave/test', 22:11:26 INFO - 'SHELL': '/bin/bash', 22:11:26 INFO - 'SHLVL': '1', 22:11:26 INFO - 'TERM': 'linux', 22:11:26 INFO - 'TMOUT': '86400', 22:11:26 INFO - 'USER': 'cltbld', 22:11:26 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1464930669.597156-1532903752', 22:11:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:11:26 INFO - '_': '/tools/buildbot/bin/python'} 22:11:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:11:26 INFO - Downloading/unpacking psutil>=3.1.1 22:11:26 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 22:11:26 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 22:11:26 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 22:11:26 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 22:11:26 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 22:11:26 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 22:11:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:11:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:11:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:11:28 INFO - Installing collected packages: psutil 22:11:28 INFO - Running setup.py install for psutil 22:11:28 INFO - building 'psutil._psutil_linux' extension 22:11:28 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 22:11:28 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 22:11:28 INFO - building 'psutil._psutil_posix' extension 22:11:28 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 22:11:29 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 22:11:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:11:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:11:29 INFO - Successfully installed psutil 22:11:29 INFO - Cleaning up... 22:11:29 INFO - Return code: 0 22:11:29 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 22:11:29 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')]} 22:11:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:11:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:11:29 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')]} 22:11:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:11:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:11:29 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 0x7f2100bbcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfd18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109e020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11302e0>, '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 0x109c140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109c5d0>, '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': 'db0483c52d987ecb441a263b000001ad-1464930669.597156-1532903752', '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 22:11:29 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 22:11:29 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 22:11:29 INFO - Using env: {'DISPLAY': ':0', 22:11:29 INFO - 'HOME': '/home/cltbld', 22:11:29 INFO - 'LANG': 'en_US.UTF-8', 22:11:29 INFO - 'LANGUAGE': 'en_US:en', 22:11:29 INFO - 'LOGNAME': 'cltbld', 22:11:29 INFO - 'MAIL': '/var/mail/cltbld', 22:11:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:11:29 INFO - 'MOZ_NO_REMOTE': '1', 22:11:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:11:29 INFO - 'NO_EM_RESTART': '1', 22:11:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:11:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:11:29 INFO - 'PWD': '/builds/slave/test', 22:11:29 INFO - 'SHELL': '/bin/bash', 22:11:29 INFO - 'SHLVL': '1', 22:11:29 INFO - 'TERM': 'linux', 22:11:29 INFO - 'TMOUT': '86400', 22:11:29 INFO - 'USER': 'cltbld', 22:11:29 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1464930669.597156-1532903752', 22:11:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:11:29 INFO - '_': '/tools/buildbot/bin/python'} 22:11:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:11:29 INFO - Downloading/unpacking mozsystemmonitor==0.3 22:11:29 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 22:11:29 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 22:11:29 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 22:11:29 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 22:11:29 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 22:11:29 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 22:11:31 INFO - Downloading mozsystemmonitor-0.3.tar.gz 22:11:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:11:31 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 22:11:31 INFO - Installing collected packages: mozsystemmonitor 22:11:31 INFO - Running setup.py install for mozsystemmonitor 22:11:31 INFO - Successfully installed mozsystemmonitor 22:11:31 INFO - Cleaning up... 22:11:31 INFO - Return code: 0 22:11:31 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 22: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')]} 22:11:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:11:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22: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')]} 22:11:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:11:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:11:31 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 0x7f2100bbcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfd18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109e020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11302e0>, '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 0x109c140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109c5d0>, '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': 'db0483c52d987ecb441a263b000001ad-1464930669.597156-1532903752', '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 22:11:31 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 22:11:31 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 22:11:31 INFO - Using env: {'DISPLAY': ':0', 22:11:31 INFO - 'HOME': '/home/cltbld', 22:11:31 INFO - 'LANG': 'en_US.UTF-8', 22:11:31 INFO - 'LANGUAGE': 'en_US:en', 22:11:31 INFO - 'LOGNAME': 'cltbld', 22:11:31 INFO - 'MAIL': '/var/mail/cltbld', 22:11:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:11:31 INFO - 'MOZ_NO_REMOTE': '1', 22:11:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:11:31 INFO - 'NO_EM_RESTART': '1', 22:11:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:11:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:11:31 INFO - 'PWD': '/builds/slave/test', 22:11:31 INFO - 'SHELL': '/bin/bash', 22:11:31 INFO - 'SHLVL': '1', 22:11:31 INFO - 'TERM': 'linux', 22:11:31 INFO - 'TMOUT': '86400', 22:11:31 INFO - 'USER': 'cltbld', 22:11:31 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1464930669.597156-1532903752', 22:11:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:11:31 INFO - '_': '/tools/buildbot/bin/python'} 22:11:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:11:31 INFO - Downloading/unpacking jsonschema==2.5.1 22:11:31 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 22:11:31 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 22:11:31 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 22:11:31 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 22:11:31 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 22:11:31 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 22:11:33 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:11:33 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 22:11:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:11:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:11:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:11:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:11:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:11:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:11:33 INFO - Downloading functools32-3.2.3-2.tar.gz 22:11:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 22:11:34 INFO - warning: no files found matching '*.txt' 22:11:34 INFO - no previously-included directories found matching 'build' 22:11:34 INFO - no previously-included directories found matching 'dist' 22:11:34 INFO - no previously-included directories found matching '.git*' 22:11:34 INFO - Installing collected packages: jsonschema, functools32 22:11:34 INFO - Running setup.py install for functools32 22:11:34 INFO - warning: no files found matching '*.txt' 22:11:34 INFO - no previously-included directories found matching 'build' 22:11:34 INFO - no previously-included directories found matching 'dist' 22:11:34 INFO - no previously-included directories found matching '.git*' 22:11:34 INFO - Successfully installed jsonschema functools32 22:11:34 INFO - Cleaning up... 22:11:34 INFO - Return code: 0 22:11:34 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:11:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:11:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:11:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:11:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:11:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:11:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:11:34 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 0x7f2100bbcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfd18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109e020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11302e0>, '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 0x109c140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109c5d0>, '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': 'db0483c52d987ecb441a263b000001ad-1464930669.597156-1532903752', '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 22:11:34 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 22:11:34 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 22:11:34 INFO - Using env: {'DISPLAY': ':0', 22:11:34 INFO - 'HOME': '/home/cltbld', 22:11:34 INFO - 'LANG': 'en_US.UTF-8', 22:11:34 INFO - 'LANGUAGE': 'en_US:en', 22:11:34 INFO - 'LOGNAME': 'cltbld', 22:11:34 INFO - 'MAIL': '/var/mail/cltbld', 22:11:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:11:34 INFO - 'MOZ_NO_REMOTE': '1', 22:11:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:11:34 INFO - 'NO_EM_RESTART': '1', 22:11:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:11:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:11:34 INFO - 'PWD': '/builds/slave/test', 22:11:34 INFO - 'SHELL': '/bin/bash', 22:11:34 INFO - 'SHLVL': '1', 22:11:34 INFO - 'TERM': 'linux', 22:11:34 INFO - 'TMOUT': '86400', 22:11:34 INFO - 'USER': 'cltbld', 22:11:34 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1464930669.597156-1532903752', 22:11:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:11:34 INFO - '_': '/tools/buildbot/bin/python'} 22:11:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:11:34 INFO - Downloading/unpacking blobuploader==1.2.4 22:11:34 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 22:11:34 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 22:11:34 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 22:11:34 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 22:11:34 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 22:11:34 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 22:11:36 INFO - Downloading blobuploader-1.2.4.tar.gz 22:11:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:11:36 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22: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 22: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 22: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 22: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 22: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 22: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 22:11:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:11:36 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22: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 22: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 22: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 22: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 22: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 22: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 22:11:37 INFO - Downloading docopt-0.6.1.tar.gz 22:11:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:11:37 INFO - Installing collected packages: blobuploader, requests, docopt 22:11:37 INFO - Running setup.py install for blobuploader 22:11:37 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:11:37 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:11:37 INFO - Running setup.py install for requests 22:11:37 INFO - Running setup.py install for docopt 22:11:37 INFO - Successfully installed blobuploader requests docopt 22:11:37 INFO - Cleaning up... 22:11:37 INFO - Return code: 0 22:11:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:11:37 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')]} 22:11:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:11:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:11:37 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')]} 22:11:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:11:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:11:37 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 0x7f2100bbcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfd18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109e020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11302e0>, '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 0x109c140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109c5d0>, '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': 'db0483c52d987ecb441a263b000001ad-1464930669.597156-1532903752', '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 22:11:37 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 22:11:37 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 22:11:37 INFO - Using env: {'DISPLAY': ':0', 22:11:37 INFO - 'HOME': '/home/cltbld', 22:11:37 INFO - 'LANG': 'en_US.UTF-8', 22:11:37 INFO - 'LANGUAGE': 'en_US:en', 22:11:37 INFO - 'LOGNAME': 'cltbld', 22:11:37 INFO - 'MAIL': '/var/mail/cltbld', 22:11:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:11:37 INFO - 'MOZ_NO_REMOTE': '1', 22:11:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:11:37 INFO - 'NO_EM_RESTART': '1', 22:11:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:11:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:11:37 INFO - 'PWD': '/builds/slave/test', 22:11:37 INFO - 'SHELL': '/bin/bash', 22:11:37 INFO - 'SHLVL': '1', 22:11:37 INFO - 'TERM': 'linux', 22:11:37 INFO - 'TMOUT': '86400', 22:11:37 INFO - 'USER': 'cltbld', 22:11:37 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1464930669.597156-1532903752', 22:11:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:11:37 INFO - '_': '/tools/buildbot/bin/python'} 22:11:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:11:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:11:37 INFO - Running setup.py (path:/tmp/pip-TdP8ub-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:11:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:11:38 INFO - Running setup.py (path:/tmp/pip-yztFpX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:11:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:11:38 INFO - Running setup.py (path:/tmp/pip-4j7NI8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:11:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:11:38 INFO - Running setup.py (path:/tmp/pip-vPSVtl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:11:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:11:38 INFO - Running setup.py (path:/tmp/pip-IFc7Dc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:11:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:11:38 INFO - Running setup.py (path:/tmp/pip-Fup2mL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:11:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:11:38 INFO - Running setup.py (path:/tmp/pip-yOjKUz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:11:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:11:38 INFO - Running setup.py (path:/tmp/pip-qqDWGw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:11:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:11:38 INFO - Running setup.py (path:/tmp/pip-y2syXq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:11:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:11:38 INFO - Running setup.py (path:/tmp/pip-jvj4ml-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:11:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:11:38 INFO - Running setup.py (path:/tmp/pip-3R44zF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:11:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:11:38 INFO - Running setup.py (path:/tmp/pip-zHkjKz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:11:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:11:38 INFO - Running setup.py (path:/tmp/pip-R5dgE9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:11:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:11:38 INFO - Running setup.py (path:/tmp/pip-w8MJGQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:11:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:11:38 INFO - Running setup.py (path:/tmp/pip-ov59bs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:11:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:11:39 INFO - Running setup.py (path:/tmp/pip-mo6TzF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:11:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:11:39 INFO - Running setup.py (path:/tmp/pip-_evSk_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:11:39 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:11:39 INFO - Running setup.py install for manifestparser 22:11:39 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:11:39 INFO - Running setup.py install for mozcrash 22:11:39 INFO - Running setup.py install for mozdebug 22:11:39 INFO - Running setup.py install for mozdevice 22:11:39 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 22:11:39 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:11:39 INFO - Running setup.py install for mozfile 22:11:39 INFO - Running setup.py install for mozhttpd 22:11:39 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:11:39 INFO - Running setup.py install for mozinfo 22:11:39 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:11:39 INFO - Running setup.py install for mozInstall 22:11:39 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:11:39 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:11:39 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:11:39 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:11:39 INFO - Running setup.py install for mozleak 22:11:40 INFO - Running setup.py install for mozlog 22:11:40 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:11:40 INFO - Running setup.py install for moznetwork 22:11:40 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:11:40 INFO - Running setup.py install for mozprocess 22:11:40 INFO - Running setup.py install for mozprofile 22:11:40 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:11:40 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:11:40 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:11:40 INFO - Running setup.py install for mozrunner 22:11:40 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:11:40 INFO - Running setup.py install for mozscreenshot 22:11:40 INFO - Running setup.py install for moztest 22:11:40 INFO - Running setup.py install for mozversion 22:11:40 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:11:40 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:11:40 INFO - Cleaning up... 22:11:40 INFO - Return code: 0 22:11:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:11:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:11:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:11:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:11:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:11:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:11:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:11:40 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 0x7f2100bbcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfd18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109e020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11302e0>, '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 0x109c140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109c5d0>, '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': 'db0483c52d987ecb441a263b000001ad-1464930669.597156-1532903752', '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 22:11:40 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 22:11:40 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 22:11:40 INFO - Using env: {'DISPLAY': ':0', 22:11:40 INFO - 'HOME': '/home/cltbld', 22:11:40 INFO - 'LANG': 'en_US.UTF-8', 22:11:40 INFO - 'LANGUAGE': 'en_US:en', 22:11:40 INFO - 'LOGNAME': 'cltbld', 22:11:40 INFO - 'MAIL': '/var/mail/cltbld', 22:11:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:11:40 INFO - 'MOZ_NO_REMOTE': '1', 22:11:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:11:40 INFO - 'NO_EM_RESTART': '1', 22:11:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:11:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:11:40 INFO - 'PWD': '/builds/slave/test', 22:11:40 INFO - 'SHELL': '/bin/bash', 22:11:40 INFO - 'SHLVL': '1', 22:11:40 INFO - 'TERM': 'linux', 22:11:40 INFO - 'TMOUT': '86400', 22:11:40 INFO - 'USER': 'cltbld', 22:11:40 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1464930669.597156-1532903752', 22:11:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:11:40 INFO - '_': '/tools/buildbot/bin/python'} 22:11:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:11:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:11:41 INFO - Running setup.py (path:/tmp/pip-PF_5qN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:11:41 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)) 22:11:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:11:41 INFO - Running setup.py (path:/tmp/pip-wRBwF0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:11:41 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)) 22:11:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:11:41 INFO - Running setup.py (path:/tmp/pip-x2CBai-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:11:41 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)) 22:11:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:11:41 INFO - Running setup.py (path:/tmp/pip-X2tNYt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:11:41 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)) 22:11:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:11:41 INFO - Running setup.py (path:/tmp/pip-HxQXEr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:11:41 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)) 22:11:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:11:41 INFO - Running setup.py (path:/tmp/pip-dk9LkD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:11:41 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)) 22:11:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:11:41 INFO - Running setup.py (path:/tmp/pip-kB0pAI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:11:41 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)) 22:11:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:11:41 INFO - Running setup.py (path:/tmp/pip-Nis6Po-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:11:41 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)) 22:11:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:11:41 INFO - Running setup.py (path:/tmp/pip-n02fN8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:11:41 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)) 22:11:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:11:41 INFO - Running setup.py (path:/tmp/pip-vaSloU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:11:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:11:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:11:41 INFO - Running setup.py (path:/tmp/pip-XJ8T30-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:11:41 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)) 22:11:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:11:41 INFO - Running setup.py (path:/tmp/pip-JCFmnQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:11:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 22:11:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:11:42 INFO - Running setup.py (path:/tmp/pip-U1NQxI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:11:42 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)) 22:11:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:11:42 INFO - Running setup.py (path:/tmp/pip-A3W3g9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:11:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 22:11:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:11:42 INFO - Running setup.py (path:/tmp/pip-N_cQLB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:11:42 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)) 22:11:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:11:42 INFO - Running setup.py (path:/tmp/pip-oQ1c1V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:11:42 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)) 22:11:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:11:42 INFO - Running setup.py (path:/tmp/pip-gkpMnw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:11:42 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)) 22:11:42 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)) 22:11:42 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)) 22:11:42 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)) 22:11:42 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)) 22:11:42 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)) 22:11:42 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:11:42 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 22:11:42 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 22:11:42 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 22:11:42 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 22:11:42 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 22:11:42 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 22:11:44 INFO - Downloading blessings-1.6.tar.gz 22:11:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:11:44 INFO - Installing collected packages: blessings 22:11:44 INFO - Running setup.py install for blessings 22:11:44 INFO - Successfully installed blessings 22:11:44 INFO - Cleaning up... 22:11:44 INFO - Return code: 0 22:11:44 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:11:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:11:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:11:44 INFO - Reading from file tmpfile_stdout 22:11:44 INFO - Current package versions: 22:11:44 INFO - argparse == 1.2.1 22:11:44 INFO - blessings == 1.6 22:11:44 INFO - blobuploader == 1.2.4 22:11:44 INFO - docopt == 0.6.1 22:11:44 INFO - functools32 == 3.2.3-2 22:11:44 INFO - jsonschema == 2.5.1 22:11:44 INFO - manifestparser == 1.1 22:11:44 INFO - mozInstall == 1.12 22:11:44 INFO - mozcrash == 0.17 22:11:44 INFO - mozdebug == 0.1 22:11:44 INFO - mozdevice == 0.48 22:11:44 INFO - mozfile == 1.2 22:11:44 INFO - mozhttpd == 0.7 22:11:44 INFO - mozinfo == 0.9 22:11:44 INFO - mozleak == 0.1 22:11:44 INFO - mozlog == 3.2 22:11:44 INFO - moznetwork == 0.27 22:11:44 INFO - mozprocess == 0.22 22:11:44 INFO - mozprofile == 0.28 22:11:44 INFO - mozrunner == 6.11 22:11:44 INFO - mozscreenshot == 0.1 22:11:44 INFO - mozsystemmonitor == 0.3 22:11:44 INFO - moztest == 0.7 22:11:44 INFO - mozversion == 1.4 22:11:44 INFO - psutil == 3.1.1 22:11:44 INFO - requests == 1.2.3 22:11:44 INFO - wsgiref == 0.1.2 22:11:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22: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')]} 22:11:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:11:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22: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')]} 22:11:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:11:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:11:44 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 0x7f2100bbcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfd18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109e020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11302e0>, '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 0x109c140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109c5d0>, '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': 'db0483c52d987ecb441a263b000001ad-1464930669.597156-1532903752', '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 22:11:44 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 22:11:44 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 22:11:44 INFO - Using env: {'DISPLAY': ':0', 22:11:44 INFO - 'HOME': '/home/cltbld', 22:11:44 INFO - 'LANG': 'en_US.UTF-8', 22:11:44 INFO - 'LANGUAGE': 'en_US:en', 22:11:44 INFO - 'LOGNAME': 'cltbld', 22:11:44 INFO - 'MAIL': '/var/mail/cltbld', 22:11:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:11:44 INFO - 'MOZ_NO_REMOTE': '1', 22:11:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:11:44 INFO - 'NO_EM_RESTART': '1', 22:11:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:11:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:11:44 INFO - 'PWD': '/builds/slave/test', 22:11:44 INFO - 'SHELL': '/bin/bash', 22:11:44 INFO - 'SHLVL': '1', 22:11:44 INFO - 'TERM': 'linux', 22:11:44 INFO - 'TMOUT': '86400', 22:11:44 INFO - 'USER': 'cltbld', 22:11:44 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1464930669.597156-1532903752', 22:11:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:11:44 INFO - '_': '/tools/buildbot/bin/python'} 22:11:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:11:44 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)) 22:11:44 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)) 22:11:44 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)) 22:11:44 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)) 22:11:44 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)) 22:11:44 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)) 22:11:44 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)) 22:11:44 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)) 22:11:44 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)) 22:11:44 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)) 22:11:44 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)) 22:11:44 INFO - Cleaning up... 22:11:45 INFO - Return code: 0 22:11:45 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 22:11:45 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')]} 22:11:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:11:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:11:45 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')]} 22:11:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:11:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:11:45 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 0x7f2100bbcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfd18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109e020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11302e0>, '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 0x109c140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109c5d0>, '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': 'db0483c52d987ecb441a263b000001ad-1464930669.597156-1532903752', '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 22:11:45 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 22:11:45 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 22:11:45 INFO - Using env: {'DISPLAY': ':0', 22:11:45 INFO - 'HOME': '/home/cltbld', 22:11:45 INFO - 'LANG': 'en_US.UTF-8', 22:11:45 INFO - 'LANGUAGE': 'en_US:en', 22:11:45 INFO - 'LOGNAME': 'cltbld', 22:11:45 INFO - 'MAIL': '/var/mail/cltbld', 22:11:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:11:45 INFO - 'MOZ_NO_REMOTE': '1', 22:11:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:11:45 INFO - 'NO_EM_RESTART': '1', 22:11:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:11:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:11:45 INFO - 'PWD': '/builds/slave/test', 22:11:45 INFO - 'SHELL': '/bin/bash', 22:11:45 INFO - 'SHLVL': '1', 22:11:45 INFO - 'TERM': 'linux', 22:11:45 INFO - 'TMOUT': '86400', 22:11:45 INFO - 'USER': 'cltbld', 22:11:45 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1464930669.597156-1532903752', 22:11:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:11:45 INFO - '_': '/tools/buildbot/bin/python'} 22:11:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:11:45 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 22:11:45 INFO - Cleaning up... 22:11:45 INFO - Return code: 0 22:11:45 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 22:11:45 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')]} 22:11:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:11:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:11:45 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')]} 22:11:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:11:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:11:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2100bbcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfd18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109e020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11302e0>, '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 0x109c140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109c5d0>, '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': 'db0483c52d987ecb441a263b000001ad-1464930669.597156-1532903752', '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 22:11:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 22:11:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 22:11:45 INFO - Using env: {'DISPLAY': ':0', 22:11:45 INFO - 'HOME': '/home/cltbld', 22:11:45 INFO - 'LANG': 'en_US.UTF-8', 22:11:45 INFO - 'LANGUAGE': 'en_US:en', 22:11:45 INFO - 'LOGNAME': 'cltbld', 22:11:45 INFO - 'MAIL': '/var/mail/cltbld', 22:11:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:11:45 INFO - 'MOZ_NO_REMOTE': '1', 22:11:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:11:45 INFO - 'NO_EM_RESTART': '1', 22:11:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:11:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:11:45 INFO - 'PWD': '/builds/slave/test', 22:11:45 INFO - 'SHELL': '/bin/bash', 22:11:45 INFO - 'SHLVL': '1', 22:11:45 INFO - 'TERM': 'linux', 22:11:45 INFO - 'TMOUT': '86400', 22:11:45 INFO - 'USER': 'cltbld', 22:11:45 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1464930669.597156-1532903752', 22:11:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:11:45 INFO - '_': '/tools/buildbot/bin/python'} 22:11:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:11:45 INFO - Downloading/unpacking flake8 22:11:45 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 22:11:45 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 22:11:45 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 22:11:45 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 22:11:45 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 22:11:45 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 22:11:47 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 22:11:47 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 22: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 22: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 22: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 22: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 22: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 22: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 22:11:47 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 22:11:47 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 22: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 22: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 22: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 22: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 22: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 22: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 22:11:47 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 22: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 22: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 22: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 22: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 22: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 22: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 22:11:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 22:11:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:11:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:11:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:11:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:11:48 INFO - no previously-included directories found matching 'docs/_build' 22:11:48 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 22:11:48 INFO - Running setup.py install for pep8 22:11:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:11:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:11:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:11:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:11:48 INFO - no previously-included directories found matching 'docs/_build' 22:11:48 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 22:11:48 INFO - Successfully installed flake8 mccabe pyflakes pep8 22:11:48 INFO - Cleaning up... 22:11:48 INFO - Return code: 0 22:11:48 INFO - Running post-action listener: _resource_record_post_action 22:11:48 INFO - Running post-action listener: _start_resource_monitoring 22:11:48 INFO - Starting resource monitoring. 22:11:48 INFO - ##### 22:11:48 INFO - ##### Finished create-virtualenv step (success) 22:11:48 INFO - ##### 22:11:48 INFO - ##### 22:11:48 INFO - ##### Running install step. 22:11:48 INFO - ##### 22:11:48 INFO - Running pre-action listener: _resource_record_pre_action 22:11:48 INFO - Running main action method: install 22:11:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:11:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:11:48 INFO - Reading from file tmpfile_stdout 22:11:48 INFO - Detecting whether we're running mozinstall >=1.0... 22:11:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:11:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:11:48 INFO - Reading from file tmpfile_stdout 22:11:48 INFO - Output received: 22:11:48 INFO - Usage: mozinstall [options] installer 22:11:48 INFO - Options: 22:11:48 INFO - -h, --help show this help message and exit 22:11:48 INFO - -d DEST, --destination=DEST 22:11:48 INFO - Directory to install application into. [default: 22:11:48 INFO - "/builds/slave/test"] 22:11:48 INFO - --app=APP Application being installed. [default: firefox] 22:11:48 INFO - mkdir: /builds/slave/test/build/application 22:11:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 22:11:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 22:12:05 INFO - Reading from file tmpfile_stdout 22:12:05 INFO - Output received: 22:12:05 INFO - /builds/slave/test/build/application/firefox/firefox 22:12:05 INFO - Running post-action listener: _resource_record_post_action 22:12:05 INFO - ##### 22:12:05 INFO - ##### Finished install step (success) 22:12:05 INFO - ##### 22:12:05 INFO - ##### 22:12:05 INFO - ##### Running run-tests step. 22:12:05 INFO - ##### 22:12:05 INFO - Running pre-action listener: _resource_record_pre_action 22:12:05 INFO - Running main action method: run_tests 22:12:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:12:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:12:05 INFO - Python 2.7.3 22:12:05 INFO - Return code: 0 22:12:05 INFO - grabbing minidump binary from tooltool 22:12:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:12:05 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 0x11302e0>, '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 0x109c140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109c5d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:12:05 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 22:12:05 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 22:12:05 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 22:12:05 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:12:05 INFO - Return code: 0 22:12:05 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 22:12:05 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:12:05 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:12:05 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 22:12:05 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:12:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 22:12:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 22:12:06 INFO - Return code: 0 22:12:06 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/cN-KpsgvRQKyhxA3iZAElA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-031', '--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 22:12:06 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/cN-KpsgvRQKyhxA3iZAElA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-031 --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 22:12:06 INFO - Using env: {'DISPLAY': ':0', 22:12:06 INFO - 'HOME': '/home/cltbld', 22:12:06 INFO - 'LANG': 'en_US.UTF-8', 22:12:06 INFO - 'LANGUAGE': 'en_US:en', 22:12:06 INFO - 'LOGNAME': 'cltbld', 22:12:06 INFO - 'MAIL': '/var/mail/cltbld', 22:12:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:12:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 22:12:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:12:06 INFO - 'MOZ_NO_REMOTE': '1', 22:12:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:12:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:12:06 INFO - 'NO_EM_RESTART': '1', 22:12:06 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:12:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:12:06 INFO - 'PWD': '/builds/slave/test', 22:12:06 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:12:06 INFO - 'SHELL': '/bin/bash', 22:12:06 INFO - 'SHLVL': '1', 22:12:06 INFO - 'TERM': 'linux', 22:12:06 INFO - 'TMOUT': '86400', 22:12:06 INFO - 'USER': 'cltbld', 22:12:06 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1464930669.597156-1532903752', 22:12:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:12:06 INFO - '_': '/tools/buildbot/bin/python'} 22:12:06 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/cN-KpsgvRQKyhxA3iZAElA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-031', '--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 22:12:06 INFO - mozversion application_buildid: 20160602193138 22:12:06 INFO - mozversion application_changeset: c5c9bc65a408fa0c26ec742c0950b6fc484cb635 22:12:06 INFO - mozversion application_display_name: Nightly 22:12:06 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:12:06 INFO - mozversion application_name: Firefox 22:12:06 INFO - mozversion application_remotingname: firefox 22:12:06 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 22:12:06 INFO - mozversion application_vendor: Mozilla 22:12:06 INFO - mozversion application_version: 49.0a1 22:12:06 INFO - mozversion platform_buildid: 20160602193138 22:12:06 INFO - mozversion platform_changeset: c5c9bc65a408fa0c26ec742c0950b6fc484cb635 22:12:06 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 22:12:06 INFO - mozversion platform_version: 49.0a1 22:12:06 INFO - using testdate: 1464930726 22:12:06 INFO - actual date: 1464930726 22:12:06 INFO - starting webserver on 'localhost:54747' 22:12:06 INFO - SUITE-START | Running 2 tests 22:12:06 INFO - TEST-START | dromaeo_css 22:12:06 INFO - operating with platform_type : linux_ 22:12:06 INFO - Initialising browser for dromaeo_css test... 22:12:06 INFO - TEST-INFO | started process 10069 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKm276b/profile http://localhost:54747/getInfo.html) 22:12:11 INFO - PROCESS | 10069 | __metrics Screen width/height:1600/1200 22:12:11 INFO - PROCESS | 10069 | colorDepth:24 22:12:11 INFO - PROCESS | 10069 | Browser inner width/height: 1024/697 22:12:11 INFO - PROCESS | 10069 | __metrics 22:12:11 ERROR - PROCESS | 10069 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2938: TypeError: this.tabs is undefined 22:12:12 INFO - TEST-INFO | 10069: exit 0 22:12:12 INFO - Browser initialized. 22:12:12 INFO - Running cycle 1/1 for dromaeo_css test... 22:12:12 INFO - TEST-INFO | started process 10189 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKm276b/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:12:24 INFO - PROCESS | 10189 | RSS: Main: 167104512 22:12:24 INFO - PROCESS | 10189 | 22:13:13 INFO - PROCESS | 10189 | 1464930793964 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 22:15:22 INFO - PROCESS | 10189 | Cycle 1(1): loaded http://localhost:54747/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54747/tests/dromaeo/cssquery-ext.html) 22:15:23 INFO - PROCESS | 10189 | RSS: Main: 170336256 22:15:23 INFO - PROCESS | 10189 | 22:18:25 INFO - PROCESS | 10189 | Cycle 1(1): loaded http://localhost:54747/tests/dromaeo/cssquery-ext.html (next: http://localhost:54747/tests/dromaeo/cssquery-jquery.html) 22:18:25 INFO - PROCESS | 10189 | RSS: Main: 169996288 22:18:25 INFO - PROCESS | 10189 | 22:21:27 INFO - PROCESS | 10189 | Cycle 1(1): loaded http://localhost:54747/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54747/tests/dromaeo/cssquery-mootools.html) 22:21:28 INFO - PROCESS | 10189 | RSS: Main: 171892736 22:21:28 INFO - PROCESS | 10189 | 22:24:30 INFO - PROCESS | 10189 | Cycle 1(1): loaded http://localhost:54747/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54747/tests/dromaeo/cssquery-prototype.html) 22:24:30 INFO - PROCESS | 10189 | RSS: Main: 168456192 22:24:30 INFO - PROCESS | 10189 | 22:27:33 INFO - PROCESS | 10189 | Cycle 1(1): loaded http://localhost:54747/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54747/tests/dromaeo/cssquery-yui.html) 22:27:33 INFO - PROCESS | 10189 | RSS: Main: 170479616 22:27:33 INFO - PROCESS | 10189 | 22:30:36 INFO - PROCESS | 10189 | Cycle 1(1): loaded http://localhost:54747/tests/dromaeo/cssquery-yui.html (next: http://localhost:54747/tests/dromaeo/cssquery-dojo.html) 22:30:36 INFO - PROCESS | 10189 | RSS: Main: 171261952 22:30:36 INFO - PROCESS | 10189 | 22:30:36 INFO - PROCESS | 10189 | __start_tp_report 22:30:36 INFO - PROCESS | 10189 | _x_x_mozilla_page_load 22:30:36 INFO - PROCESS | 10189 | _x_x_mozilla_page_load_details 22:30:36 INFO - PROCESS | 10189 | |i|pagename|runs| 22:30:36 INFO - PROCESS | 10189 | |0;dojo.html;3159.083865678953;3196.728278096362;3234.8867789627366;3240.384326977874;3250.057483329833;5549.445055494449;5568.554515638749;5578.916316255254;5626.240457538231;5654.095344744842;5390.973045134779;5504.394516603181;5565.638233514819;5572.192032155335;5595.21666966624;4994.051130285252;5022.19644856823;5120.820771273006;5169;5231.084560201968;914.6191545509677;4926.630502712293;5009.323741294915;5097.7196254206;5152.072626927152;5030.496950304995;5032.320636714034;5032.5470707636305;5047.242913562958;5054.115529782292;5062.291279220912;5062.544371006627;5063.443021267658;5066.873328166826;5111.182210846247;4963.60291176705;5033.597312215051;5059.392872855281;5064.721440320781;5076.086304465195;5518.310211223597;5522.972385138049;5549.833504994856;5557.221988921554;5623.26897503326;5662.433756624346;5913.615614985012;5922.911156332659;5934.495567876736;5967.224260846106;6036.8188954331445;6113.658745237687;6115.541334399938;6119.816405507798;6134.110553969694;5640.351359593617;5641.097424412115;5644;5647.745851436654;5653.378128405872;5854.092615644582;6076.726547305382;6102.633841969496;6167.938320616737;6170.660613666201;5797.130430435468;5802.622829516068;5809.622374545641;5815.941840581625;5819.679917604572;5934.287885453773;5941.613795103391;5944.7027648617395;5956.493698035629;5966.522678185735;5818.5345172386105;5888.263967004124;5907.172995780594;5916.822495325147;5931.228940237827;5880.588358814842;5941.643501389931;5944.5838791284195;5945.227120474397;5964.1650168976375;4374.431323927869;4475.216837053503;4477.261251893467;4502.4371953505815;4555.886102847456;3918.45141680165;3973.443717879499;3990.940135897964;3998.3402738547816;4014.41790940312;5619.353774316006;5629.408912064257;5661.943380566142;5685.459881311269;5743.396943320975;5744.597878148573;6033.456988871023;6039;6041.033434650435;6050.757969681252;5525.640833345819;5605.32736071674;5609.943900561024;5611.6352437091455;5615.410381909841;5145;5164.664296820694;5200.089984252741;5203.037438073969;5205.817796377109;6273.247210334789;6308.085327627468;6313.210848643919;6318.4313411793155;6325.683715814283;5809.070548712186;5973.761049557969;6035.155078288955;6081.17904082952;6091.02543593023;6163.506919446523;6276.686165691788;6280.9685951569945;6297.685115744286;6299.779507717208;5857.150713146485;5887.293524777054;5905.202797622266;5928;5944.702764861653;5753.424657534213;5969.970150149222;5998.910016349845;6050.606710563799;6063.484603808549;5833.445822646841;5846.064629659234;5884.382139875252;5896.056630939029;5931.6441013539325;5822.534197264294;5834.329052159056;5835;5836.678982655994;5854.443827836349;5488.588355873405;5730.656160630376;5732.799352022659;5746.367899530965;5791.276090488689;5853.882922341614;5866.735996880236;5914.852128696817;5924.31870334917;5951.047832346977;5721.427857214412;5750.5112065474905;5768.221290125779;5770.192173095854;5772.163036359789 22:30:36 INFO - PROCESS | 10189 | |1;ext.html;568.7696482924415;619.6437048697;620.128719149595;620.3238470067625;626.8808926304002;32323.191920202007;35396.64603353969;38015.42976855349;38294.4255836162;38709;45780.771096144555;46191.30713039307;46345.304820427635;46429.767851160694;46454.76772616141;8752;8963.507007114606;9003.729888103368;9011.95494022529;9025.052369501207;8760.211580957712;8850.955745221265;8867.512286824222;8871.778205544848;8901.376903616718;8846.601902914384;8872.37893347466;8891.110888911122;8947.64209431622;8962.910370896305;8825.69110081144;8844.07137250586;8880.73357799267;8918.420302680304;8930.866037009417;8793.692220772242;8891.288696904232;8901.955490222572;8911.643534258621;8933.46399216049;42554.36168457475;42775.144497110196;42948;43001.139977200284;43269.35095973531;3366.545516355285;3464.4803279508023;3479.930401391958;3519.9264224411545;3892.4161375793856;33242.50136247958;33515.329693406;33733;35095.29809403798;35120.64879351225;4323.265044942367;4355.978220108879;4384.12317536494;4412.889677758049;4540.704854184468;380662.09668951755;381337;381658;382957;383241;60764.39235607676;60879;61306.38693613096;61318;61417.38582614206;36088.45867311992;36966.260674786354;63588.95904889028;64421.355786441534;64737;16438.178091095397;16496;16531.504054878373;16572.58568535796;16577.66844663124;11947.402629868471;11973.40132993347;11986;12057.0957178212;12065.638030859089;19950.800491995185;20016.799832001783;20113.798862011485;20196.394108176777;20312.492187695425;7050.92949070513;7235.348818606245;7268.600226987461;7289.562626242442;7367;990.1633120013577;1014.2798612984864;1026.5380578739598;1092.63396762084;1093.6336327330275;33134;33239.50140747891;33441;33476.49785253223;33567;1088.6407485529755;1120.1654767198327;1162.3026184289529;1171.5631486508044;1178.8997935175605;17072;17197.656046878994;17419.825801742074;17467;17583.560410989827;541429;546582;556391;560802;970807;59501;60148;60720.05319654297;60815;60881.391186087574;1380.806687063812;1384.1349156777014;1392.0951381601838;1395.4557722488441;1423.7294913966314;31533.52699709552;33645.66354336425;33719.325613487104;33720.32559348848;34081.31837363189;52507.73746131398;52735;53550.73224633852;53571.19643205277;53761.19358209708;488895;493616;493899;494141;494199;28186.577201341584;28199.71800282053;28520.85739571289;28625.856870715514;29166.56250156292;49565.50434495609;49922.75038624783;49975.500244997085;50209.74895125501;50991;41355.379669305585;41389.37915931203;42237.155256895305;42687;43382.34926476169;41813.58186418218;42134.57865421429;42668.359974599785;42846.143077138906;43129.784351078044;35117.47323790196;36774.44838327374;43528.34707479454;43895;44810.77594612006;41442.792786035876;42891;43601;46067.30899036584;47381.52618473771;34329.99233594434;34756.47865282073;35181.29637407186;35248.82375588106;35463.29073418466 22:30:36 INFO - PROCESS | 10189 | |2;jquery.html;384.3984164782115;385.3429902017063;396.65689178860293;398.1380311625331;412.0892826852656;17717.734233986484;18490.44528664139;18777.718334225;19273.132709028094;19293.614127717436;17667;18227.72658410125;18544.999999999967;18692.25230990762;18704.345347912826;5244.160934250521;5322.308099947001;5365.892682146355;5411.83764487066;5715.771369145229;5444.373897001856;5632.7183640818;5645.633033852807;5656.095024796013;5670.574706896979;5776.220210271602;5850.4734573888345;5877.67672777997;5897.498712609412;5902.3507414184405;5540.113581826889;5558.416366281563;5755.68343741094;5839.649621022731;5857.589968702193;5349.946500535023;5391.757370918318;5392.083345831218;5400.216968539579;5409.350877894639;12101.455434505468;12740.305311459666;21328.680069798964;21776.564468710538;21846.344609661737;2125.7130287411155;2164.945876353104;2298.6322188449767;2477.996411453364;2856.4715527627454;9380.765480863032;9776.120149186536;13708.794368084487;14630.487932922402;15255.648808900396;1993.4019794061724;1993.820556149939;2000.5398758285676;2032.5223572460459;2047.5802460495563;92823.53588232084;96083.51958240234;96385;96422;99319.50340248324;14924.776128358084;17585.12074396275;17596.824031759774;18108.547286317684;18327;31126.533102003486;31197.532037019464;31340.84329578383;31439;31485.527717084264;9642.469664168399;10012.349197302152;10021.699349019542;10078.244131690006;10098.899011009942;8325.25072743456;8404.28563572091;8429.4942303462;8434.536100514531;8443.83112337762;8606.698765543177;8765.780855478664;8781.91218087811;8819.426737262058;8870.290376769843;3518.7712798668517;3532.064003039145;3552.312651490521;3565.7682250653625;3713.294474049922;869.426178722053;1020.5152552537634;1053.8577292065627;1076.311160857052;1079.6005477973201;17960.640787184184;18934.43196704101;18978.335758248395;19094;19112;975.5268694683073;1004.7237009822211;1022.3712416863575;1024.2215915903819;1066.919981001428;8942.552872356357;10377.584896604052;10616.575336986434;10624.203184761174;10626.574937002588;408226;416652;425098;432319;432816;85771;87012.5649371749;89579.55210224037;90243.09756902346;90966;1006.6124542051217;1023.1916785739331;1035.803197392493;1039.5010395010286;1040.6461802987021;16193.838061619233;16290.918545407198;16536.586585335463;16611.750823737897;16910.32358705638;38679;41431.37852932148;43207;43818.56181438145;44276;48848.75575622241;59287.70356148192;59692;59904.10143847933;60402.69798651154;7852.1755215703815;8235.38234632393;8261.793455163668;8316.168383161636;8364.87452688198;12551.435185416496;12625;12813.871861281268;12831.935840320739;12904.870951290366;10852.294600850919;11355.091592672732;11398.658040258806;11901.821472677744;12018.75962480728;10922.672319830417;11049;11137;11194.160437967348;11333.829992550283;11506.94246528762;11682.415879205835;11835.467403967014;11932.403379831147;12388.946939509882;6756.560823546453;7105.75129870452;7648.311651951129;8217.95891020541;8380.036295826058;11485;11495.597654082067;11510.251833630788;11628.88371116278;11631.185816992729 22:30:36 INFO - PROCESS | 10189 | |3;mootools.html;1475.6310922269436;1516.962075948101;1655.5778276539481;1802.5289211729896;1822.2255541394904;7792.92207077929;8378.581070946451;8442.831143377129;8905.332100092495;8918.019017908025;8423.115572864854;8639.092895246004;8658.26404755595;8685.435446695961;8734.257588105018;2271.681964524964;2309.769023097685;2317.582835089683;2320.5938960681897;2323.372689373868;2288.7139107611547;2291.51878105598;2336.0655737704883;2338.9766102339013;2352.764723527651;2265.569541787055;2274.2608652188023;2280.293109136173;2327.627579587266;2332.3469428559947;2216.7007453993747;2251.3020963501367;2258.954820903573;2284.0635339510804;2289.473421113153;2277.6241920083166;2299.7010388649537;2309.452666713306;2311.711036120485;2314.3982564533176;8585.141485851427;8645.962484501837;8647.481151130889;8651.870221946676;8667.869981950276;4946;5023.547880690755;5049.141645920203;5058.165402708549;5076.949230507685;3060.8010479318773;3072.4316001539787;3138.4978403455566;3245.204924793417;3257.38109759145;1082.8213344798098;1093.6609651008214;1094.4254266510065;1096.9177311701574;1149.8907603777627;11864.703382415422;11922.940385298105;11951.641450756491;11959.162858599902;11995.280283183038;4399.802008909607;4429.247028005247;4522;4529.139463501924;4560.270356742905;9865.506724663737;9927.354721943051;9968.950155249177;10040.598376065022;10082.798344033225;5135.948640513622;5191.195364718475;5192.714400707997;5200.869978250574;5203.687778733212;4089.1821635672986;4580;4726.550977657117;4729.219678753036;4800.255960326155;3951.0912490126857;3953.7545673112877;4071.776052317092;4104.938425923614;4121.752694838259;1279.3858947704969;1295.481807277078;1304.2696090189525;1308.6335825968745;1311.8032295155613;918.2653876898454;1016.3698506925754;1021.8160731068479;1033.509083185496;1049.239301506417;6198.2252218472695;6269.686515674198;6273.247210334698;6335.746570137143;6353.809385718436;425.41930265187796;429.79155109771733;430.3845500933695;432.68197874562173;433.7029135042506;4316.956830431718;4414.955850441519;4415.867523974286;4421.5578442156175;4425.291953287458;10054.095131438205;10438.530266138043;10495.685129446128;10497.370157790558;10548.683539493828;10239.539220735085;10477.476126193813;10478.842817357745;10548.41983690889;10580.682579522627;8085.555294458862;8175.223353781381;8178.141295163922;8249.422540422232;8251.2986396157;5993.820185394445;6261.279952805304;6270.122182894307;6339.080833279241;6347.42873141401;9803.950980245054;10087.142592879394;10146.137578305927;10204.2346823987;10204.234682398997;9975.750606234902;10150.23873209527;10157.238207134347;10244.385336879812;10350.981558596002;7177.533460325062;7463;7648.73229436967;7732.7680169595005;7837.804054898673;8622.741317760478;8708.91291087081;8726.91273087261;8736.825263494822;8756.387052906235;7552.433567482351;7793.961030194812;7874.763757087297;7901.68393264286;7926.524408535506;7518.812029699301;7539.208383119693;7634.427417943787;7734.110577283459;7795.532268063935;6926.168859736864;6996.440284777307;7002.719891204499;7010.228874823663;7041.260667629826;5284;5294.205869119663;5410.48600382963;5423.972880135574;5463;5072.767982087869;5191.6884986900905;5210.609204309768;5267.183586544092;5281.392639846466 22:30:36 INFO - PROCESS | 10189 | |4;prototype.html;321.8809040654958;338.6833310854351;340.3465346534653;341.6446895228961;347.95998460177054;5534.584906132036;5615.073512870372;5636.239107720462;5771.210924613368;5786.161006654038;5610.915836262459;5648.406917273689;5651.660900345983;5661.688607126606;5680.346760122577;4387.648988080954;4396.450443694538;4398.9560104399025;4407.2507673695545;4408.448943882015;4141.689373296999;4317.913641727164;4332.328489084197;4415.580519850609;4472.837062363777;4254.468191476066;4284.2930916398755;4290.828366865321;4301.913961720764;4302.397664326997;4287.121140166274;4299.097189590158;4301.870943871673;4333.696641235115;4350.71720338177;3564.1267889367014;3766.8681596144;3768.5100936878302;3773.1887644156636;3774.8112594370446;5457.208704737791;5506.779728810843;5512.39363669996;5535.280413546213;5546.528545073674;4912.926306105412;4925.975370123162;4941.258811178316;4953;4995.450500444948;5581.386047534768;5859.355470898197;5883;5962.880742385128;5966.820995370146;4113.753174809521;4126.154138401621;4131.338985762263;4143.274926887782;4158.521769996429;6108.831364865498;6123.326434092246;6124.724387402578;6136.631802091889;6171.691415429211;4096.877093687194;4194.448054219958;4196.412502249626;4203.936940945889;4206.810693518799;4226.774235471678;4237.87286381409;4244.596763307481;4252.829886804555;4323.978380108079;4890.682105663121;4954.578860796801;4988.226824842155;4992.525710057539;5022.121128802445;5864.563182020433;5977.850553736192;5991.760329586855;5999.850003749854;6034.849128771816;1465.479754687092;1476.948306809278;1478.4825311141014;1486.4797320937585;1486.7398205314028;923.4044041593135;929.2796612246261;951.6478902806006;955.0544960489066;955.5126885288553;5018.924716129261;5035.949640503622;5133.79464821403;5181.455947125498;5190.506901844319;5409.459054094559;5442.891142177214;5461.6996065216;5484.890302193934;5565.7217139143695;4894.877628059327;4981.850544483671;5123.97438012815;5145.151050076695;5149.304843846033;2873.913782586526;2914.781391395654;2926.97073029267;2927.9121626351243;2928.546075358323;5555.30558680165;5559.610827242054;5584;5600.60795744294;5623.690697011703;5289.7619607117;5436.673799572039;5527.44725527444;5578.163275508625;5601.60788744784;5580.804671836466;5612.635178713453;5618.494335509824;5623.044082505902;5648.491635752802;5203.375594928632;5331.600129990189;5368.2752828367675;5429.592780541396;5500;5385.488378604026;5404.6488377905525;5426.457354264542;5467.5625949923115;5500.4499550044675;5494.890102198014;5549.417311182267;5621.971890140523;5750.884982300414;6020.668863212565;4134.669226461816;4188.560201178832;4202.2435961526;4214.093969796509;4225.852095176654;5968.16445697594;5985.880282394415;5994.220751302303;6028.758849645965;6119.2350956130485;5738.741756621045;5854.594897224721;5902.232709747877;5916.763329466773;5933.347331793586;5882;5883.352321560488;5893.793717219876;5917.585768996301;5936.257967754031;5785.784985153165;5792.768289268382;5824.883502330014;5836.620619659709;5870.383609721089;5663.235463212413;5981.312149102909;6018.548608854266;6030.3416560444475;6057.212562366864;5873.618214816023;5893.116032595145;5914.408559144051;5947.821565353046;5974.133750606051 22:30:36 INFO - PROCESS | 10189 | |5;yui.html;764.0487592946782;778.2140038561055;795.4754231859733;814.4136221920218;841.7685136587442;15255.923720381397;15977;16055.75916361254;16085.356585736587;16085.919570402131;13653.453861845514;13693;13718.51985180519;13744.381502832372;13754.381052852621;633.4868756307383;756.8864670299458;771.6103367799282;781.1914668318292;797.3820289275828;791.4103992525547;791.4183075439547;792.5126047480816;793.3494534481728;793.9126696063429;844.5988155626059;845.1421806866036;848.7708318753963;850.7873031742065;853.6116067189414;836.6611522333465;837.7570504553672;838.8573942429771;840.0507426607955;840.3319361107904;613.9140520327157;614.3181069013392;614.8063360041573;615.2002396884033;615.4460985113388;15018.924905375403;15109.848901510954;15141.318640661086;15179.089254644756;15189.316480758393;15062.623434414118;15094.698106037928;15226.390944362212;15260.196205368215;15587.376504939788;12504.81242781359;12553.435095420728;12624.684382890502;12631.115821892472;13148.342582870913;3733.869314574004;3813.8855834325013;3847.8653247136217;3895.14306852492;3961.088949541622;77252.61373693151;77517.61241193814;77762;77828.61085694535;78429;11185;11878.346690931909;11913.880861191277;11953;12097.092718046182;22687.432814179447;22716.545669086856;22785.658215126787;22798.65802012971;22887.313380598607;8314.667413303521;8371.204735550113;8465.661373545112;8469.11074337198;8724.258438032712;4517.141743068806;4596.839110631178;4662.487126416091;4662.860114196579;4860.1008813369635;3605;3681.7975011374097;3723.422869455239;3723.497327860704;3726.7763934164036;593.489598944907;598.4494265275956;601.9367966363557;612.1735656863199;617.3517806303364;718.5652680128552;736.443984791479;741.403170447784;748.1172216784138;777.4635501503944;9332.34673572857;9609.567569459392;9831.213502919749;9857.802843943082;9896.752581185385;653.7973228299243;666.5600703535644;767.1145647296426;770.6917233106802;771.7954741993376;4390.6501693123;4664.603508701731;4678.719276843332;4713.34013238147;4737.928931066037;109826.45086774675;116562;118334;119436.0563943616;119506;58460.12309815356;61280.38719612747;63557.682211588646;92119;100328.99999999854;87603.56198219095;87734.1226587726;89080;89374.55312723394;90724;8871.13706121696;8938.955305223431;8942.46345219289;8953;9006.324525660471;53684.73157634187;53785;55055.174172388244;55547.72226138844;55802.72098639643;70380.64809676123;77414.22585774296;77855;77953.61023194848;78598.6070069669;11525.069117537107;11547.942260288644;11920.880791191978;12571.497140114294;12919;11000.504977275881;11077.279976801483;11358.886411135783;11536.826947595624;11785.764284714429;11121.555137794721;11156.274842135235;11226.55093796239;11493.425328733698;11713.414329283672;10725.410102444128;11020.889791102307;11055.889441105486;11088.223824332543;11151.442427878736;11559.534680589073;11593.188476806543;11674.824877626672;11680.532778689098;11726.355050472306;9406.176243082922;9426.151646351862;9442.575084121368;9633.566489507848;9712.82858366626;9484.383515071775;9485.857712134186;9539.33224674266;9552.522373881138;9573.856392153984 22:30:36 INFO - PROCESS | 10189 | __end_tp_report 22:30:36 INFO - PROCESS | 10189 | __start_cc_report 22:30:36 INFO - PROCESS | 10189 | _x_x_mozilla_cycle_collect,337 22:30:36 INFO - PROCESS | 10189 | __end_cc_report 22:30:36 INFO - PROCESS | 10189 | __startTimestamp1464931836640__endTimestamp 22:30:36 INFO - PROCESS | 10189 | 22:30:36 INFO - PROCESS | 10189 | ------- Summary: start ------- 22:30:36 INFO - PROCESS | 10189 | Number of tests: 6 22:30:36 INFO - PROCESS | 10189 | 22:30:36 INFO - PROCESS | 10189 | [#0] dojo.html Cycles:165 Average:5516.86 Median:5753.42 stddev:742.56 (12.9%) stddev-sans-first:721.44 22:30:36 INFO - PROCESS | 10189 | Values: 3159.1 3196.7 3234.9 3240.4 3250.1 5549.4 5568.6 5578.9 5626.2 5654.1 5391.0 5504.4 5565.6 5572.2 5595.2 4994.1 5022.2 5120.8 5169.0 5231.1 914.6 4926.6 5009.3 5097.7 5152.1 5030.5 5032.3 5032.5 5047.2 5054.1 5062.3 5062.5 5063.4 5066.9 5111.2 4963.6 5033.6 5059.4 5064.7 5076.1 5518.3 5523.0 5549.8 5557.2 5623.3 5662.4 5913.6 5922.9 5934.5 5967.2 6036.8 6113.7 6115.5 6119.8 6134.1 5640.4 5641.1 5644.0 5647.7 5653.4 5854.1 6076.7 6102.6 6167.9 6170.7 5797.1 5802.6 5809.6 5815.9 5819.7 5934.3 5941.6 5944.7 5956.5 5966.5 5818.5 5888.3 5907.2 5916.8 5931.2 5880.6 5941.6 5944.6 5945.2 5964.2 4374.4 4475.2 4477.3 4502.4 4555.9 3918.5 3973.4 3990.9 3998.3 4014.4 5619.4 5629.4 5661.9 5685.5 5743.4 5744.6 6033.5 6039.0 6041.0 6050.8 5525.6 5605.3 5609.9 5611.6 5615.4 5145.0 5164.7 5200.1 5203.0 5205.8 6273.2 6308.1 6313.2 6318.4 6325.7 5809.1 5973.8 6035.2 6081.2 6091.0 6163.5 6276.7 6281.0 6297.7 6299.8 5857.2 5887.3 5905.2 5928.0 5944.7 5753.4 5970.0 5998.9 6050.6 6063.5 5833.4 5846.1 5884.4 5896.1 5931.6 5822.5 5834.3 5835.0 5836.7 5854.4 5488.6 5730.7 5732.8 5746.4 5791.3 5853.9 5866.7 5914.9 5924.3 5951.0 5721.4 5750.5 5768.2 5770.2 5772.2 22:30:36 INFO - PROCESS | 10189 | 22:30:36 INFO - PROCESS | 10189 | [#1] ext.html Cycles:180 Average:66054.47 Median:42974.57 stddev:139718.66 (325.1%) stddev-sans-first:140024.10 22:30:36 INFO - PROCESS | 10189 | Values: 568.8 619.6 620.1 620.3 626.9 32323.2 35396.6 38015.4 38294.4 38709.0 45780.8 46191.3 46345.3 46429.8 46454.8 8752.0 8963.5 9003.7 9012.0 9025.1 8760.2 8851.0 8867.5 8871.8 8901.4 8846.6 8872.4 8891.1 8947.6 8962.9 8825.7 8844.1 8880.7 8918.4 8930.9 8793.7 8891.3 8902.0 8911.6 8933.5 42554.4 42775.1 42948.0 43001.1 43269.4 3366.5 3464.5 3479.9 3519.9 3892.4 33242.5 33515.3 33733.0 35095.3 35120.6 4323.3 4356.0 4384.1 4412.9 4540.7 380662.1 381337.0 381658.0 382957.0 383241.0 60764.4 60879.0 61306.4 61318.0 61417.4 36088.5 36966.3 63589.0 64421.4 64737.0 16438.2 16496.0 16531.5 16572.6 16577.7 11947.4 11973.4 11986.0 12057.1 12065.6 19950.8 20016.8 20113.8 20196.4 20312.5 7050.9 7235.3 7268.6 7289.6 7367.0 990.2 1014.3 1026.5 1092.6 1093.6 33134.0 33239.5 33441.0 33476.5 33567.0 1088.6 1120.2 1162.3 1171.6 1178.9 17072.0 17197.7 17419.8 17467.0 17583.6 541429.0 546582.0 556391.0 560802.0 970807.0 59501.0 60148.0 60720.1 60815.0 60881.4 1380.8 1384.1 1392.1 1395.5 1423.7 31533.5 33645.7 33719.3 33720.3 34081.3 52507.7 52735.0 53550.7 53571.2 53761.2 488895.0 493616.0 493899.0 494141.0 494199.0 28186.6 28199.7 28520.9 28625.9 29166.6 49565.5 49922.8 49975.5 50209.7 50991.0 41355.4 41389.4 42237.2 42687.0 43382.3 41813.6 42134.6 42668.4 42846.1 43129.8 35117.5 36774.4 43528.3 43895.0 44810.8 41442.8 42891.0 43601.0 46067.3 47381.5 34330.0 34756.5 35181.3 35248.8 35463.3 22:30:36 INFO - PROCESS | 10189 | 22:30:36 INFO - PROCESS | 10189 | [#2] jquery.html Cycles:180 Average:28078.33 Median:31269.19 stddev:70389.72 (225.1%) stddev-sans-first:70556.47 22:30:36 INFO - PROCESS | 10189 | Values: 384.4 385.3 396.7 398.1 412.1 17717.7 18490.4 18777.7 19273.1 19293.6 17667.0 18227.7 18545.0 18692.3 18704.3 5244.2 5322.3 5365.9 5411.8 5715.8 5444.4 5632.7 5645.6 5656.1 5670.6 5776.2 5850.5 5877.7 5897.5 5902.4 5540.1 5558.4 5755.7 5839.6 5857.6 5349.9 5391.8 5392.1 5400.2 5409.4 12101.5 12740.3 21328.7 21776.6 21846.3 2125.7 2164.9 2298.6 2478.0 2856.5 9380.8 9776.1 13708.8 14630.5 15255.6 1993.4 1993.8 2000.5 2032.5 2047.6 92823.5 96083.5 96385.0 96422.0 99319.5 14924.8 17585.1 17596.8 18108.5 18327.0 31126.5 31197.5 31340.8 31439.0 31485.5 9642.5 10012.3 10021.7 10078.2 10098.9 8325.3 8404.3 8429.5 8434.5 8443.8 8606.7 8765.8 8781.9 8819.4 8870.3 3518.8 3532.1 3552.3 3565.8 3713.3 869.4 1020.5 1053.9 1076.3 1079.6 17960.6 18934.4 18978.3 19094.0 19112.0 975.5 1004.7 1022.4 1024.2 1066.9 8942.6 10377.6 10616.6 10624.2 10626.6 408226.0 416652.0 425098.0 432319.0 432816.0 85771.0 87012.6 89579.6 90243.1 90966.0 1006.6 1023.2 1035.8 1039.5 1040.6 16193.8 16290.9 16536.6 16611.8 16910.3 38679.0 41431.4 43207.0 43818.6 44276.0 48848.8 59287.7 59692.0 59904.1 60402.7 7852.2 8235.4 8261.8 8316.2 8364.9 12551.4 12625.0 12813.9 12831.9 12904.9 10852.3 11355.1 11398.7 11901.8 12018.8 10922.7 11049.0 11137.0 11194.2 11333.8 11506.9 11682.4 11835.5 11932.4 12388.9 6756.6 7105.8 7648.3 8218.0 8380.0 11485.0 11495.6 11510.3 11628.9 11631.2 22:30:36 INFO - PROCESS | 10189 | 22:30:36 INFO - PROCESS | 10189 | [#3] mootools.html Cycles:180 Average:5741.79 Median:4427.27 stddev:3237.89 (73.1%) stddev-sans-first:3231.10 22:30:36 INFO - PROCESS | 10189 | Values: 1475.6 1517.0 1655.6 1802.5 1822.2 7792.9 8378.6 8442.8 8905.3 8918.0 8423.1 8639.1 8658.3 8685.4 8734.3 2271.7 2309.8 2317.6 2320.6 2323.4 2288.7 2291.5 2336.1 2339.0 2352.8 2265.6 2274.3 2280.3 2327.6 2332.3 2216.7 2251.3 2259.0 2284.1 2289.5 2277.6 2299.7 2309.5 2311.7 2314.4 8585.1 8646.0 8647.5 8651.9 8667.9 4946.0 5023.5 5049.1 5058.2 5076.9 3060.8 3072.4 3138.5 3245.2 3257.4 1082.8 1093.7 1094.4 1096.9 1149.9 11864.7 11922.9 11951.6 11959.2 11995.3 4399.8 4429.2 4522.0 4529.1 4560.3 9865.5 9927.4 9969.0 10040.6 10082.8 5135.9 5191.2 5192.7 5200.9 5203.7 4089.2 4580.0 4726.6 4729.2 4800.3 3951.1 3953.8 4071.8 4104.9 4121.8 1279.4 1295.5 1304.3 1308.6 1311.8 918.3 1016.4 1021.8 1033.5 1049.2 6198.2 6269.7 6273.2 6335.7 6353.8 425.4 429.8 430.4 432.7 433.7 4317.0 4415.0 4415.9 4421.6 4425.3 10054.1 10438.5 10495.7 10497.4 10548.7 10239.5 10477.5 10478.8 10548.4 10580.7 8085.6 8175.2 8178.1 8249.4 8251.3 5993.8 6261.3 6270.1 6339.1 6347.4 9804.0 10087.1 10146.1 10204.2 10204.2 9975.8 10150.2 10157.2 10244.4 10351.0 7177.5 7463.0 7648.7 7732.8 7837.8 8622.7 8708.9 8726.9 8736.8 8756.4 7552.4 7794.0 7874.8 7901.7 7926.5 7518.8 7539.2 7634.4 7734.1 7795.5 6926.2 6996.4 7002.7 7010.2 7041.3 5284.0 5294.2 5410.5 5424.0 5463.0 5072.8 5191.7 5210.6 5267.2 5281.4 22:30:36 INFO - PROCESS | 10189 | 22:30:36 INFO - PROCESS | 10189 | [#4] prototype.html Cycles:180 Average:4792.12 Median:5450.05 stddev:1405.31 (25.8%) stddev-sans-first:1368.61 22:30:36 INFO - PROCESS | 10189 | Values: 321.9 338.7 340.3 341.6 348.0 5534.6 5615.1 5636.2 5771.2 5786.2 5610.9 5648.4 5651.7 5661.7 5680.3 4387.6 4396.5 4399.0 4407.3 4408.4 4141.7 4317.9 4332.3 4415.6 4472.8 4254.5 4284.3 4290.8 4301.9 4302.4 4287.1 4299.1 4301.9 4333.7 4350.7 3564.1 3766.9 3768.5 3773.2 3774.8 5457.2 5506.8 5512.4 5535.3 5546.5 4912.9 4926.0 4941.3 4953.0 4995.5 5581.4 5859.4 5883.0 5962.9 5966.8 4113.8 4126.2 4131.3 4143.3 4158.5 6108.8 6123.3 6124.7 6136.6 6171.7 4096.9 4194.4 4196.4 4203.9 4206.8 4226.8 4237.9 4244.6 4252.8 4324.0 4890.7 4954.6 4988.2 4992.5 5022.1 5864.6 5977.9 5991.8 5999.9 6034.8 1465.5 1476.9 1478.5 1486.5 1486.7 923.4 929.3 951.6 955.1 955.5 5018.9 5035.9 5133.8 5181.5 5190.5 5409.5 5442.9 5461.7 5484.9 5565.7 4894.9 4981.9 5124.0 5145.2 5149.3 2873.9 2914.8 2927.0 2927.9 2928.5 5555.3 5559.6 5584.0 5600.6 5623.7 5289.8 5436.7 5527.4 5578.2 5601.6 5580.8 5612.6 5618.5 5623.0 5648.5 5203.4 5331.6 5368.3 5429.6 5500.0 5385.5 5404.6 5426.5 5467.6 5500.4 5494.9 5549.4 5622.0 5750.9 6020.7 4134.7 4188.6 4202.2 4214.1 4225.9 5968.2 5985.9 5994.2 6028.8 6119.2 5738.7 5854.6 5902.2 5916.8 5933.3 5882.0 5883.4 5893.8 5917.6 5936.3 5785.8 5792.8 5824.9 5836.6 5870.4 5663.2 5981.3 6018.5 6030.3 6057.2 5873.6 5893.1 5914.4 5947.8 5974.1 22:30:36 INFO - PROCESS | 10189 | 22:30:36 INFO - PROCESS | 10189 | [#5] yui.html Cycles:180 Average:20116.14 Median:57131.42 stddev:29291.75 (51.3%) stddev-sans-first:29337.88 22:30:36 INFO - PROCESS | 10189 | Values: 764.0 778.2 795.5 814.4 841.8 15255.9 15977.0 16055.8 16085.4 16085.9 13653.5 13693.0 13718.5 13744.4 13754.4 633.5 756.9 771.6 781.2 797.4 791.4 791.4 792.5 793.3 793.9 844.6 845.1 848.8 850.8 853.6 836.7 837.8 838.9 840.1 840.3 613.9 614.3 614.8 615.2 615.4 15018.9 15109.8 15141.3 15179.1 15189.3 15062.6 15094.7 15226.4 15260.2 15587.4 12504.8 12553.4 12624.7 12631.1 13148.3 3733.9 3813.9 3847.9 3895.1 3961.1 77252.6 77517.6 77762.0 77828.6 78429.0 11185.0 11878.3 11913.9 11953.0 12097.1 22687.4 22716.5 22785.7 22798.7 22887.3 8314.7 8371.2 8465.7 8469.1 8724.3 4517.1 4596.8 4662.5 4662.9 4860.1 3605.0 3681.8 3723.4 3723.5 3726.8 593.5 598.4 601.9 612.2 617.4 718.6 736.4 741.4 748.1 777.5 9332.3 9609.6 9831.2 9857.8 9896.8 653.8 666.6 767.1 770.7 771.8 4390.7 4664.6 4678.7 4713.3 4737.9 109826.5 116562.0 118334.0 119436.1 119506.0 58460.1 61280.4 63557.7 92119.0 100329.0 87603.6 87734.1 89080.0 89374.6 90724.0 8871.1 8939.0 8942.5 8953.0 9006.3 53684.7 53785.0 55055.2 55547.7 55802.7 70380.6 77414.2 77855.0 77953.6 78598.6 11525.1 11547.9 11920.9 12571.5 12919.0 11000.5 11077.3 11358.9 11536.8 11785.8 11121.6 11156.3 11226.6 11493.4 11713.4 10725.4 11020.9 11055.9 11088.2 11151.4 11559.5 11593.2 11674.8 11680.5 11726.4 9406.2 9426.2 9442.6 9633.6 9712.8 9484.4 9485.9 9539.3 9552.5 9573.9 22:30:36 INFO - PROCESS | 10189 | -------- Summary: end -------- 22:30:36 INFO - PROCESS | 10189 | 22:30:37 INFO - TEST-INFO | 10189: exit 0 22:30:37 INFO - TEST-OK | dromaeo_css | took 1110747ms 22:30:37 INFO - TEST-START | kraken 22:30:37 INFO - operating with platform_type : linux_ 22:30:37 INFO - Initialising browser for kraken test... 22:30:37 INFO - TEST-INFO | started process 10423 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppudR7T/profile http://localhost:54747/getInfo.html) 22:30:41 INFO - PROCESS | 10423 | __metrics Screen width/height:1600/1200 22:30:41 INFO - PROCESS | 10423 | colorDepth:24 22:30:41 INFO - PROCESS | 10423 | Browser inner width/height: 1024/697 22:30:41 INFO - PROCESS | 10423 | __metrics 22:30:42 ERROR - PROCESS | 10423 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2938: TypeError: this.tabs is undefined 22:30:43 INFO - TEST-INFO | 10423: exit 0 22:30:43 INFO - Browser initialized. 22:30:43 INFO - Running cycle 1/1 for kraken test... 22:30:43 INFO - TEST-INFO | started process 10541 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppudR7T/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:30:55 INFO - PROCESS | 10541 | RSS: Main: 167563264 22:30:55 INFO - PROCESS | 10541 | 22:30:57 INFO - PROCESS | 10541 | Cycle 1(1): loaded http://localhost:54747/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54747/tests/kraken/driver.html?testName=audio-beat-detection) 22:30:58 INFO - PROCESS | 10541 | RSS: Main: 172584960 22:30:58 INFO - PROCESS | 10541 | 22:31:01 INFO - PROCESS | 10541 | Cycle 1(1): loaded http://localhost:54747/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54747/tests/kraken/driver.html?testName=audio-dft) 22:31:01 INFO - PROCESS | 10541 | RSS: Main: 171810816 22:31:01 INFO - PROCESS | 10541 | 22:31:04 INFO - PROCESS | 10541 | Cycle 1(1): loaded http://localhost:54747/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54747/tests/kraken/driver.html?testName=audio-fft) 22:31:05 INFO - PROCESS | 10541 | RSS: Main: 166490112 22:31:05 INFO - PROCESS | 10541 | 22:31:07 INFO - PROCESS | 10541 | Cycle 1(1): loaded http://localhost:54747/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54747/tests/kraken/driver.html?testName=audio-oscillator) 22:31:08 INFO - PROCESS | 10541 | RSS: Main: 167337984 22:31:08 INFO - PROCESS | 10541 | 22:31:10 INFO - PROCESS | 10541 | Cycle 1(1): loaded http://localhost:54747/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54747/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:31:11 INFO - PROCESS | 10541 | RSS: Main: 167960576 22:31:11 INFO - PROCESS | 10541 | 22:31:14 INFO - PROCESS | 10541 | Cycle 1(1): loaded http://localhost:54747/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54747/tests/kraken/driver.html?testName=imaging-darkroom) 22:31:14 INFO - PROCESS | 10541 | RSS: Main: 168706048 22:31:14 INFO - PROCESS | 10541 | 22:31:18 INFO - PROCESS | 10541 | Cycle 1(1): loaded http://localhost:54747/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54747/tests/kraken/driver.html?testName=imaging-desaturate) 22:31:18 INFO - PROCESS | 10541 | RSS: Main: 165740544 22:31:18 INFO - PROCESS | 10541 | 22:31:21 INFO - PROCESS | 10541 | Cycle 1(1): loaded http://localhost:54747/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54747/tests/kraken/driver.html?testName=json-parse-financial) 22:31:22 INFO - PROCESS | 10541 | RSS: Main: 167100416 22:31:22 INFO - PROCESS | 10541 | 22:31:23 INFO - PROCESS | 10541 | Cycle 1(1): loaded http://localhost:54747/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54747/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:31:24 INFO - PROCESS | 10541 | RSS: Main: 167448576 22:31:24 INFO - PROCESS | 10541 | 22:31:26 INFO - PROCESS | 10541 | Cycle 1(1): loaded http://localhost:54747/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54747/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:31:26 INFO - PROCESS | 10541 | RSS: Main: 167772160 22:31:26 INFO - PROCESS | 10541 | 22:31:29 INFO - PROCESS | 10541 | Cycle 1(1): loaded http://localhost:54747/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54747/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:31:29 INFO - PROCESS | 10541 | RSS: Main: 168361984 22:31:29 INFO - PROCESS | 10541 | 22:31:32 INFO - PROCESS | 10541 | Cycle 1(1): loaded http://localhost:54747/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54747/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:31:32 INFO - PROCESS | 10541 | RSS: Main: 168214528 22:31:32 INFO - PROCESS | 10541 | 22:31:35 INFO - PROCESS | 10541 | Cycle 1(1): loaded http://localhost:54747/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54747/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:31:36 INFO - PROCESS | 10541 | RSS: Main: 168157184 22:31:36 INFO - PROCESS | 10541 | 22:31:37 INFO - PROCESS | 10541 | Cycle 1(1): loaded http://localhost:54747/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54747/tests/kraken/driver.html?testName=ai-astar) 22:31:38 INFO - PROCESS | 10541 | RSS: Main: 168935424 22:31:38 INFO - PROCESS | 10541 | 22:31:38 INFO - PROCESS | 10541 | __start_tp_report 22:31:38 INFO - PROCESS | 10541 | _x_x_mozilla_page_load 22:31:38 INFO - PROCESS | 10541 | _x_x_mozilla_page_load_details 22:31:38 INFO - PROCESS | 10541 | |i|pagename|runs| 22:31:38 INFO - PROCESS | 10541 | |0;ai-astar;110;104;111;109;113;110;110;111;110;110 22:31:38 INFO - PROCESS | 10541 | |1;audio-beat-detection;166;127;155;189;128;163;153;127;191;136 22:31:38 INFO - PROCESS | 10541 | |2;audio-dft;165;164;161;166;163;170;165;162;163;162 22:31:38 INFO - PROCESS | 10541 | |3;audio-fft;76;74;76;167;74;76;74;75;164;76 22:31:38 INFO - PROCESS | 10541 | |4;audio-oscillator;86;85;148;87;85;85;134;86;86;145 22:31:38 INFO - PROCESS | 10541 | |5;imaging-gaussian-blur;118;117;118;117;117;117;118;118;118;118 22:31:38 INFO - PROCESS | 10541 | |6;imaging-darkroom;148;147;147;146;146;147;146;146;150;147 22:31:38 INFO - PROCESS | 10541 | |7;imaging-desaturate;95;95;96;99;95;95;96;96;96;95 22:31:38 INFO - PROCESS | 10541 | |8;json-parse-financial;55;54;58;59;56;55;57;54;54;55 22:31:38 INFO - PROCESS | 10541 | |9;json-stringify-tinderbox;63;64;62;62;63;63;64;63;62;63 22:31:38 INFO - PROCESS | 10541 | |10;stanford-crypto-aes;79;80;80;80;79;81;80;82;103;80 22:31:38 INFO - PROCESS | 10541 | |11;stanford-crypto-ccm;133;120;122;122;136;120;129;133;125;127 22:31:38 INFO - PROCESS | 10541 | |12;stanford-crypto-pbkdf2;169;158;157;161;157;159;158;162;165;168 22:31:38 INFO - PROCESS | 10541 | |13;stanford-crypto-sha256-iterative;62;62;64;63;64;62;63;61;61;61 22:31:38 INFO - PROCESS | 10541 | __end_tp_report 22:31:38 INFO - PROCESS | 10541 | __start_cc_report 22:31:38 INFO - PROCESS | 10541 | _x_x_mozilla_cycle_collect,856 22:31:38 INFO - PROCESS | 10541 | __end_cc_report 22:31:38 INFO - PROCESS | 10541 | __startTimestamp1464931898190__endTimestamp 22:31:38 INFO - PROCESS | 10541 | 22:31:38 INFO - PROCESS | 10541 | ------- Summary: start ------- 22:31:38 INFO - PROCESS | 10541 | Number of tests: 14 22:31:38 INFO - PROCESS | 10541 | 22:31:38 INFO - PROCESS | 10541 | [#0] ai-astar Cycles:10 Average:109.80 Median:110.00 stddev:2.30 (2.1%) stddev-sans-first:2.44 22:31:38 INFO - PROCESS | 10541 | Values: 110.0 104.0 111.0 109.0 113.0 110.0 110.0 111.0 110.0 110.0 22:31:38 INFO - PROCESS | 10541 | 22:31:38 INFO - PROCESS | 10541 | [#1] audio-beat-detection Cycles:10 Average:153.50 Median:159.00 stddev:24.21 (15.2%) stddev-sans-first:25.26 22:31:38 INFO - PROCESS | 10541 | Values: 166.0 127.0 155.0 189.0 128.0 163.0 153.0 127.0 191.0 136.0 22:31:38 INFO - PROCESS | 10541 | 22:31:38 INFO - PROCESS | 10541 | [#2] audio-dft Cycles:10 Average:164.10 Median:164.50 stddev:2.60 (1.6%) stddev-sans-first:2.74 22:31:38 INFO - PROCESS | 10541 | Values: 165.0 164.0 161.0 166.0 163.0 170.0 165.0 162.0 163.0 162.0 22:31:38 INFO - PROCESS | 10541 | 22:31:38 INFO - PROCESS | 10541 | [#3] audio-fft Cycles:10 Average:93.20 Median:75.50 stddev:38.12 (50.5%) stddev-sans-first:39.92 22:31:38 INFO - PROCESS | 10541 | Values: 76.0 74.0 76.0 167.0 74.0 76.0 74.0 75.0 164.0 76.0 22:31:38 INFO - PROCESS | 10541 | 22:31:38 INFO - PROCESS | 10541 | [#4] audio-oscillator Cycles:10 Average:102.70 Median:85.50 stddev:27.58 (32.3%) stddev-sans-first:28.58 22:31:38 INFO - PROCESS | 10541 | Values: 86.0 85.0 148.0 87.0 85.0 85.0 134.0 86.0 86.0 145.0 22:31:38 INFO - PROCESS | 10541 | 22:31:38 INFO - PROCESS | 10541 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:118.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 22:31:38 INFO - PROCESS | 10541 | Values: 118.0 117.0 118.0 117.0 117.0 117.0 118.0 118.0 118.0 118.0 22:31:38 INFO - PROCESS | 10541 | 22:31:38 INFO - PROCESS | 10541 | [#6] imaging-darkroom Cycles:10 Average:147.00 Median:147.00 stddev:1.25 (0.8%) stddev-sans-first:1.27 22:31:38 INFO - PROCESS | 10541 | Values: 148.0 147.0 147.0 146.0 146.0 147.0 146.0 146.0 150.0 147.0 22:31:38 INFO - PROCESS | 10541 | 22:31:38 INFO - PROCESS | 10541 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:1.23 (1.3%) stddev-sans-first:1.27 22:31:38 INFO - PROCESS | 10541 | Values: 95.0 95.0 96.0 99.0 95.0 95.0 96.0 96.0 96.0 95.0 22:31:38 INFO - PROCESS | 10541 | 22:31:38 INFO - PROCESS | 10541 | [#8] json-parse-financial Cycles:10 Average:55.70 Median:55.50 stddev:1.77 (3.2%) stddev-sans-first:1.86 22:31:38 INFO - PROCESS | 10541 | Values: 55.0 54.0 58.0 59.0 56.0 55.0 57.0 54.0 54.0 55.0 22:31:38 INFO - PROCESS | 10541 | 22:31:38 INFO - PROCESS | 10541 | [#9] json-stringify-tinderbox Cycles:10 Average:62.90 Median:63.00 stddev:0.74 (1.2%) stddev-sans-first:0.78 22:31:38 INFO - PROCESS | 10541 | Values: 63.0 64.0 62.0 62.0 63.0 63.0 64.0 63.0 62.0 63.0 22:31:38 INFO - PROCESS | 10541 | 22:31:38 INFO - PROCESS | 10541 | [#10] stanford-crypto-aes Cycles:10 Average:82.40 Median:80.00 stddev:7.29 (9.1%) stddev-sans-first:7.63 22:31:38 INFO - PROCESS | 10541 | Values: 79.0 80.0 80.0 80.0 79.0 81.0 80.0 82.0 103.0 80.0 22:31:38 INFO - PROCESS | 10541 | 22:31:38 INFO - PROCESS | 10541 | [#11] stanford-crypto-ccm Cycles:10 Average:126.70 Median:128.00 stddev:5.85 (4.6%) stddev-sans-first:5.74 22:31:38 INFO - PROCESS | 10541 | Values: 133.0 120.0 122.0 122.0 136.0 120.0 129.0 133.0 125.0 127.0 22:31:38 INFO - PROCESS | 10541 | 22:31:38 INFO - PROCESS | 10541 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.40 Median:161.50 stddev:4.50 (2.8%) stddev-sans-first:3.84 22:31:38 INFO - PROCESS | 10541 | Values: 169.0 158.0 157.0 161.0 157.0 159.0 158.0 162.0 165.0 168.0 22:31:38 INFO - PROCESS | 10541 | 22:31:38 INFO - PROCESS | 10541 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.30 Median:62.50 stddev:1.16 (1.9%) stddev-sans-first:1.22 22:31:38 INFO - PROCESS | 10541 | Values: 62.0 62.0 64.0 63.0 64.0 62.0 63.0 61.0 61.0 61.0 22:31:38 INFO - PROCESS | 10541 | -------- Summary: end -------- 22:31:38 INFO - PROCESS | 10541 | 22:31:39 INFO - TEST-INFO | 10541: exit 0 22:31:39 INFO - TEST-OK | kraken | took 61799ms 22:31:39 INFO - SUITE-END | took 1172s 22:31:39 INFO - Completed test suite (00:19:32) 22:31:39 INFO - javascript benchmark 22:31:39 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7364.220497895913, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3159.083865678953, 3196.728278096362, 3234.8867789627366, 3240.384326977874, 3250.057483329833, 5549.445055494449, 5568.554515638749, 5578.916316255254, 5626.240457538231, 5654.095344744842, 5390.973045134779, 5504.394516603181, 5565.638233514819, 5572.192032155335, 5595.21666966624, 4994.051130285252, 5022.19644856823, 5120.820771273006, 5169.0, 5231.084560201968, 914.6191545509677, 4926.630502712293, 5009.323741294915, 5097.7196254206, 5152.072626927152, 5030.496950304995, 5032.320636714034, 5032.5470707636305, 5047.242913562958, 5054.115529782292, 5062.291279220912, 5062.544371006627, 5063.443021267658, 5066.873328166826, 5111.182210846247, 4963.60291176705, 5033.597312215051, 5059.392872855281, 5064.721440320781, 5076.086304465195, 5518.310211223597, 5522.972385138049, 5549.833504994856, 5557.221988921554, 5623.26897503326, 5662.433756624346, 5913.615614985012, 5922.911156332659, 5934.495567876736, 5967.224260846106, 6036.8188954331445, 6113.658745237687, 6115.541334399938, 6119.816405507798, 6134.110553969694, 5640.351359593617, 5641.097424412115, 5644.0, 5647.745851436654, 5653.378128405872, 5854.092615644582, 6076.726547305382, 6102.633841969496, 6167.938320616737, 6170.660613666201, 5797.130430435468, 5802.622829516068, 5809.622374545641, 5815.941840581625, 5819.679917604572, 5934.287885453773, 5941.613795103391, 5944.7027648617395, 5956.493698035629, 5966.522678185735, 5818.5345172386105, 5888.263967004124, 5907.172995780594, 5916.822495325147, 5931.228940237827, 5880.588358814842, 5941.643501389931, 5944.5838791284195, 5945.227120474397, 5964.1650168976375, 4374.431323927869, 4475.216837053503, 4477.261251893467, 4502.4371953505815, 4555.886102847456, 3918.45141680165, 3973.443717879499, 3990.940135897964, 3998.3402738547816, 4014.41790940312, 5619.353774316006, 5629.408912064257, 5661.943380566142, 5685.459881311269, 5743.396943320975, 5744.597878148573, 6033.456988871023, 6039.0, 6041.033434650435, 6050.757969681252, 5525.640833345819, 5605.32736071674, 5609.943900561024, 5611.6352437091455, 5615.410381909841, 5145.0, 5164.664296820694, 5200.089984252741, 5203.037438073969, 5205.817796377109, 6273.247210334789, 6308.085327627468, 6313.210848643919, 6318.4313411793155, 6325.683715814283, 5809.070548712186, 5973.761049557969, 6035.155078288955, 6081.17904082952, 6091.02543593023, 6163.506919446523, 6276.686165691788, 6280.9685951569945, 6297.685115744286, 6299.779507717208, 5857.150713146485, 5887.293524777054, 5905.202797622266, 5928.0, 5944.702764861653, 5753.424657534213, 5969.970150149222, 5998.910016349845, 6050.606710563799, 6063.484603808549, 5833.445822646841, 5846.064629659234, 5884.382139875252, 5896.056630939029, 5931.6441013539325, 5822.534197264294, 5834.329052159056, 5835.0, 5836.678982655994, 5854.443827836349, 5488.588355873405, 5730.656160630376, 5732.799352022659, 5746.367899530965, 5791.276090488689, 5853.882922341614, 5866.735996880236, 5914.852128696817, 5924.31870334917, 5951.047832346977, 5721.427857214412, 5750.5112065474905, 5768.221290125779, 5770.192173095854, 5772.163036359789], "value": 5466.948514859949, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [568.7696482924415, 619.6437048697, 620.128719149595, 620.3238470067625, 626.8808926304002, 32323.191920202007, 35396.64603353969, 38015.42976855349, 38294.4255836162, 38709.0, 45780.771096144555, 46191.30713039307, 46345.304820427635, 46429.767851160694, 46454.76772616141, 8752.0, 8963.507007114606, 9003.729888103368, 9011.95494022529, 9025.052369501207, 8760.211580957712, 8850.955745221265, 8867.512286824222, 8871.778205544848, 8901.376903616718, 8846.601902914384, 8872.37893347466, 8891.110888911122, 8947.64209431622, 8962.910370896305, 8825.69110081144, 8844.07137250586, 8880.73357799267, 8918.420302680304, 8930.866037009417, 8793.692220772242, 8891.288696904232, 8901.955490222572, 8911.643534258621, 8933.46399216049, 42554.36168457475, 42775.144497110196, 42948.0, 43001.139977200284, 43269.35095973531, 3366.545516355285, 3464.4803279508023, 3479.930401391958, 3519.9264224411545, 3892.4161375793856, 33242.50136247958, 33515.329693406, 33733.0, 35095.29809403798, 35120.64879351225, 4323.265044942367, 4355.978220108879, 4384.12317536494, 4412.889677758049, 4540.704854184468, 380662.09668951755, 381337.0, 381658.0, 382957.0, 383241.0, 60764.39235607676, 60879.0, 61306.38693613096, 61318.0, 61417.38582614206, 36088.45867311992, 36966.260674786354, 63588.95904889028, 64421.355786441534, 64737.0, 16438.178091095397, 16496.0, 16531.504054878373, 16572.58568535796, 16577.66844663124, 11947.402629868471, 11973.40132993347, 11986.0, 12057.0957178212, 12065.638030859089, 19950.800491995185, 20016.799832001783, 20113.798862011485, 20196.394108176777, 20312.492187695425, 7050.92949070513, 7235.348818606245, 7268.600226987461, 7289.562626242442, 7367.0, 990.1633120013577, 1014.2798612984864, 1026.5380578739598, 1092.63396762084, 1093.6336327330275, 33134.0, 33239.50140747891, 33441.0, 33476.49785253223, 33567.0, 1088.6407485529755, 1120.1654767198327, 1162.3026184289529, 1171.5631486508044, 1178.8997935175605, 17072.0, 17197.656046878994, 17419.825801742074, 17467.0, 17583.560410989827, 541429.0, 546582.0, 556391.0, 560802.0, 970807.0, 59501.0, 60148.0, 60720.05319654297, 60815.0, 60881.391186087574, 1380.806687063812, 1384.1349156777014, 1392.0951381601838, 1395.4557722488441, 1423.7294913966314, 31533.52699709552, 33645.66354336425, 33719.325613487104, 33720.32559348848, 34081.31837363189, 52507.73746131398, 52735.0, 53550.73224633852, 53571.19643205277, 53761.19358209708, 488895.0, 493616.0, 493899.0, 494141.0, 494199.0, 28186.577201341584, 28199.71800282053, 28520.85739571289, 28625.856870715514, 29166.56250156292, 49565.50434495609, 49922.75038624783, 49975.500244997085, 50209.74895125501, 50991.0, 41355.379669305585, 41389.37915931203, 42237.155256895305, 42687.0, 43382.34926476169, 41813.58186418218, 42134.57865421429, 42668.359974599785, 42846.143077138906, 43129.784351078044, 35117.47323790196, 36774.44838327374, 43528.34707479454, 43895.0, 44810.77594612006, 41442.792786035876, 42891.0, 43601.0, 46067.30899036584, 47381.52618473771, 34329.99233594434, 34756.47865282073, 35181.29637407186, 35248.82375588106, 35463.29073418466], "value": 20728.53125593947, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [384.3984164782115, 385.3429902017063, 396.65689178860293, 398.1380311625331, 412.0892826852656, 17717.734233986484, 18490.44528664139, 18777.718334225, 19273.132709028094, 19293.614127717436, 17667.0, 18227.72658410125, 18544.999999999967, 18692.25230990762, 18704.345347912826, 5244.160934250521, 5322.308099947001, 5365.892682146355, 5411.83764487066, 5715.771369145229, 5444.373897001856, 5632.7183640818, 5645.633033852807, 5656.095024796013, 5670.574706896979, 5776.220210271602, 5850.4734573888345, 5877.67672777997, 5897.498712609412, 5902.3507414184405, 5540.113581826889, 5558.416366281563, 5755.68343741094, 5839.649621022731, 5857.589968702193, 5349.946500535023, 5391.757370918318, 5392.083345831218, 5400.216968539579, 5409.350877894639, 12101.455434505468, 12740.305311459666, 21328.680069798964, 21776.564468710538, 21846.344609661737, 2125.7130287411155, 2164.945876353104, 2298.6322188449767, 2477.996411453364, 2856.4715527627454, 9380.765480863032, 9776.120149186536, 13708.794368084487, 14630.487932922402, 15255.648808900396, 1993.4019794061724, 1993.820556149939, 2000.5398758285676, 2032.5223572460459, 2047.5802460495563, 92823.53588232084, 96083.51958240234, 96385.0, 96422.0, 99319.50340248324, 14924.776128358084, 17585.12074396275, 17596.824031759774, 18108.547286317684, 18327.0, 31126.533102003486, 31197.532037019464, 31340.84329578383, 31439.0, 31485.527717084264, 9642.469664168399, 10012.349197302152, 10021.699349019542, 10078.244131690006, 10098.899011009942, 8325.25072743456, 8404.28563572091, 8429.4942303462, 8434.536100514531, 8443.83112337762, 8606.698765543177, 8765.780855478664, 8781.91218087811, 8819.426737262058, 8870.290376769843, 3518.7712798668517, 3532.064003039145, 3552.312651490521, 3565.7682250653625, 3713.294474049922, 869.426178722053, 1020.5152552537634, 1053.8577292065627, 1076.311160857052, 1079.6005477973201, 17960.640787184184, 18934.43196704101, 18978.335758248395, 19094.0, 19112.0, 975.5268694683073, 1004.7237009822211, 1022.3712416863575, 1024.2215915903819, 1066.919981001428, 8942.552872356357, 10377.584896604052, 10616.575336986434, 10624.203184761174, 10626.574937002588, 408226.0, 416652.0, 425098.0, 432319.0, 432816.0, 85771.0, 87012.5649371749, 89579.55210224037, 90243.09756902346, 90966.0, 1006.6124542051217, 1023.1916785739331, 1035.803197392493, 1039.5010395010286, 1040.6461802987021, 16193.838061619233, 16290.918545407198, 16536.586585335463, 16611.750823737897, 16910.32358705638, 38679.0, 41431.37852932148, 43207.0, 43818.56181438145, 44276.0, 48848.75575622241, 59287.70356148192, 59692.0, 59904.10143847933, 60402.69798651154, 7852.1755215703815, 8235.38234632393, 8261.793455163668, 8316.168383161636, 8364.87452688198, 12551.435185416496, 12625.0, 12813.871861281268, 12831.935840320739, 12904.870951290366, 10852.294600850919, 11355.091592672732, 11398.658040258806, 11901.821472677744, 12018.75962480728, 10922.672319830417, 11049.0, 11137.0, 11194.160437967348, 11333.829992550283, 11506.94246528762, 11682.415879205835, 11835.467403967014, 11932.403379831147, 12388.946939509882, 6756.560823546453, 7105.75129870452, 7648.311651951129, 8217.95891020541, 8380.036295826058, 11485.0, 11495.597654082067, 11510.251833630788, 11628.88371116278, 11631.185816992729], "value": 9799.79256445564, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1475.6310922269436, 1516.962075948101, 1655.5778276539481, 1802.5289211729896, 1822.2255541394904, 7792.92207077929, 8378.581070946451, 8442.831143377129, 8905.332100092495, 8918.019017908025, 8423.115572864854, 8639.092895246004, 8658.26404755595, 8685.435446695961, 8734.257588105018, 2271.681964524964, 2309.769023097685, 2317.582835089683, 2320.5938960681897, 2323.372689373868, 2288.7139107611547, 2291.51878105598, 2336.0655737704883, 2338.9766102339013, 2352.764723527651, 2265.569541787055, 2274.2608652188023, 2280.293109136173, 2327.627579587266, 2332.3469428559947, 2216.7007453993747, 2251.3020963501367, 2258.954820903573, 2284.0635339510804, 2289.473421113153, 2277.6241920083166, 2299.7010388649537, 2309.452666713306, 2311.711036120485, 2314.3982564533176, 8585.141485851427, 8645.962484501837, 8647.481151130889, 8651.870221946676, 8667.869981950276, 4946.0, 5023.547880690755, 5049.141645920203, 5058.165402708549, 5076.949230507685, 3060.8010479318773, 3072.4316001539787, 3138.4978403455566, 3245.204924793417, 3257.38109759145, 1082.8213344798098, 1093.6609651008214, 1094.4254266510065, 1096.9177311701574, 1149.8907603777627, 11864.703382415422, 11922.940385298105, 11951.641450756491, 11959.162858599902, 11995.280283183038, 4399.802008909607, 4429.247028005247, 4522.0, 4529.139463501924, 4560.270356742905, 9865.506724663737, 9927.354721943051, 9968.950155249177, 10040.598376065022, 10082.798344033225, 5135.948640513622, 5191.195364718475, 5192.714400707997, 5200.869978250574, 5203.687778733212, 4089.1821635672986, 4580.0, 4726.550977657117, 4729.219678753036, 4800.255960326155, 3951.0912490126857, 3953.7545673112877, 4071.776052317092, 4104.938425923614, 4121.752694838259, 1279.3858947704969, 1295.481807277078, 1304.2696090189525, 1308.6335825968745, 1311.8032295155613, 918.2653876898454, 1016.3698506925754, 1021.8160731068479, 1033.509083185496, 1049.239301506417, 6198.2252218472695, 6269.686515674198, 6273.247210334698, 6335.746570137143, 6353.809385718436, 425.41930265187796, 429.79155109771733, 430.3845500933695, 432.68197874562173, 433.7029135042506, 4316.956830431718, 4414.955850441519, 4415.867523974286, 4421.5578442156175, 4425.291953287458, 10054.095131438205, 10438.530266138043, 10495.685129446128, 10497.370157790558, 10548.683539493828, 10239.539220735085, 10477.476126193813, 10478.842817357745, 10548.41983690889, 10580.682579522627, 8085.555294458862, 8175.223353781381, 8178.141295163922, 8249.422540422232, 8251.2986396157, 5993.820185394445, 6261.279952805304, 6270.122182894307, 6339.080833279241, 6347.42873141401, 9803.950980245054, 10087.142592879394, 10146.137578305927, 10204.2346823987, 10204.234682398997, 9975.750606234902, 10150.23873209527, 10157.238207134347, 10244.385336879812, 10350.981558596002, 7177.533460325062, 7463.0, 7648.73229436967, 7732.7680169595005, 7837.804054898673, 8622.741317760478, 8708.91291087081, 8726.91273087261, 8736.825263494822, 8756.387052906235, 7552.433567482351, 7793.961030194812, 7874.763757087297, 7901.68393264286, 7926.524408535506, 7518.812029699301, 7539.208383119693, 7634.427417943787, 7734.110577283459, 7795.532268063935, 6926.168859736864, 6996.440284777307, 7002.719891204499, 7010.228874823663, 7041.260667629826, 5284.0, 5294.205869119663, 5410.48600382963, 5423.972880135574, 5463.0, 5072.767982087869, 5191.6884986900905, 5210.609204309768, 5267.183586544092, 5281.392639846466], "value": 4529.757205983901, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [321.8809040654958, 338.6833310854351, 340.3465346534653, 341.6446895228961, 347.95998460177054, 5534.584906132036, 5615.073512870372, 5636.239107720462, 5771.210924613368, 5786.161006654038, 5610.915836262459, 5648.406917273689, 5651.660900345983, 5661.688607126606, 5680.346760122577, 4387.648988080954, 4396.450443694538, 4398.9560104399025, 4407.2507673695545, 4408.448943882015, 4141.689373296999, 4317.913641727164, 4332.328489084197, 4415.580519850609, 4472.837062363777, 4254.468191476066, 4284.2930916398755, 4290.828366865321, 4301.913961720764, 4302.397664326997, 4287.121140166274, 4299.097189590158, 4301.870943871673, 4333.696641235115, 4350.71720338177, 3564.1267889367014, 3766.8681596144, 3768.5100936878302, 3773.1887644156636, 3774.8112594370446, 5457.208704737791, 5506.779728810843, 5512.39363669996, 5535.280413546213, 5546.528545073674, 4912.926306105412, 4925.975370123162, 4941.258811178316, 4953.0, 4995.450500444948, 5581.386047534768, 5859.355470898197, 5883.0, 5962.880742385128, 5966.820995370146, 4113.753174809521, 4126.154138401621, 4131.338985762263, 4143.274926887782, 4158.521769996429, 6108.831364865498, 6123.326434092246, 6124.724387402578, 6136.631802091889, 6171.691415429211, 4096.877093687194, 4194.448054219958, 4196.412502249626, 4203.936940945889, 4206.810693518799, 4226.774235471678, 4237.87286381409, 4244.596763307481, 4252.829886804555, 4323.978380108079, 4890.682105663121, 4954.578860796801, 4988.226824842155, 4992.525710057539, 5022.121128802445, 5864.563182020433, 5977.850553736192, 5991.760329586855, 5999.850003749854, 6034.849128771816, 1465.479754687092, 1476.948306809278, 1478.4825311141014, 1486.4797320937585, 1486.7398205314028, 923.4044041593135, 929.2796612246261, 951.6478902806006, 955.0544960489066, 955.5126885288553, 5018.924716129261, 5035.949640503622, 5133.79464821403, 5181.455947125498, 5190.506901844319, 5409.459054094559, 5442.891142177214, 5461.6996065216, 5484.890302193934, 5565.7217139143695, 4894.877628059327, 4981.850544483671, 5123.97438012815, 5145.151050076695, 5149.304843846033, 2873.913782586526, 2914.781391395654, 2926.97073029267, 2927.9121626351243, 2928.546075358323, 5555.30558680165, 5559.610827242054, 5584.0, 5600.60795744294, 5623.690697011703, 5289.7619607117, 5436.673799572039, 5527.44725527444, 5578.163275508625, 5601.60788744784, 5580.804671836466, 5612.635178713453, 5618.494335509824, 5623.044082505902, 5648.491635752802, 5203.375594928632, 5331.600129990189, 5368.2752828367675, 5429.592780541396, 5500.0, 5385.488378604026, 5404.6488377905525, 5426.457354264542, 5467.5625949923115, 5500.4499550044675, 5494.890102198014, 5549.417311182267, 5621.971890140523, 5750.884982300414, 6020.668863212565, 4134.669226461816, 4188.560201178832, 4202.2435961526, 4214.093969796509, 4225.852095176654, 5968.16445697594, 5985.880282394415, 5994.220751302303, 6028.758849645965, 6119.2350956130485, 5738.741756621045, 5854.594897224721, 5902.232709747877, 5916.763329466773, 5933.347331793586, 5882.0, 5883.352321560488, 5893.793717219876, 5917.585768996301, 5936.257967754031, 5785.784985153165, 5792.768289268382, 5824.883502330014, 5836.620619659709, 5870.383609721089, 5663.235463212413, 5981.312149102909, 6018.548608854266, 6030.3416560444475, 6057.212562366864, 5873.618214816023, 5893.116032595145, 5914.408559144051, 5947.821565353046, 5974.133750606051], "value": 4341.24865511501, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [764.0487592946782, 778.2140038561055, 795.4754231859733, 814.4136221920218, 841.7685136587442, 15255.923720381397, 15977.0, 16055.75916361254, 16085.356585736587, 16085.919570402131, 13653.453861845514, 13693.0, 13718.51985180519, 13744.381502832372, 13754.381052852621, 633.4868756307383, 756.8864670299458, 771.6103367799282, 781.1914668318292, 797.3820289275828, 791.4103992525547, 791.4183075439547, 792.5126047480816, 793.3494534481728, 793.9126696063429, 844.5988155626059, 845.1421806866036, 848.7708318753963, 850.7873031742065, 853.6116067189414, 836.6611522333465, 837.7570504553672, 838.8573942429771, 840.0507426607955, 840.3319361107904, 613.9140520327157, 614.3181069013392, 614.8063360041573, 615.2002396884033, 615.4460985113388, 15018.924905375403, 15109.848901510954, 15141.318640661086, 15179.089254644756, 15189.316480758393, 15062.623434414118, 15094.698106037928, 15226.390944362212, 15260.196205368215, 15587.376504939788, 12504.81242781359, 12553.435095420728, 12624.684382890502, 12631.115821892472, 13148.342582870913, 3733.869314574004, 3813.8855834325013, 3847.8653247136217, 3895.14306852492, 3961.088949541622, 77252.61373693151, 77517.61241193814, 77762.0, 77828.61085694535, 78429.0, 11185.0, 11878.346690931909, 11913.880861191277, 11953.0, 12097.092718046182, 22687.432814179447, 22716.545669086856, 22785.658215126787, 22798.65802012971, 22887.313380598607, 8314.667413303521, 8371.204735550113, 8465.661373545112, 8469.11074337198, 8724.258438032712, 4517.141743068806, 4596.839110631178, 4662.487126416091, 4662.860114196579, 4860.1008813369635, 3605.0, 3681.7975011374097, 3723.422869455239, 3723.497327860704, 3726.7763934164036, 593.489598944907, 598.4494265275956, 601.9367966363557, 612.1735656863199, 617.3517806303364, 718.5652680128552, 736.443984791479, 741.403170447784, 748.1172216784138, 777.4635501503944, 9332.34673572857, 9609.567569459392, 9831.213502919749, 9857.802843943082, 9896.752581185385, 653.7973228299243, 666.5600703535644, 767.1145647296426, 770.6917233106802, 771.7954741993376, 4390.6501693123, 4664.603508701731, 4678.719276843332, 4713.34013238147, 4737.928931066037, 109826.45086774675, 116562.0, 118334.0, 119436.0563943616, 119506.0, 58460.12309815356, 61280.38719612747, 63557.682211588646, 92119.0, 100328.99999999854, 87603.56198219095, 87734.1226587726, 89080.0, 89374.55312723394, 90724.0, 8871.13706121696, 8938.955305223431, 8942.46345219289, 8953.0, 9006.324525660471, 53684.73157634187, 53785.0, 55055.174172388244, 55547.72226138844, 55802.72098639643, 70380.64809676123, 77414.22585774296, 77855.0, 77953.61023194848, 78598.6070069669, 11525.069117537107, 11547.942260288644, 11920.880791191978, 12571.497140114294, 12919.0, 11000.504977275881, 11077.279976801483, 11358.886411135783, 11536.826947595624, 11785.764284714429, 11121.555137794721, 11156.274842135235, 11226.55093796239, 11493.425328733698, 11713.414329283672, 10725.410102444128, 11020.889791102307, 11055.889441105486, 11088.223824332543, 11151.442427878736, 11559.534680589073, 11593.188476806543, 11674.824877626672, 11680.532778689098, 11726.355050472306, 9406.176243082922, 9426.151646351862, 9442.575084121368, 9633.566489507848, 9712.82858366626, 9484.383515071775, 9485.857712134186, 9539.33224674266, 9552.522373881138, 9573.856392153984], "value": 7302.885291898982, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1535.1000000000004, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 104.0, 111.0, 109.0, 113.0, 110.0, 110.0, 111.0, 110.0, 110.0], "value": 109.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 127.0, 155.0, 189.0, 128.0, 163.0, 153.0, 127.0, 191.0, 136.0], "value": 153.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 164.0, 161.0, 166.0, 163.0, 170.0, 165.0, 162.0, 163.0, 162.0], "value": 164.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 74.0, 76.0, 167.0, 74.0, 76.0, 74.0, 75.0, 164.0, 76.0], "value": 93.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 148.0, 87.0, 85.0, 85.0, 134.0, 86.0, 86.0, 145.0], "value": 102.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 118.0, 117.0, 117.0, 117.0, 118.0, 118.0, 118.0, 118.0], "value": 117.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 147.0, 146.0, 146.0, 147.0, 146.0, 146.0, 150.0, 147.0], "value": 147.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 99.0, 95.0, 95.0, 96.0, 96.0, 96.0, 95.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 54.0, 58.0, 59.0, 56.0, 55.0, 57.0, 54.0, 54.0, 55.0], "value": 55.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 62.0, 62.0, 63.0, 63.0, 64.0, 63.0, 62.0, 63.0], "value": 62.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 80.0, 80.0, 80.0, 79.0, 81.0, 80.0, 82.0, 103.0, 80.0], "value": 82.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 120.0, 122.0, 122.0, 136.0, 120.0, 129.0, 133.0, 125.0, 127.0], "value": 126.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 158.0, 157.0, 161.0, 157.0, 159.0, 158.0, 162.0, 165.0, 168.0], "value": 161.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 64.0, 63.0, 64.0, 62.0, 63.0, 61.0, 61.0, 61.0], "value": 62.3, "unit": "score"}]}]} 22:31:39 INFO - Return code: 0 22:31:39 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 22:31:39 ERROR - # TBPL SUCCESS # 22:31:39 INFO - Running post-action listener: _resource_record_post_action 22:31:39 INFO - ##### 22:31:39 INFO - ##### Finished run-tests step (success) 22:31:39 INFO - ##### 22:31:39 INFO - Running post-run listener: _resource_record_post_run 22:31:39 INFO - Total resource usage - Wall time: 1191s; CPU: 14.0%; Read bytes: 0; Write bytes: 542289920; Read time: 0; Write time: 538104 22:31:39 INFO - TinderboxPrint: CPU usage
13.5% 22:31:39 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 22:31:39 INFO - TinderboxPrint: I/O write bytes / time
542,289,920 / 538,104 22:31:39 INFO - TinderboxPrint: CPU idle
8,214.9 (86.4%) 22:31:39 INFO - TinderboxPrint: CPU user
1,230.5 (12.9%) 22:31:39 INFO - TinderboxPrint: Swap in / out
0 / 0 22:31:39 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 254902272; Read time: 0; Write time: 347340 22:31:39 INFO - run-tests - Wall time: 1174s; CPU: 14.0%; Read bytes: 0; Write bytes: 287387648; Read time: 0; Write time: 190764 22:31:40 INFO - Running post-run listener: _upload_blobber_files 22:31:40 INFO - Blob upload gear active. 22:31:40 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 22:31:40 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 22:31:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 22:31:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 22:31:40 INFO - (blobuploader) - INFO - Open directory for files ... 22:31:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 22:31:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:31:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:31:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 22:31:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:31:41 INFO - (blobuploader) - INFO - Done attempting. 22:31:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 22:31:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:31:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:31:45 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 22:31:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:31:45 INFO - (blobuploader) - INFO - Done attempting. 22:31:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 22:31:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:31:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:31:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 22:31:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:31:46 INFO - (blobuploader) - INFO - Done attempting. 22:31:46 INFO - (blobuploader) - INFO - Iteration through files over. 22:31:46 INFO - Return code: 0 22:31:46 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 22:31:46 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 22:31:46 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/165e2671171a98f1079561631ae1be99b44195814ca8d8293179fb170d32bd0bf0b5c792addc02c406613a87083c679e1f9855d46114d02942837d76dbdd7d71", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/4767140766476fec20fa30e2736fd5c6440ef04c7a5771156aaa36ab496ccfc6be2b80f9c96af8bc2c5ec6c618afee454b55b527f8900e3a79a24d972841550d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/4af4e876b3f248d68d064f5562284ff6673d17d8488c8dc4185c0acde762b3ff4e800a294ede510c271dd97eea9939022468e384b6b6bd311757ae456df1ef17"} 22:31:46 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 22:31:46 INFO - Writing to file /builds/slave/test/properties/blobber_files 22:31:46 INFO - Contents: 22:31:46 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/165e2671171a98f1079561631ae1be99b44195814ca8d8293179fb170d32bd0bf0b5c792addc02c406613a87083c679e1f9855d46114d02942837d76dbdd7d71", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/4767140766476fec20fa30e2736fd5c6440ef04c7a5771156aaa36ab496ccfc6be2b80f9c96af8bc2c5ec6c618afee454b55b527f8900e3a79a24d972841550d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/4af4e876b3f248d68d064f5562284ff6673d17d8488c8dc4185c0acde762b3ff4e800a294ede510c271dd97eea9939022468e384b6b6bd311757ae456df1ef17"} 22:31:46 INFO - Running post-run listener: copy_logs_to_upload_dir 22:31:46 INFO - Copying logs to upload dir... 22:31:46 INFO - mkdir: /builds/slave/test/build/upload/logs 22:31:46 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1233.478408 ========= master_lag: 0.27 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-06-02 22:31:46.174909) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-02 22:31:46.179147) ========= 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=db0483c52d987ecb441a263b000001ad-1464930669.597156-1532903752 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/165e2671171a98f1079561631ae1be99b44195814ca8d8293179fb170d32bd0bf0b5c792addc02c406613a87083c679e1f9855d46114d02942837d76dbdd7d71", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/4767140766476fec20fa30e2736fd5c6440ef04c7a5771156aaa36ab496ccfc6be2b80f9c96af8bc2c5ec6c618afee454b55b527f8900e3a79a24d972841550d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/4af4e876b3f248d68d064f5562284ff6673d17d8488c8dc4185c0acde762b3ff4e800a294ede510c271dd97eea9939022468e384b6b6bd311757ae456df1ef17"} build_url:https://queue.taskcluster.net/v1/task/cN-KpsgvRQKyhxA3iZAElA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011330 build_url: 'https://queue.taskcluster.net/v1/task/cN-KpsgvRQKyhxA3iZAElA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/165e2671171a98f1079561631ae1be99b44195814ca8d8293179fb170d32bd0bf0b5c792addc02c406613a87083c679e1f9855d46114d02942837d76dbdd7d71", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/4767140766476fec20fa30e2736fd5c6440ef04c7a5771156aaa36ab496ccfc6be2b80f9c96af8bc2c5ec6c618afee454b55b527f8900e3a79a24d972841550d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/4af4e876b3f248d68d064f5562284ff6673d17d8488c8dc4185c0acde762b3ff4e800a294ede510c271dd97eea9939022468e384b6b6bd311757ae456df1ef17"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-02 22:31:46.209105) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 22:31:46.209429) ========= 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=db0483c52d987ecb441a263b000001ad-1464930669.597156-1532903752 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004644 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 22:31:46.262108) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-02 22:31:46.262409) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-02 22:31:46.265723) ========= ========= Total master_lag: 0.39 =========