builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-037 starttime: 1468374915.89 results: success (0) buildid: 20160712160625 builduid: 6c3d3a8e9bc8484dbe262f3f044d5331 revision: bd3207c8ef3811b55e2073248c6ca39576fcf3a6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-12 18:55:15.891315) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-12 18:55:15.891846) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-12 18:55:15.892135) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-12 18:55:15.923168) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 18:55:15.923898) ========= 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=56c518bb7cbc29fb3c9463e2000001c4-1468374756.115701-1499394416 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-12 18:55:16-- 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% 40.7M=0s 2016-07-12 18:55:16 (40.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.241893 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 18:55:16.186237) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 18:55:16.186565) ========= 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=56c518bb7cbc29fb3c9463e2000001c4-1468374756.115701-1499394416 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018606 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 18:55:16.235810) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 18:55:16.236359) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev bd3207c8ef3811b55e2073248c6ca39576fcf3a6 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev bd3207c8ef3811b55e2073248c6ca39576fcf3a6 --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=56c518bb7cbc29fb3c9463e2000001c4-1468374756.115701-1499394416 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-12 18:55:16,329 truncating revision to first 12 chars 2016-07-12 18:55:16,329 Setting DEBUG logging. 2016-07-12 18:55:16,329 attempt 1/10 2016-07-12 18:55:16,329 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/bd3207c8ef38?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-12 18:55:16,844 unpacking tar archive at: mozilla-aurora-bd3207c8ef38/testing/mozharness/ program finished with exit code 0 elapsedTime=0.880267 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 18:55:17.131140) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-12 18:55:17.131462) ========= script_repo_revision: bd3207c8ef3811b55e2073248c6ca39576fcf3a6 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-12 18:55:17.131865) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-12 18:55:17.132134) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-12 18:55:17.140089) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-07-12 18:55:17.140422) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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=56c518bb7cbc29fb3c9463e2000001c4-1468374756.115701-1499394416 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:55:17 INFO - MultiFileLogger online at 20160712 18:55:17 in /builds/slave/test 18:55:17 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 18:55:17 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:55:17 INFO - {'append_to_log': False, 18:55:17 INFO - 'base_work_dir': '/builds/slave/test', 18:55:17 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 18:55:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:55:17 INFO - 'branch': 'Mozilla-Aurora', 18:55:17 INFO - 'buildbot_json_path': 'buildprops.json', 18:55:17 INFO - 'config_files': ('talos/linux_config.py',), 18:55:17 INFO - 'default_actions': ('clobber', 18:55:17 INFO - 'read-buildbot-config', 18:55:17 INFO - 'download-and-extract', 18:55:17 INFO - 'populate-webroot', 18:55:17 INFO - 'create-virtualenv', 18:55:17 INFO - 'install', 18:55:17 INFO - 'run-tests'), 18:55:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:55:17 INFO - 'download_minidump_stackwalk': True, 18:55:17 INFO - 'download_symbols': 'ondemand', 18:55:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:55:17 INFO - 'tooltool.py': '/tools/tooltool.py', 18:55:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:55:17 INFO - '/tools/misc-python/virtualenv.py')}, 18:55:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:55:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:55:17 INFO - 'installer_path': 'installer.exe', 18:55:17 INFO - 'log_level': 'info', 18:55:17 INFO - 'log_name': 'talos', 18:55:17 INFO - 'log_to_console': True, 18:55:17 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:55:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:55:17 INFO - 'opt_config_files': (), 18:55:17 INFO - 'pip_index': False, 18:55:17 INFO - 'sps_profile': False, 18:55:17 INFO - 'sps_profile_interval': 0, 18:55:17 INFO - 'suite': 'dromaeojs', 18:55:17 INFO - 'system_bits': '32', 18:55:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:55:17 INFO - 'title': 'talos-linux64-ix-037', 18:55:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:55:17 INFO - 'use_talos_json': True, 18:55:17 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:55:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:55:17 INFO - 'work_dir': 'build'} 18:55:17 INFO - ##### 18:55:17 INFO - ##### Running clobber step. 18:55:17 INFO - ##### 18:55:17 INFO - Running pre-action listener: _resource_record_pre_action 18:55:17 INFO - Running main action method: clobber 18:55:17 INFO - rmtree: /builds/slave/test/build 18:55:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:55:18 INFO - Running post-action listener: _resource_record_post_action 18:55:18 INFO - ##### 18:55:18 INFO - ##### Finished clobber step (success) 18:55:18 INFO - ##### 18:55:18 INFO - ##### 18:55:18 INFO - ##### Running read-buildbot-config step. 18:55:18 INFO - ##### 18:55:18 INFO - Running pre-action listener: _resource_record_pre_action 18:55:18 INFO - Running main action method: read_buildbot_config 18:55:18 INFO - Using buildbot properties: 18:55:18 INFO - { 18:55:18 INFO - "project": "", 18:55:18 INFO - "product": "firefox", 18:55:18 INFO - "script_repo_revision": "production", 18:55:18 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 18:55:18 INFO - "repository": "", 18:55:18 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 18:55:18 INFO - "buildid": "20160712160625", 18:55:18 INFO - "pgo_build": "True", 18:55:18 INFO - "basedir": "/builds/slave/test", 18:55:18 INFO - "buildnumber": 410, 18:55:18 INFO - "slavename": "talos-linux64-ix-037", 18:55:18 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 18:55:18 INFO - "platform": "ubuntu64_hw", 18:55:18 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 18:55:18 INFO - "branch": "mozilla-aurora", 18:55:18 INFO - "repo_path": "releases/mozilla-aurora", 18:55:18 INFO - "revision": "bd3207c8ef3811b55e2073248c6ca39576fcf3a6", 18:55:18 INFO - "stage_platform": "linux64-pgo", 18:55:18 INFO - "builduid": "6c3d3a8e9bc8484dbe262f3f044d5331", 18:55:18 INFO - "slavebuilddir": "test" 18:55:18 INFO - } 18:55:18 INFO - Found installer url https://queue.taskcluster.net/v1/task/Nn3JUOTFQjyO9V21Tv3zsA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2. 18:55:18 INFO - Running post-action listener: _resource_record_post_action 18:55:18 INFO - ##### 18:55:18 INFO - ##### Finished read-buildbot-config step (success) 18:55:18 INFO - ##### 18:55:18 INFO - ##### 18:55:18 INFO - ##### Running download-and-extract step. 18:55:18 INFO - ##### 18:55:18 INFO - Running pre-action listener: _resource_record_pre_action 18:55:18 INFO - Running main action method: download_and_extract 18:55:18 INFO - mkdir: /builds/slave/test/build/tests 18:55:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:55:18 INFO - https://queue.taskcluster.net/v1/task/Nn3JUOTFQjyO9V21Tv3zsA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 18:55:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nn3JUOTFQjyO9V21Tv3zsA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 18:55:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nn3JUOTFQjyO9V21Tv3zsA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 18:55:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nn3JUOTFQjyO9V21Tv3zsA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 18:55:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nn3JUOTFQjyO9V21Tv3zsA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 18:55:19 INFO - Downloaded 1361 bytes. 18:55:19 INFO - Reading from file /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 18:55:19 INFO - Using the following test package requirements: 18:55:19 INFO - {u'common': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 18:55:19 INFO - u'cppunittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 18:55:19 INFO - u'firefox-49.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 18:55:19 INFO - u'gtest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 18:55:19 INFO - u'firefox-49.0a2.en-US.linux-x86_64.gtest.tests.zip'], 18:55:19 INFO - u'jittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 18:55:19 INFO - u'jsshell-linux-x86_64.zip'], 18:55:19 INFO - u'mochitest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 18:55:19 INFO - u'firefox-49.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 18:55:19 INFO - u'mozbase': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 18:55:19 INFO - u'reftest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 18:55:19 INFO - u'firefox-49.0a2.en-US.linux-x86_64.reftest.tests.zip'], 18:55:19 INFO - u'talos': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 18:55:19 INFO - u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'], 18:55:19 INFO - u'web-platform': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 18:55:19 INFO - u'firefox-49.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 18:55:19 INFO - u'xpcshell': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 18:55:19 INFO - u'firefox-49.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 18:55:19 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 18:55:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:55:19 INFO - https://queue.taskcluster.net/v1/task/Nn3JUOTFQjyO9V21Tv3zsA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:55:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nn3JUOTFQjyO9V21Tv3zsA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 18:55:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nn3JUOTFQjyO9V21Tv3zsA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 18:55:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nn3JUOTFQjyO9V21Tv3zsA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 18:55:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nn3JUOTFQjyO9V21Tv3zsA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:55:20 INFO - Downloaded 24424405 bytes. 18:55:20 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 18:55:20 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 18:55:22 INFO - Return code: 0 18:55:22 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 18:55:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:55:22 INFO - https://queue.taskcluster.net/v1/task/Nn3JUOTFQjyO9V21Tv3zsA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:55:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nn3JUOTFQjyO9V21Tv3zsA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 18:55:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nn3JUOTFQjyO9V21Tv3zsA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 18:55:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nn3JUOTFQjyO9V21Tv3zsA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 18:55:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nn3JUOTFQjyO9V21Tv3zsA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:55:24 INFO - Downloaded 24424405 bytes. 18:55:24 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 18:55:24 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 18:55:25 INFO - Return code: 0 18:55:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:55:25 INFO - https://queue.taskcluster.net/v1/task/Nn3JUOTFQjyO9V21Tv3zsA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 18:55:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nn3JUOTFQjyO9V21Tv3zsA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 18:55:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nn3JUOTFQjyO9V21Tv3zsA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 18:55:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nn3JUOTFQjyO9V21Tv3zsA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 18:55:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nn3JUOTFQjyO9V21Tv3zsA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 18:55:26 INFO - Downloaded 10833369 bytes. 18:55:26 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 18:55:26 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 18:55:26 INFO - Return code: 0 18:55: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')]} 18:55:26 INFO - https://queue.taskcluster.net/v1/task/Nn3JUOTFQjyO9V21Tv3zsA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 18:55:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nn3JUOTFQjyO9V21Tv3zsA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 18:55:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nn3JUOTFQjyO9V21Tv3zsA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 18:55:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nn3JUOTFQjyO9V21Tv3zsA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 18:55:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nn3JUOTFQjyO9V21Tv3zsA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 18:55:28 INFO - Downloaded 62839007 bytes. 18:55:28 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Nn3JUOTFQjyO9V21Tv3zsA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 18:55:28 INFO - mkdir: /builds/slave/test/properties 18:55:28 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:55:28 INFO - Writing to file /builds/slave/test/properties/build_url 18:55:28 INFO - Contents: 18:55:28 INFO - build_url:https://queue.taskcluster.net/v1/task/Nn3JUOTFQjyO9V21Tv3zsA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 18:55:28 INFO - Running post-action listener: _resource_record_post_action 18:55:28 INFO - Running post-action listener: set_extra_try_arguments 18:55:28 INFO - ##### 18:55:28 INFO - ##### Finished download-and-extract step (success) 18:55:28 INFO - ##### 18:55:28 INFO - ##### 18:55:28 INFO - ##### Running populate-webroot step. 18:55:28 INFO - ##### 18:55:28 INFO - Running pre-action listener: _resource_record_pre_action 18:55:28 INFO - Running main action method: populate_webroot 18:55:28 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:55:28 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:55:28 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:55:28 INFO - '--tppagecycles', 18:55:28 INFO - '7'], 18:55:28 INFO - 'tests': ['tsvgm']}}, 18:55:28 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 18:55:28 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:55:28 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:55:28 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:55:28 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:55:28 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:55:28 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:55:28 INFO - 'talos_options': ['--disable-e10s'], 18:55:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:55:28 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:55:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:55:28 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:55:28 INFO - 'talos_options': ['--disable-e10s'], 18:55:28 INFO - 'tests': ['damp', 'tps']}, 18:55:28 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:55:28 INFO - 'tests': ['damp', 'tps']}, 18:55:28 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:55:28 INFO - 'tests': ['dromaeo_dom']}, 18:55:28 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:55:28 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:55:28 INFO - 'tests': ['a11yr', 18:55:28 INFO - 'ts_paint', 18:55:28 INFO - 'tpaint', 18:55:28 INFO - 'sessionrestore', 18:55:28 INFO - 'sessionrestore_no_auto_restore', 18:55:28 INFO - 'tabpaint']}, 18:55:28 INFO - 'other-e10s': {'tests': ['a11yr', 18:55:28 INFO - 'ts_paint', 18:55:28 INFO - 'tpaint', 18:55:28 INFO - 'sessionrestore', 18:55:28 INFO - 'sessionrestore_no_auto_restore', 18:55:28 INFO - 'tabpaint']}, 18:55:28 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:55:28 INFO - 'ts_paint', 18:55:28 INFO - 'tpaint', 18:55:28 INFO - 'sessionrestore', 18:55:28 INFO - 'sessionrestore_no_auto_restore', 18:55:28 INFO - 'tabpaint']}, 18:55:28 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:55:28 INFO - 'ts_paint', 18:55:28 INFO - 'tpaint', 18:55:28 INFO - 'sessionrestore', 18:55:28 INFO - 'sessionrestore_no_auto_restore', 18:55:28 INFO - 'tabpaint']}, 18:55:28 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:55:28 INFO - 'tests': ['a11yr', 18:55:28 INFO - 'ts_paint', 18:55:28 INFO - 'tpaint', 18:55:28 INFO - 'sessionrestore', 18:55:28 INFO - 'sessionrestore_no_auto_restore', 18:55:28 INFO - 'tabpaint']}, 18:55:28 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:55:28 INFO - 'tests': ['a11yr', 18:55:28 INFO - 'ts_paint', 18:55:28 INFO - 'tpaint', 18:55:28 INFO - 'sessionrestore', 18:55:28 INFO - 'sessionrestore_no_auto_restore', 18:55:28 INFO - 'tabpaint']}, 18:55:28 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:55:28 INFO - 'tests': ['tsvgx', 18:55:28 INFO - 'tsvgr_opacity', 18:55:28 INFO - 'tart', 18:55:28 INFO - 'tscrollx', 18:55:28 INFO - 'cart']}, 18:55:28 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:55:28 INFO - 'tsvgr_opacity', 18:55:28 INFO - 'tart', 18:55:28 INFO - 'tscrollx', 18:55:28 INFO - 'cart']}, 18:55:28 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:55:28 INFO - 'talos_options': ['--disable-e10s'], 18:55:28 INFO - 'tests': ['tp5o']}, 18:55:28 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:55:28 INFO - 'tests': ['tp5o']}, 18:55:28 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:55:28 INFO - 'talos_options': ['--disable-e10s', 18:55:28 INFO - '--xperf_path', 18:55:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:55:28 INFO - 'tests': ['tp5n']}, 18:55:28 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:55:28 INFO - 'talos_options': ['--xperf_path', 18:55:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:55:28 INFO - 'tests': ['tp5n']}}, 18:55:28 INFO - 'talos.zip': {'path': '', 18:55:28 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:55:28 INFO - Running post-action listener: _resource_record_post_action 18:55:28 INFO - ##### 18:55:28 INFO - ##### Finished populate-webroot step (success) 18:55:28 INFO - ##### 18:55:28 INFO - ##### 18:55:28 INFO - ##### Running create-virtualenv step. 18:55:28 INFO - ##### 18:55:28 INFO - Running pre-action listener: _resource_record_pre_action 18:55:28 INFO - Running main action method: create_virtualenv 18:55:28 INFO - Creating virtualenv /builds/slave/test/build/venv 18:55:28 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 18:55:28 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:55:28 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:55:28 INFO - Using real prefix '/usr' 18:55:28 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:55:29 INFO - Installing distribute.............................................................................................................................................................................................done. 18:55:31 INFO - Installing pip.................done. 18:55:31 INFO - Return code: 0 18:55:31 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:55: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')]} 18:55:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:55:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:55: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')]} 18:55:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:55:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:55: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4602b3af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x117b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1248020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12da2e0>, '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 0x1246140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12465d0>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1468374756.115701-1499394416', '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 18:55: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', 'pip>=1.5'] in /builds/slave/test/build 18:55: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 pip>=1.5 18:55:31 INFO - Using env: {'DISPLAY': ':0', 18:55:31 INFO - 'HOME': '/home/cltbld', 18:55:31 INFO - 'LANG': 'en_US.UTF-8', 18:55:31 INFO - 'LANGUAGE': 'en_US:en', 18:55:31 INFO - 'LOGNAME': 'cltbld', 18:55:31 INFO - 'MAIL': '/var/mail/cltbld', 18:55:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:55:31 INFO - 'MOZ_NO_REMOTE': '1', 18:55:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:55:31 INFO - 'NO_EM_RESTART': '1', 18:55:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:55:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:55:31 INFO - 'PWD': '/builds/slave/test', 18:55:31 INFO - 'SHELL': '/bin/bash', 18:55:31 INFO - 'SHLVL': '1', 18:55:31 INFO - 'TERM': 'linux', 18:55:31 INFO - 'TMOUT': '86400', 18:55:31 INFO - 'USER': 'cltbld', 18:55:31 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1468374756.115701-1499394416', 18:55:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:55:31 INFO - '_': '/tools/buildbot/bin/python'} 18:55:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:55:31 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 18:55:31 INFO - Cleaning up... 18:55:31 INFO - Return code: 0 18:55:31 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:55: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')]} 18:55:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:55:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:55: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')]} 18:55:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:55:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:55: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', '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 0x7f4602b3af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x117b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1248020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12da2e0>, '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 0x1246140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12465d0>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1468374756.115701-1499394416', '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 18:55: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', 'psutil>=3.1.1'] in /builds/slave/test/build 18:55: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 psutil>=3.1.1 18:55:31 INFO - Using env: {'DISPLAY': ':0', 18:55:31 INFO - 'HOME': '/home/cltbld', 18:55:31 INFO - 'LANG': 'en_US.UTF-8', 18:55:31 INFO - 'LANGUAGE': 'en_US:en', 18:55:31 INFO - 'LOGNAME': 'cltbld', 18:55:31 INFO - 'MAIL': '/var/mail/cltbld', 18:55:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:55:31 INFO - 'MOZ_NO_REMOTE': '1', 18:55:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:55:31 INFO - 'NO_EM_RESTART': '1', 18:55:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:55:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:55:31 INFO - 'PWD': '/builds/slave/test', 18:55:31 INFO - 'SHELL': '/bin/bash', 18:55:31 INFO - 'SHLVL': '1', 18:55:31 INFO - 'TERM': 'linux', 18:55:31 INFO - 'TMOUT': '86400', 18:55:31 INFO - 'USER': 'cltbld', 18:55:31 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1468374756.115701-1499394416', 18:55:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:55:31 INFO - '_': '/tools/buildbot/bin/python'} 18:55:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:55:32 INFO - Downloading/unpacking psutil>=3.1.1 18:55:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:55:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:55:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:55:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:55:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:55:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:55:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:55:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:55:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:55:34 INFO - Installing collected packages: psutil 18:55:34 INFO - Running setup.py install for psutil 18:55:34 INFO - building 'psutil._psutil_linux' extension 18:55:34 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 18:55:35 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 18:55:35 INFO - building 'psutil._psutil_posix' extension 18:55:35 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 18:55:35 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 18:55:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:55:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:55:35 INFO - Successfully installed psutil 18:55:35 INFO - Cleaning up... 18:55:35 INFO - Return code: 0 18:55:35 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:55:35 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')]} 18:55:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:55:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:55:35 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')]} 18:55:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:55:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:55:35 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 0x7f4602b3af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x117b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1248020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12da2e0>, '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 0x1246140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12465d0>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1468374756.115701-1499394416', '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 18:55:35 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 18:55:35 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 18:55:35 INFO - Using env: {'DISPLAY': ':0', 18:55:35 INFO - 'HOME': '/home/cltbld', 18:55:35 INFO - 'LANG': 'en_US.UTF-8', 18:55:35 INFO - 'LANGUAGE': 'en_US:en', 18:55:35 INFO - 'LOGNAME': 'cltbld', 18:55:35 INFO - 'MAIL': '/var/mail/cltbld', 18:55:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:55:35 INFO - 'MOZ_NO_REMOTE': '1', 18:55:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:55:35 INFO - 'NO_EM_RESTART': '1', 18:55:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:55:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:55:35 INFO - 'PWD': '/builds/slave/test', 18:55:35 INFO - 'SHELL': '/bin/bash', 18:55:35 INFO - 'SHLVL': '1', 18:55:35 INFO - 'TERM': 'linux', 18:55:35 INFO - 'TMOUT': '86400', 18:55:35 INFO - 'USER': 'cltbld', 18:55:35 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1468374756.115701-1499394416', 18:55:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:55:35 INFO - '_': '/tools/buildbot/bin/python'} 18:55:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:55:35 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:55:35 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 18:55:35 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 18:55:35 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 18:55:35 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 18:55:35 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 18:55:35 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 18:55:37 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:55:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:55:37 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:55:37 INFO - Installing collected packages: mozsystemmonitor 18:55:37 INFO - Running setup.py install for mozsystemmonitor 18:55:37 INFO - Successfully installed mozsystemmonitor 18:55:37 INFO - Cleaning up... 18:55:38 INFO - Return code: 0 18:55:38 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:55:38 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')]} 18:55:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:55:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:55:38 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')]} 18:55:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:55:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:55:38 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 0x7f4602b3af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x117b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1248020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12da2e0>, '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 0x1246140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12465d0>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1468374756.115701-1499394416', '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 18:55:38 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 18:55:38 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 18:55:38 INFO - Using env: {'DISPLAY': ':0', 18:55:38 INFO - 'HOME': '/home/cltbld', 18:55:38 INFO - 'LANG': 'en_US.UTF-8', 18:55:38 INFO - 'LANGUAGE': 'en_US:en', 18:55:38 INFO - 'LOGNAME': 'cltbld', 18:55:38 INFO - 'MAIL': '/var/mail/cltbld', 18:55:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:55:38 INFO - 'MOZ_NO_REMOTE': '1', 18:55:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:55:38 INFO - 'NO_EM_RESTART': '1', 18:55:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:55:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:55:38 INFO - 'PWD': '/builds/slave/test', 18:55:38 INFO - 'SHELL': '/bin/bash', 18:55:38 INFO - 'SHLVL': '1', 18:55:38 INFO - 'TERM': 'linux', 18:55:38 INFO - 'TMOUT': '86400', 18:55:38 INFO - 'USER': 'cltbld', 18:55:38 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1468374756.115701-1499394416', 18:55:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:55:38 INFO - '_': '/tools/buildbot/bin/python'} 18:55:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:55:38 INFO - Downloading/unpacking jsonschema==2.5.1 18:55:38 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 18:55:38 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 18:55:38 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 18:55:38 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 18:55:38 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 18:55:38 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 18:55:40 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:55:40 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:55:40 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 18:55:40 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 18:55:40 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 18:55:40 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 18:55:40 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 18:55:40 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 18:55:40 INFO - Downloading functools32-3.2.3-2.tar.gz 18:55:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:55:40 INFO - warning: no files found matching '*.txt' 18:55:40 INFO - no previously-included directories found matching 'build' 18:55:40 INFO - no previously-included directories found matching 'dist' 18:55:40 INFO - no previously-included directories found matching '.git*' 18:55:40 INFO - Installing collected packages: jsonschema, functools32 18:55:40 INFO - Running setup.py install for functools32 18:55:40 INFO - warning: no files found matching '*.txt' 18:55:40 INFO - no previously-included directories found matching 'build' 18:55:40 INFO - no previously-included directories found matching 'dist' 18:55:40 INFO - no previously-included directories found matching '.git*' 18:55:40 INFO - Successfully installed jsonschema functools32 18:55:40 INFO - Cleaning up... 18:55:40 INFO - Return code: 0 18:55:40 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:55: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')]} 18:55:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:55:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:55: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')]} 18:55:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:55:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:55:40 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 0x7f4602b3af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x117b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1248020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12da2e0>, '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 0x1246140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12465d0>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1468374756.115701-1499394416', '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 18:55:40 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 18:55:40 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 18:55:40 INFO - Using env: {'DISPLAY': ':0', 18:55:40 INFO - 'HOME': '/home/cltbld', 18:55:40 INFO - 'LANG': 'en_US.UTF-8', 18:55:40 INFO - 'LANGUAGE': 'en_US:en', 18:55:40 INFO - 'LOGNAME': 'cltbld', 18:55:40 INFO - 'MAIL': '/var/mail/cltbld', 18:55:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:55:40 INFO - 'MOZ_NO_REMOTE': '1', 18:55:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:55:40 INFO - 'NO_EM_RESTART': '1', 18:55:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:55:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:55:40 INFO - 'PWD': '/builds/slave/test', 18:55:40 INFO - 'SHELL': '/bin/bash', 18:55:40 INFO - 'SHLVL': '1', 18:55:40 INFO - 'TERM': 'linux', 18:55:40 INFO - 'TMOUT': '86400', 18:55:40 INFO - 'USER': 'cltbld', 18:55:40 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1468374756.115701-1499394416', 18:55:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:55:40 INFO - '_': '/tools/buildbot/bin/python'} 18:55:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:55:40 INFO - Downloading/unpacking blobuploader==1.2.4 18:55:40 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 18:55:40 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 18:55:40 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 18:55:40 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 18:55:40 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 18:55:40 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 18:55:42 INFO - Downloading blobuploader-1.2.4.tar.gz 18:55:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:55:42 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:55: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 18:55: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 18:55: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 18:55: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 18:55: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 18:55: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 18:55:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:55:43 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:55:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:55:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:55:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:55:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:55:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:55:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:55:43 INFO - Downloading docopt-0.6.1.tar.gz 18:55:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:55:43 INFO - Installing collected packages: blobuploader, requests, docopt 18:55:43 INFO - Running setup.py install for blobuploader 18:55:43 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:55:43 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:55:43 INFO - Running setup.py install for requests 18:55:44 INFO - Running setup.py install for docopt 18:55:44 INFO - Successfully installed blobuploader requests docopt 18:55:44 INFO - Cleaning up... 18:55:44 INFO - Return code: 0 18:55:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:55: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')]} 18:55:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:55:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:55: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')]} 18:55:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:55:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:55:44 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 0x7f4602b3af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x117b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1248020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12da2e0>, '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 0x1246140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12465d0>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1468374756.115701-1499394416', '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 18:55:44 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 18:55:44 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 18:55:44 INFO - Using env: {'DISPLAY': ':0', 18:55:44 INFO - 'HOME': '/home/cltbld', 18:55:44 INFO - 'LANG': 'en_US.UTF-8', 18:55:44 INFO - 'LANGUAGE': 'en_US:en', 18:55:44 INFO - 'LOGNAME': 'cltbld', 18:55:44 INFO - 'MAIL': '/var/mail/cltbld', 18:55:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:55:44 INFO - 'MOZ_NO_REMOTE': '1', 18:55:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:55:44 INFO - 'NO_EM_RESTART': '1', 18:55:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:55:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:55:44 INFO - 'PWD': '/builds/slave/test', 18:55:44 INFO - 'SHELL': '/bin/bash', 18:55:44 INFO - 'SHLVL': '1', 18:55:44 INFO - 'TERM': 'linux', 18:55:44 INFO - 'TMOUT': '86400', 18:55:44 INFO - 'USER': 'cltbld', 18:55:44 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1468374756.115701-1499394416', 18:55:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:55:44 INFO - '_': '/tools/buildbot/bin/python'} 18:55:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:55:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:55:44 INFO - Running setup.py (path:/tmp/pip-H0xs2K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:55:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:55:44 INFO - Running setup.py (path:/tmp/pip-V1p26o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:55:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:55:44 INFO - Running setup.py (path:/tmp/pip-KGaPT4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:55:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:55:44 INFO - Running setup.py (path:/tmp/pip-A54mEI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:55:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:55:44 INFO - Running setup.py (path:/tmp/pip-0uQPLi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:55:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:55:44 INFO - Running setup.py (path:/tmp/pip-GxSwiX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:55:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:55:44 INFO - Running setup.py (path:/tmp/pip-SJESfz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:55:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:55:45 INFO - Running setup.py (path:/tmp/pip-u_JEyX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:55:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:55:45 INFO - Running setup.py (path:/tmp/pip-SOx3yw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:55:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:55:45 INFO - Running setup.py (path:/tmp/pip-7Zotht-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:55:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:55:45 INFO - Running setup.py (path:/tmp/pip-mairtH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:55:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:55:45 INFO - Running setup.py (path:/tmp/pip-68rneR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:55:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:55:45 INFO - Running setup.py (path:/tmp/pip-aFMavR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:55:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:55:45 INFO - Running setup.py (path:/tmp/pip-8sf6NB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:55:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:55:45 INFO - Running setup.py (path:/tmp/pip-C33QG8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:55:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:55:45 INFO - Running setup.py (path:/tmp/pip-eW_DWI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:55:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:55:45 INFO - Running setup.py (path:/tmp/pip-semW3c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:55:45 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:55:45 INFO - Running setup.py install for manifestparser 18:55:45 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:55:45 INFO - Running setup.py install for mozcrash 18:55:45 INFO - Running setup.py install for mozdebug 18:55:46 INFO - Running setup.py install for mozdevice 18:55:46 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:55:46 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:55:46 INFO - Running setup.py install for mozfile 18:55:46 INFO - Running setup.py install for mozhttpd 18:55:46 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:55:46 INFO - Running setup.py install for mozinfo 18:55:46 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:55:46 INFO - Running setup.py install for mozInstall 18:55:46 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:55:46 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:55:46 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:55:46 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:55:46 INFO - Running setup.py install for mozleak 18:55:46 INFO - Running setup.py install for mozlog 18:55:46 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:55:46 INFO - Running setup.py install for moznetwork 18:55:46 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:55:46 INFO - Running setup.py install for mozprocess 18:55:46 INFO - Running setup.py install for mozprofile 18:55:47 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:55:47 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:55:47 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:55:47 INFO - Running setup.py install for mozrunner 18:55:47 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:55:47 INFO - Running setup.py install for mozscreenshot 18:55:47 INFO - Running setup.py install for moztest 18:55:47 INFO - Running setup.py install for mozversion 18:55:47 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:55:47 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:55:47 INFO - Cleaning up... 18:55:47 INFO - Return code: 0 18:55:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:55:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:55:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:55:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:55:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:55:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:55:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:55:47 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 0x7f4602b3af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x117b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1248020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12da2e0>, '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 0x1246140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12465d0>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1468374756.115701-1499394416', '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 18:55:47 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 18:55:47 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 18:55:47 INFO - Using env: {'DISPLAY': ':0', 18:55:47 INFO - 'HOME': '/home/cltbld', 18:55:47 INFO - 'LANG': 'en_US.UTF-8', 18:55:47 INFO - 'LANGUAGE': 'en_US:en', 18:55:47 INFO - 'LOGNAME': 'cltbld', 18:55:47 INFO - 'MAIL': '/var/mail/cltbld', 18:55:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:55:47 INFO - 'MOZ_NO_REMOTE': '1', 18:55:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:55:47 INFO - 'NO_EM_RESTART': '1', 18:55:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:55:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:55:47 INFO - 'PWD': '/builds/slave/test', 18:55:47 INFO - 'SHELL': '/bin/bash', 18:55:47 INFO - 'SHLVL': '1', 18:55:47 INFO - 'TERM': 'linux', 18:55:47 INFO - 'TMOUT': '86400', 18:55:47 INFO - 'USER': 'cltbld', 18:55:47 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1468374756.115701-1499394416', 18:55:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:55:47 INFO - '_': '/tools/buildbot/bin/python'} 18:55:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:55:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:55:47 INFO - Running setup.py (path:/tmp/pip-NA8IHu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:55:47 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)) 18:55:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:55:47 INFO - Running setup.py (path:/tmp/pip-ulrG_i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:55:47 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)) 18:55:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:55:47 INFO - Running setup.py (path:/tmp/pip-ZMi4UK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:55:47 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)) 18:55:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:55:47 INFO - Running setup.py (path:/tmp/pip-wJGTjI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:55:48 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)) 18:55:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:55:48 INFO - Running setup.py (path:/tmp/pip-M6v3Bw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:55:48 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)) 18:55:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:55:48 INFO - Running setup.py (path:/tmp/pip-KPbmx5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:55:48 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)) 18:55:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:55:48 INFO - Running setup.py (path:/tmp/pip-6z87uh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:55:48 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)) 18:55:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:55:48 INFO - Running setup.py (path:/tmp/pip-ETC7ru-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:55:48 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)) 18:55:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:55:48 INFO - Running setup.py (path:/tmp/pip-6Fd1zw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:55:48 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)) 18:55:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:55:48 INFO - Running setup.py (path:/tmp/pip-447o4P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:55:48 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)) 18:55:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:55:48 INFO - Running setup.py (path:/tmp/pip-6NisNR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:55:48 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)) 18:55:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:55:48 INFO - Running setup.py (path:/tmp/pip-L5eioF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:55:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 18:55:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:55:48 INFO - Running setup.py (path:/tmp/pip-4Ff37m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:55:48 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)) 18:55:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:55:48 INFO - Running setup.py (path:/tmp/pip-kX5n8I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:55:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 18:55:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:55:48 INFO - Running setup.py (path:/tmp/pip-ciFUPv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:55:48 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)) 18:55:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:55:48 INFO - Running setup.py (path:/tmp/pip-9toGzY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:55:48 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)) 18:55:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:55:48 INFO - Running setup.py (path:/tmp/pip-ALD3pw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:55:48 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)) 18:55:48 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)) 18:55:48 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)) 18:55:48 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)) 18:55:48 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)) 18:55:48 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)) 18:55:48 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:55:48 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 18:55:48 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 18:55:48 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 18:55:48 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 18:55:48 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 18:55:48 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 18:55:50 INFO - Downloading blessings-1.6.tar.gz 18:55:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:55:50 INFO - Installing collected packages: blessings 18:55:50 INFO - Running setup.py install for blessings 18:55:51 INFO - Successfully installed blessings 18:55:51 INFO - Cleaning up... 18:55:51 INFO - Return code: 0 18:55:51 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:55:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:55:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:55:51 INFO - Reading from file tmpfile_stdout 18:55:51 INFO - Current package versions: 18:55:51 INFO - argparse == 1.2.1 18:55:51 INFO - blessings == 1.6 18:55:51 INFO - blobuploader == 1.2.4 18:55:51 INFO - docopt == 0.6.1 18:55:51 INFO - functools32 == 3.2.3-2 18:55:51 INFO - jsonschema == 2.5.1 18:55:51 INFO - manifestparser == 1.1 18:55:51 INFO - mozInstall == 1.12 18:55:51 INFO - mozcrash == 0.17 18:55:51 INFO - mozdebug == 0.1 18:55:51 INFO - mozdevice == 0.48 18:55:51 INFO - mozfile == 1.2 18:55:51 INFO - mozhttpd == 0.7 18:55:51 INFO - mozinfo == 0.9 18:55:51 INFO - mozleak == 0.1 18:55:51 INFO - mozlog == 3.2 18:55:51 INFO - moznetwork == 0.27 18:55:51 INFO - mozprocess == 0.23 18:55:51 INFO - mozprofile == 0.28 18:55:51 INFO - mozrunner == 6.12 18:55:51 INFO - mozscreenshot == 0.1 18:55:51 INFO - mozsystemmonitor == 0.3 18:55:51 INFO - moztest == 0.7 18:55:51 INFO - mozversion == 1.4 18:55:51 INFO - psutil == 3.1.1 18:55:51 INFO - requests == 1.2.3 18:55:51 INFO - wsgiref == 0.1.2 18:55:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:55:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:55:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:55:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:55:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:55:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:55:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:55:51 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 0x7f4602b3af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x117b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1248020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12da2e0>, '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 0x1246140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12465d0>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1468374756.115701-1499394416', '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 18:55:51 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 18:55:51 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 18:55:51 INFO - Using env: {'DISPLAY': ':0', 18:55:51 INFO - 'HOME': '/home/cltbld', 18:55:51 INFO - 'LANG': 'en_US.UTF-8', 18:55:51 INFO - 'LANGUAGE': 'en_US:en', 18:55:51 INFO - 'LOGNAME': 'cltbld', 18:55:51 INFO - 'MAIL': '/var/mail/cltbld', 18:55:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:55:51 INFO - 'MOZ_NO_REMOTE': '1', 18:55:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:55:51 INFO - 'NO_EM_RESTART': '1', 18:55:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:55:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:55:51 INFO - 'PWD': '/builds/slave/test', 18:55:51 INFO - 'SHELL': '/bin/bash', 18:55:51 INFO - 'SHLVL': '1', 18:55:51 INFO - 'TERM': 'linux', 18:55:51 INFO - 'TMOUT': '86400', 18:55:51 INFO - 'USER': 'cltbld', 18:55:51 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1468374756.115701-1499394416', 18:55:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:55:51 INFO - '_': '/tools/buildbot/bin/python'} 18:55:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:55:51 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)) 18:55:51 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)) 18:55:51 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)) 18:55:51 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)) 18:55:51 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)) 18:55:51 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)) 18:55:51 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)) 18:55:51 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)) 18:55:51 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)) 18:55:51 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)) 18:55:51 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)) 18:55:51 INFO - Cleaning up... 18:55:51 INFO - Return code: 0 18:55:51 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:55:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:55:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:55:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:55:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:55:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:55:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:55:51 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 0x7f4602b3af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x117b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1248020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12da2e0>, '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 0x1246140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12465d0>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1468374756.115701-1499394416', '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 18:55:51 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 18:55:51 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 18:55:51 INFO - Using env: {'DISPLAY': ':0', 18:55:51 INFO - 'HOME': '/home/cltbld', 18:55:51 INFO - 'LANG': 'en_US.UTF-8', 18:55:51 INFO - 'LANGUAGE': 'en_US:en', 18:55:51 INFO - 'LOGNAME': 'cltbld', 18:55:51 INFO - 'MAIL': '/var/mail/cltbld', 18:55:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:55:51 INFO - 'MOZ_NO_REMOTE': '1', 18:55:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:55:51 INFO - 'NO_EM_RESTART': '1', 18:55:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:55:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:55:51 INFO - 'PWD': '/builds/slave/test', 18:55:51 INFO - 'SHELL': '/bin/bash', 18:55:51 INFO - 'SHLVL': '1', 18:55:51 INFO - 'TERM': 'linux', 18:55:51 INFO - 'TMOUT': '86400', 18:55:51 INFO - 'USER': 'cltbld', 18:55:51 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1468374756.115701-1499394416', 18:55:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:55:51 INFO - '_': '/tools/buildbot/bin/python'} 18:55:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:55:51 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:55:51 INFO - Cleaning up... 18:55:51 INFO - Return code: 0 18:55:51 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 18:55:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:55:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:55:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:55:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:55:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:55:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:55:51 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 0x7f4602b3af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x117b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1248020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12da2e0>, '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 0x1246140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12465d0>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1468374756.115701-1499394416', '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 18:55:51 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 18:55:51 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 18:55:51 INFO - Using env: {'DISPLAY': ':0', 18:55:51 INFO - 'HOME': '/home/cltbld', 18:55:51 INFO - 'LANG': 'en_US.UTF-8', 18:55:51 INFO - 'LANGUAGE': 'en_US:en', 18:55:51 INFO - 'LOGNAME': 'cltbld', 18:55:51 INFO - 'MAIL': '/var/mail/cltbld', 18:55:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:55:51 INFO - 'MOZ_NO_REMOTE': '1', 18:55:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:55:51 INFO - 'NO_EM_RESTART': '1', 18:55:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:55:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:55:51 INFO - 'PWD': '/builds/slave/test', 18:55:51 INFO - 'SHELL': '/bin/bash', 18:55:51 INFO - 'SHLVL': '1', 18:55:51 INFO - 'TERM': 'linux', 18:55:51 INFO - 'TMOUT': '86400', 18:55:51 INFO - 'USER': 'cltbld', 18:55:51 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1468374756.115701-1499394416', 18:55:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:55:51 INFO - '_': '/tools/buildbot/bin/python'} 18:55:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:55:51 INFO - Downloading/unpacking flake8 18:55:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:55:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:55:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:55:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:55:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:55:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:55:54 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 18:55:54 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 18:55:54 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 18:55:54 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 18:55:54 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 18:55:54 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 18:55:54 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 18:55:54 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 18:55:54 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 18:55:54 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 18:55:54 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 18:55:54 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 18:55:54 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 18:55:54 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 18:55:54 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 18:55:54 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 18:55:54 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 18:55:54 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 18:55:54 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 18:55:54 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 18:55:54 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 18:55:54 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 18:55:54 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 18:55:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 18:55:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:55:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:55:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:55:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:55:54 INFO - no previously-included directories found matching 'docs/_build' 18:55:54 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 18:55:54 INFO - Running setup.py install for pep8 18:55:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:55:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:55:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:55:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:55:54 INFO - no previously-included directories found matching 'docs/_build' 18:55:54 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 18:55:54 INFO - Successfully installed flake8 mccabe pyflakes pep8 18:55:54 INFO - Cleaning up... 18:55:55 INFO - Return code: 0 18:55:55 INFO - Running post-action listener: _resource_record_post_action 18:55:55 INFO - Running post-action listener: _start_resource_monitoring 18:55:55 INFO - Starting resource monitoring. 18:55:55 INFO - ##### 18:55:55 INFO - ##### Finished create-virtualenv step (success) 18:55:55 INFO - ##### 18:55:55 INFO - ##### 18:55:55 INFO - ##### Running install step. 18:55:55 INFO - ##### 18:55:55 INFO - Running pre-action listener: _resource_record_pre_action 18:55:55 INFO - Running main action method: install 18:55:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:55:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:55:55 INFO - Reading from file tmpfile_stdout 18:55:55 INFO - Detecting whether we're running mozinstall >=1.0... 18:55:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:55:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:55:55 INFO - Reading from file tmpfile_stdout 18:55:55 INFO - Output received: 18:55:55 INFO - Usage: mozinstall [options] installer 18:55:55 INFO - Options: 18:55:55 INFO - -h, --help show this help message and exit 18:55:55 INFO - -d DEST, --destination=DEST 18:55:55 INFO - Directory to install application into. [default: 18:55:55 INFO - "/builds/slave/test"] 18:55:55 INFO - --app=APP Application being installed. [default: firefox] 18:55:55 INFO - mkdir: /builds/slave/test/build/application 18:55:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 18:55:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 18:56:10 INFO - Reading from file tmpfile_stdout 18:56:10 INFO - Output received: 18:56:10 INFO - /builds/slave/test/build/application/firefox/firefox 18:56:11 INFO - Running post-action listener: _resource_record_post_action 18:56:11 INFO - ##### 18:56:11 INFO - ##### Finished install step (success) 18:56:11 INFO - ##### 18:56:11 INFO - ##### 18:56:11 INFO - ##### Running run-tests step. 18:56:11 INFO - ##### 18:56:11 INFO - Running pre-action listener: _resource_record_pre_action 18:56:11 INFO - Running main action method: run_tests 18:56:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:56:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:56:11 INFO - Python 2.7.3 18:56:11 INFO - Return code: 0 18:56:11 INFO - grabbing minidump binary from tooltool 18:56:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:56:11 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 0x12da2e0>, '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 0x1246140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12465d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:56:11 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 18:56:11 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 18:56:11 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 18:56:11 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:56:11 INFO - Return code: 0 18:56:11 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:56:11 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:56:11 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:56:11 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:56:11 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:56:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 18:56:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 18:56:12 INFO - Return code: 0 18:56:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Nn3JUOTFQjyO9V21Tv3zsA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-037', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 18:56:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Nn3JUOTFQjyO9V21Tv3zsA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-037 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 18:56:12 INFO - Using env: {'DISPLAY': ':0', 18:56:12 INFO - 'HOME': '/home/cltbld', 18:56:12 INFO - 'LANG': 'en_US.UTF-8', 18:56:12 INFO - 'LANGUAGE': 'en_US:en', 18:56:12 INFO - 'LOGNAME': 'cltbld', 18:56:12 INFO - 'MAIL': '/var/mail/cltbld', 18:56:12 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:56:12 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:56:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:56:12 INFO - 'MOZ_NO_REMOTE': '1', 18:56:12 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:56:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:56:12 INFO - 'NO_EM_RESTART': '1', 18:56:12 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:56:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:56:12 INFO - 'PWD': '/builds/slave/test', 18:56:12 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:56:12 INFO - 'SHELL': '/bin/bash', 18:56:12 INFO - 'SHLVL': '1', 18:56:12 INFO - 'TERM': 'linux', 18:56:12 INFO - 'TMOUT': '86400', 18:56:12 INFO - 'USER': 'cltbld', 18:56:12 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1468374756.115701-1499394416', 18:56:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:56:12 INFO - '_': '/tools/buildbot/bin/python'} 18:56:12 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Nn3JUOTFQjyO9V21Tv3zsA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-037', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 18:56:12 INFO - mozversion application_buildid: 20160712160625 18:56:12 INFO - mozversion application_changeset: bd3207c8ef3811b55e2073248c6ca39576fcf3a6 18:56:12 INFO - mozversion application_display_name: FirefoxDeveloperEdition 18:56:12 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:56:12 INFO - mozversion application_name: Firefox 18:56:12 INFO - mozversion application_remotingname: firefox-dev 18:56:12 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 18:56:12 INFO - mozversion application_vendor: Mozilla 18:56:12 INFO - mozversion application_version: 49.0a2 18:56:12 INFO - mozversion platform_buildid: 20160712160625 18:56:12 INFO - mozversion platform_changeset: bd3207c8ef3811b55e2073248c6ca39576fcf3a6 18:56:12 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 18:56:12 INFO - mozversion platform_version: 49.0a2 18:56:12 INFO - using testdate: 1468374972 18:56:12 INFO - actual date: 1468374972 18:56:12 INFO - starting webserver on 'localhost:59764' 18:56:12 INFO - SUITE-START | Running 2 tests 18:56:12 INFO - TEST-START | dromaeo_css 18:56:12 INFO - operating with platform_type : linux_ 18:56:12 INFO - Initialising browser for dromaeo_css test... 18:56:12 INFO - TEST-INFO | started process 3318 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6AlK_O/profile http://localhost:59764/getInfo.html) 18:56:17 INFO - PROCESS | 3318 | __metrics Screen width/height:1600/1200 18:56:17 INFO - PROCESS | 3318 | colorDepth:24 18:56:17 INFO - PROCESS | 3318 | Browser inner width/height: 1024/697 18:56:17 INFO - PROCESS | 3318 | __metrics 18:56:19 ERROR - PROCESS | 3318 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 18:56:20 INFO - TEST-INFO | 3318: exit 0 18:56:20 INFO - Browser initialized. 18:56:20 INFO - Running cycle 1/1 for dromaeo_css test... 18:56:20 INFO - TEST-INFO | started process 3410 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6AlK_O/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:56:31 INFO - PROCESS | 3410 | RSS: Main: 145866752 18:56:31 INFO - PROCESS | 3410 | 18:57:22 INFO - PROCESS | 3410 | 1468375042846 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] 18:59:30 INFO - PROCESS | 3410 | Cycle 1(1): loaded http://localhost:59764/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59764/tests/dromaeo/cssquery-ext.html) 18:59:31 INFO - PROCESS | 3410 | RSS: Main: 243822592 18:59:31 INFO - PROCESS | 3410 | 19:02:33 INFO - PROCESS | 3410 | Cycle 1(1): loaded http://localhost:59764/tests/dromaeo/cssquery-ext.html (next: http://localhost:59764/tests/dromaeo/cssquery-jquery.html) 19:02:34 INFO - PROCESS | 3410 | RSS: Main: 230707200 19:02:34 INFO - PROCESS | 3410 | 19:05:36 INFO - PROCESS | 3410 | Cycle 1(1): loaded http://localhost:59764/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59764/tests/dromaeo/cssquery-mootools.html) 19:05:36 INFO - PROCESS | 3410 | RSS: Main: 229122048 19:05:36 INFO - PROCESS | 3410 | 19:08:38 INFO - PROCESS | 3410 | Cycle 1(1): loaded http://localhost:59764/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59764/tests/dromaeo/cssquery-prototype.html) 19:08:39 INFO - PROCESS | 3410 | RSS: Main: 222695424 19:08:39 INFO - PROCESS | 3410 | 19:11:42 INFO - PROCESS | 3410 | Cycle 1(1): loaded http://localhost:59764/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59764/tests/dromaeo/cssquery-yui.html) 19:11:42 INFO - PROCESS | 3410 | RSS: Main: 213217280 19:11:42 INFO - PROCESS | 3410 | 19:14:45 INFO - PROCESS | 3410 | Cycle 1(1): loaded http://localhost:59764/tests/dromaeo/cssquery-yui.html (next: http://localhost:59764/tests/dromaeo/cssquery-dojo.html) 19:14:45 INFO - PROCESS | 3410 | RSS: Main: 268034048 19:14:45 INFO - PROCESS | 3410 | 19:14:45 INFO - PROCESS | 3410 | __start_tp_report 19:14:45 INFO - PROCESS | 3410 | _x_x_mozilla_page_load 19:14:45 INFO - PROCESS | 3410 | _x_x_mozilla_page_load_details 19:14:45 INFO - PROCESS | 3410 | |i|pagename|runs| 19:14:45 INFO - PROCESS | 3410 | |0;dojo.html;3144.4340018796615;3145.5124455709374;3166.2401023754305;3166.3034132490843;3195.520671899215;4770.451398089221;4839.3224948507195;4870.464248932623;4881.1213981483315;4886.36477257956;4842.104210721019;4849.36958195435;4870.147724148278;4873.122837889178;4885.755712214384;4366.148601022802;4439.600435960763;4479.955200447995;4493.438320209973;4537.659675524333;4484.775761211943;4493.46078470584;4496.595306422421;4524.140413321475;4528.275475923853;4458.687891847572;4481.932771008437;4500.324951257305;4515.3227015947705;4528.094381123772;4576.83981060663;4584.977075114603;4585.816567337302;4588.128255631419;4617.284320930261;4376.518582955872;4441.444819397575;4467.039586488888;4520.095980803852;4541.137183935041;4640.443146822369;4640.721556706575;4662;4690.671652984258;4699.342092107107;5142.357205349332;5144.356955380577;5183.45573714762;5185.222216667492;5192.013517431714;5117.872053198663;5153.149730294497;5154.92267615986;5167.612429067835;5213.27014218006;4865.95134048655;4905.264210368473;4917.680350777188;4917.704937703714;4919.163742163805;5152.227165925066;5291.973540132351;5302.09864323066;5302.628815982921;5307.416184219733;5095.821646242438;5119.948800511947;5184.066867963803;5189.221616757516;5193.870153246199;5207.661502002357;5208.765605547759;5218.817341393033;5233.188855727369;5235.685858848481;4964;5084.8220312288895;5173.508516690984;5187.299714538564;5188.507091826271;5084.211947148198;5116.053530096944;5120.103981803244;5150.896982060338;5166.793328266903;4156.605122513356;4157.189348077096;4163.625273725319;4187.120704651997;4193.391958166048;3681.9079523012138;3688.3176612326806;3705.4256590228556;3762.3792074307435;3794.29805485986;4923.261510773341;4926.45808961014;4944.876378090505;4945.950540494549;4950.034743225108;5111.693298402108;5113.667611605234;5116.488351164854;5128.538431541179;5140.100482415637;4867.9269810952865;4932.28481870134;4947.604191664658;4970.204767237297;5003.5997120230295;4582.9312560310955;4592.03567250881;4595.195840727859;4601.44782626087;4628.699134556243;5426.403095659474;5463.019331144349;5464.28964234647;5468.7539060742365;5471.206675032098;5024.57291130258;5056.6713163644245;5063.3417655704525;5089.51649593288;5147.253648221062;5352.197170424468;5399.622026458111;5426.0504411727;5442.238086667949;5442.4285450028765;5050.469700681376;5088.6946783193125;5094.439611642642;5109.514596113363;5125.8718532037;5024.120778863758;5137.023965446553;5153.845384638467;5172.612054095883;5205.6616319939085;5087.771050302819;5089.3638295213095;5091.465396133352;5092.185250359925;5119.897602047864;4907;5079.796808127633;5091.770870310919;5092.490750924878;5095.745212739423;4944.8763780905765;4967.379077615298;4993.550580447632;4998.175301075282;5020.121478741279;5100.183970564692;5104;5124.923126153036;5129.281900533853;5129.948700513097;4870.537298956593;4930.6795058321095;5013.172826483589;5013.6490445669915;5033.496650335083 19:14:45 INFO - PROCESS | 3410 | |1;ext.html;603.6619493083873;625.1841347042108;637.1716768201338;639.8208501619548;645.216062484082;33917.15207119823;36625.26749465012;44733;45587.77206113973;45806.541934580644;48405;48719;48838.51161488384;48852.267215991786;48917.26624100633;8174.3460523158;9063.229625481841;9215.723528294162;9224.07759224079;9232.261419086457;8124.22819832115;8195.71315003975;10915.672529824118;11183.217174797768;11193.992540671337;10953.34279943202;10995.505202265917;10999.560017599286;11008.504617292201;11009.504572294227;8107.391945604103;10982.176336774733;11051.115910727123;11054.392008439532;11068.833967490455;10691.30506517074;11098.44507774608;11101.944490277498;11105.500252488657;11447.713807154805;42025.78987105045;42778;46525;46595;46598.301025484645;3674.6692797648075;3710.18375957289;3847.942280865789;3890.1830615570766;3928.214357128557;34644.82677586621;35121.297574048374;35473.46789798155;35847.64152358495;35990;4445.799939002753;4450.132224216279;4471.217536931024;4540.114677637862;4596.241620132674;368716;370763;370890;373287;374519;38737;68584.31415685879;68854;69079;69349.65325173443;39598.60401396007;41917.79041104836;42111.36832947508;42122.15755684869;42185;15680.372785088468;15781.36874525029;15790.605234869221;15795.289211985488;15797.68404631901;12398.194117382342;12649.494020239272;13625.386857591433;13686;13719.1082579632;9287.489188094585;9451.716448506555;9551.474668893277;9636.855447168298;9680.709578712509;3596.3166998270244;3625.5649322081517;3637.654422829827;3648.9817550912076;3708.740388172856;1062.923687657841;1089.2103225161695;1157.7279339355414;1171.841801356806;1198.7003249187703;34399.31201375958;34948.65051349505;34988.30023399518;35016.299674006375;35218.295634087175;1184.703824043989;1209.8911098001222;1223.8409006829233;1226.7669142862828;1269.904757143218;17932.462026138975;18519.35182268614;18578.814211857978;18667.626647467245;18672.25310987545;652408;655412;659785;660436;660968;64359.35640643627;64515.354846451875;64744.35255647383;64811.67594161999;65005.67497162484;1311.114997376767;1423.6546463591806;1439.4673970630934;1455.679750454877;1463.9194844283454;34394.82802585971;35200.82399587986;36061.09847253735;36259.637403625624;36507.634923650425;55154.72422637861;55682;55763;55845.44154558565;55919;434252;438294;438701;438945;438963;27400.177994660193;30233.546496803006;31163.220919477193;31264.374712505167;32709.20099394556;50252.246216306055;50267;52244.47755522396;52661.47338526566;56009.15986260128;44162.779186103864;44774.3283850749;44864.32703509385;45063;46128.30807537823;42699;43429;43794;44172.337414939444;44674;45117.54882451134;45185.32222016607;45806.31290530712;45853.082938341715;46331.53668463272;37884.43173352457;39363.21273574455;39631.40552891651;40197.1960560793;40298;29388.412231755672;29813.403731925675;29834.701652983193;29994.850025749733;30084.097477075724 19:14:45 INFO - PROCESS | 3410 | |2;jquery.html;418.26176797951604;421.76591991444747;424.7111963864573;432.3773765777282;434.6957130008994;18622.720659190105;19032.429027129172;19203.231870725172;20104.899475502603;20599.1760329587;18386;18813.905930470362;18902.338418155367;19100.713489297672;19243.23027078915;5344.973275133629;5598.916016259759;5603.691796951186;5616.494515493605;5617.157426386034;4134.64855487284;5639.520640745542;5741.282339707536;6006.399360063981;6314.842128946767;6397.1683681121385;6408.679566021704;6414.615123092606;6423.7430502779835;6428.19647544057;6135.325114237453;6354.205724284465;6372.7132279047555;6376.840578985516;6383.202099737533;3802.714796390254;5386.111291636876;5688.544916406678;5701.230333904911;5706.258186435737;23379.298621041227;23549.94025268867;23800;23942.880285598636;23950.28149155528;2444.3889027743066;2501.9249422517355;2592.235290589281;2745.835249884993;2959.7632189424794;14008.85991140096;14772.409103635842;14828.3327250274;14863.70272594542;15338.156401397919;2041.5100375909824;2053.1068984991575;2054.876707397561;2127.861688990226;2183.15948359881;77238.6138069306;77447.6127619364;77664.22335776627;79307.6034619829;80197;11026.283291586182;11175.21773475849;11390.601328953448;11630.302181869114;11650.067994560415;16077.437289694804;16128.193590320438;16277.104759238118;16281.674366512603;16288.755668664979;8164.836703265902;8401.327893768606;8420.53687047206;8527.616257268437;8545.401821872534;7949.562774047367;7979.960100199578;8072.636731347104;8107.83784324322;8113.432059755878;7003.439724822104;7010.719571217196;7065.50541462103;7118.893216601755;7142.107236595426;1799.9550011249823;1825.963193104781;1923.5960448305732;2058.197303051811;2079.4593405714622;995.6714284286168;1055.5619417941468;1083.5557421457322;1121.6820236222568;1139.658102569226;19193.90403047976;19471.70489789212;19983.20067197325;20243.190272389234;20467.8976605116;1078.8975047370486;1105.5246244115108;1140.8802075781923;1190.9702257443632;1197.26368283505;11406.144539159597;11664.300141991507;11708.590199342982;11739.823902641467;11751.47118379675;512413;520631;533205;539821;539982;82134;84765;85581;86167.56916215378;87495.12504874996;952.9952350238343;982.4301904895144;1063.7606538528923;1083.7561548651647;1099.2689861242345;16721;17364.73952890733;17460.30158793634;17509.38717144894;17963.7867674407;37145.628543714214;38092.42861357137;40577.594224058565;40799.38800917929;40847.591524084375;53329.733351332994;53380;54181;54428.45571544234;54565.18152227799;8682.175193356621;9046.502442365732;9056.13966673165;9057.637694492147;9230.030846761261;13079.476820927057;13203.207807531195;13212;13219.603411897659;13259.204447733167;11257.831132532854;11598.652040438801;11637.185397022127;11714.941425292818;11798.056155507367;11416.714582135513;11562.94218528902;11577.59478418285;11644.2431241969;11713.531458741554;11653.76692466163;11859.288442693465;11927.880721192678;11975.580854670394;12063.276203427822;7641.57971311561;8090.514569125871;8112.797180070545;8970.10298970124;8997.190252877272;9048.547572621474;11680.70798230051;11723.648290551297;11891.464884080064;12056.156069075432 19:14:45 INFO - PROCESS | 3410 | |3;mootools.html;1331.4674130347853;1533.6855944531371;1554.4093244567064;1718.278323104296;1878.736976823244;7983.9201607983905;8796.516191609468;8964.50695211764;8969.775755606113;9242;8886.644534218623;9048.864267036;9052.90947090529;9061.456312621247;9065.04816994216;2117.798809113132;2438;2449.9510009799837;2481.789047930928;2501.849889006656;2482.8137889658256;2489.0790407549143;2516.6225066240117;2521.0546045233036;2522.054229663876;2426.065964603623;2427.5387676341525;2429.7205821330595;2432.2581612608146;2441.645961335605;2025.5037515808647;2371.0515793682493;2437.6709144265474;2440.585100532896;2441.316431399211;2445.3519817248443;2449.317996793526;2475.2945410557904;2533.505966336565;2538.0862889359814;9228.307876909192;9290.581923813445;9298.72103836886;9308.581113849894;9329.906700932972;5233.947660523422;5375;5378.085725426687;5381.381141168777;5385;3289.407906576815;3315.055209265348;3351.4302568563403;3437.226624009603;3477.94783078254;1129.8305254211853;1130.4856290387936;1160.373398364882;1162.7965106106483;1187.8277649740826;13025.804612930813;13290.800637990438;13321.333933303296;13330.200187988654;13330.800037999437;4804.8318308859025;4849.175640141185;4914.311996320518;4929.457759646436;4962.60299176065;11172.888271117346;11239.943800280946;11242.775144497064;11245.943770281096;11272.323660580392;4907.288443175719;5537;5540.2243685884005;5541.722913854291;5546.362168350611;4563.612092972135;4681.438227412732;4684.320773487825;4903.901921961541;5043.117454445457;4098.381139449901;4124.52567954689;4135.234981528427;4183.372494125844;4184.581541845791;1162.5291756838494;1164.0745607242263;1172.302480024384;1174.9588764393204;1272.4528452765214;952.2001518724305;981.8036392721484;1004.8241557727368;1014.3102690170607;1022.3712416863575;5905.025670764362;5971.671558064349;6181.907271390933;6236.688165591702;6361.650109244036;456.1242414564045;462.858828057439;468.6526237068428;495.2175562611066;497.5074676070664;4055.9594404055583;4117.629413352813;4158.979205103955;4197.811098500575;4267.125239325931;11403.42982850854;11803.704907377385;11908.761824763456;11931.926126648643;11935.52257909674;11729.765404691858;11745.060395168366;11749.177557571058;11755.177137600456;11768.411579420994;8360.247577717913;8637.395382323302;8678.826423471495;8768.736937891874;8773.561321933877;6099.725512351866;6160.599561028519;6227.844303892439;6274.780382686584;6317.336679648571;10467.738306542398;10798.784024319626;10979.231453798477;10981.83527247076;11082.445877706245;10863.402512861552;11076.335419874833;11108.777824443627;11118.166137539554;11231.326120432801;7637.770866874002;8069.47548409375;8266.586670666322;8373.246407823324;8475.279601233964;9186.035466275946;9220.124088211609;9238.214751746176;9284.118008789153;9293.117153870371;8180.14108518597;8288.751337459886;8361.456505327134;8406.369522285975;8461.703840365557;7948.642311095899;8022.679092836454;8040.839183216186;8086.191380862102;8329.250367466957;7533.209013053551;7554.773356799085;7558.735444259424;7616.504927179715;7700.3454706350585;4929.211326187793;4977.427595826526;5001;5039.546440820343;5047.596192304533;5035.974820125876;5062.417821950523;5089.847304580869;5100.336956195671;5115.693058416507 19:14:45 INFO - PROCESS | 3410 | |4;prototype.html;358.7309517861604;360.6177451900985;363.3205904957729;366.57843479997985;371.037158573502;4939.629527785417;4975.253711943201;4980.27785971034;5000.649954503182;5002.849914502566;4939.728314942677;4944.579710724593;4953.405591329046;4963.776630051647;4969.5030496950285;3845.5193100862393;3956.663683586884;4034.2334956358272;4043.3934909763475;4072;3966.9206615867665;3992.361222204448;4007.819648115827;4008.7394319369146;4035.47538819953;3822.923541529168;3974.5627980922077;3980.104476492795;3987;4000.439938408625;3847.0959324558708;3970.2059588082498;3982.4424580558743;3984.860529881469;4015.6185162409815;3617.8733744318824;3618.855245790165;3633.6555474474612;3640.8725694600826;3641.3991691370893;4539.364488971547;4613.538646135359;4681.180793361148;4733.502982186856;4738.881527961794;4500.549945005473;4513.119941611387;4518.774061296922;4527.9359350552595;4528.954710452919;5145.819896303648;5185.688858668492;5186.118359878829;5206.114960456732;5218.921716174261;3864.478295430109;3945.6646185074305;3946.3093958557424;3946.467226924357;3952.505936757905;5300.09898317287;5305.7612407441375;5306.204069389584;5327.360716713981;5336.226247194135;4005.8798236052967;4012.4583181270154;4023.416604592376;4026.7986600670433;4044.8988775280263;4048.190361927567;4070.592940705965;4074.6332830044844;4083.632473077437;4097.467329247179;4360.7819609019425;4495.595396414273;4500.729956202638;4501.549845015472;4510.526394728572;5073.416557095981;5116.8209112681625;5159.638825282269;5165.14775062118;5170.560502357342;1399.6430910117854;1412.265621876639;1417.2771886337837;1418.319206780751;1418.7304412161657;932.9673461428818;956.4744232948436;972.8686627305224;979.7899594001402;984.7784248544164;5020.59835213182;5054.848354549369;5086.821961231339;5158.896822063538;5164.870878227999;5285.814996475105;5308.814191503356;5311.468853114658;5326.387465441524;5335;4977.65156439053;4991.9500804991485;5114.846554603368;5144.768485418165;5174.301469301671;2796.2170592234206;2801.9632735887853;2802.5515917453517;2803.649543807024;2803.8598070096823;5424.810131645373;5550.639208451437;5560.972195138998;5591.692456914909;5626.915596266059;5392.730363481889;5419.132938729785;5439.972800135974;5441.591880608891;5449.3460784706085;5574.16387541872;5584.134459158837;5584.720763961867;5594.24477695514;5617.662940223599;5127.512886275797;5256.369235691742;5264.263003179634;5308.336457942757;5318.122509785842;5222.381061870832;5247.4490178530705;5250.26496290512;5274.314339135888;5281.7095059770545;5567.164925261243;5579.497845193952;5593.328800543961;5599.244102046172;5629.662220266797;3793.6585707286476;3946.1910308387287;4001.099752555652;4012.317905955936;4014.2172276406986;5323.4676532348;5349.893002139857;5354.464553544614;5361.222622719606;5362.865928351823;5239.738013099253;5242.318498595158;5247.370315562157;5252.290940722954;5262.368815592204;4920.876978075434;5229.581633469389;5233.607479439133;5234.685918844882;5242.580593552583;5147.279380886754;5158.09733296664;5161.7677204525135;5165.896682066413;5187.144121220107;4954.65317427791;5235.110031294766;5239.685618862881;5246.265522826731;5262.184361423985;4911.68074075184;5119.46245644202;5119.820806271762;5123.436421993652;5123.692578445305 19:14:45 INFO - PROCESS | 3410 | |5;yui.html;756.9583672897995;769.7729169894881;770.2490072179623;810.2059981218406;820.163433298036;15221.543353699393;16162.595935101614;16298.348066077373;16579.33682652694;16907.323707051735;15204.543863684079;15245.39018439261;15282.541523754277;15328.923355383235;15415.768763468528;671.3622059043903;798.9693295648607;829.8755186721979;833.2792134803396;848.0205362805938;827.7227128911821;830.3108420011376;835.3484282259847;838.337713206566;838.861587838006;876.2989608313355;877.4209022045451;878.1306506558493;878.5168157513374;878.7846977490524;696.7143471176819;831.0442990560842;874.2743522875998;875.6847534887436;877.4252864373846;641.0704478506185;644.230144976753;644.5423749138117;645.2643985856128;645.4836131095152;14841.406343746237;14874.405023799036;14898.478553250585;14919.104853708704;14934.178620175886;15906.125163116025;16127;16260.593485162848;16397.67204655912;16413.917930410393;11923.347766807045;11963.282203067756;11995.700107497383;12121.151519393647;12254.754904901942;3891.1633998690136;3895.3962135868987;3904.8828535143707;3926.0381206604566;3945.5265368156006;66165.66917165383;66352.00471992925;66481.335186648;67121.66439167772;67277;10886.564537418415;11039.668809935714;11139.888601114048;11282.548698051985;11425;22890.771092289197;23153.884230579075;23204.18785342505;23222.187223447436;23298.65052024221;8332.833343333099;8380;8475.237228649452;8535.103814099555;8697.739067827975;5056.469070747592;5103.464136265713;5128.410232823198;5224.634275600747;5270.78916843322;3562.7327950403824;3690.9630903691154;3691.354013047706;3691.7600355976774;3698.0385099874225;593.7506247376112;596.4095545410013;604.4439116013278;605.5065121925704;615.8429600451946;712.3232928717636;744.4974642116549;747.4132805747462;749.056189201599;752.2139364364252;9703.272254580934;9745.951270243604;9800.019998000143;9809.117179453884;9891.901080989099;583.5710752596838;594.8215535339381;673.4713250098649;679.2358596578849;691.761342336893;4561;4590.563896429834;4765.309030190603;4792.137415265286;4823.324734537167;107221.46389268004;108439;110672;111683;115840;65644;71333.64333178301;93527.53236233775;94984.0501594989;95759.52120239355;87415.12584874197;87598.56200718955;87960;88215;89798.55100724586;10400.895991039994;10538.894611054098;10675.89324106749;10758.40828754426;10801.459927003461;49326;50752.23871642002;51242;52057.7397113012;53303;72037.6398118006;77625;78330;78481;79381;12732.745345093232;13175.2753598553;13707.246101464516;13728.45086196541;13822.792658109935;15042;15175.16536590498;15591.220438978233;15674.764878526603;15925.920370398075;13676.247806370746;14133.222672752687;14273.785893211403;14649.487267945571;14686.706265874836;12429.44067516982;12540.686482837637;13031.739365212832;14550.199739014033;14981.625459363604;13068.085234033526;13336.333183340601;13642.590722278348;13834.584962451143;13897.791533127214;10714.73213169677;11005.504752286326;11303.434828258718;11506.712332191762;11657;11866.881331186578;12024.33866137371;12188.146829721834;12283.877161228631;12511.812322815347 19:14:45 INFO - PROCESS | 3410 | __end_tp_report 19:14:45 INFO - PROCESS | 3410 | __start_cc_report 19:14:45 INFO - PROCESS | 3410 | _x_x_mozilla_cycle_collect,794 19:14:45 INFO - PROCESS | 3410 | __end_cc_report 19:14:45 INFO - PROCESS | 3410 | __startTimestamp1468376085266__endTimestamp 19:14:45 INFO - PROCESS | 3410 | 19:14:45 INFO - PROCESS | 3410 | ------- Summary: start ------- 19:14:45 INFO - PROCESS | 3410 | Number of tests: 6 19:14:45 INFO - PROCESS | 3410 | 19:14:45 INFO - PROCESS | 3410 | [#0] dojo.html Cycles:165 Average:4851.77 Median:5003.60 stddev:470.34 (9.4%) stddev-sans-first:452.31 19:14:45 INFO - PROCESS | 3410 | Values: 3144.4 3145.5 3166.2 3166.3 3195.5 4770.5 4839.3 4870.5 4881.1 4886.4 4842.1 4849.4 4870.1 4873.1 4885.8 4366.1 4439.6 4480.0 4493.4 4537.7 4484.8 4493.5 4496.6 4524.1 4528.3 4458.7 4481.9 4500.3 4515.3 4528.1 4576.8 4585.0 4585.8 4588.1 4617.3 4376.5 4441.4 4467.0 4520.1 4541.1 4640.4 4640.7 4662.0 4690.7 4699.3 5142.4 5144.4 5183.5 5185.2 5192.0 5117.9 5153.1 5154.9 5167.6 5213.3 4866.0 4905.3 4917.7 4917.7 4919.2 5152.2 5292.0 5302.1 5302.6 5307.4 5095.8 5119.9 5184.1 5189.2 5193.9 5207.7 5208.8 5218.8 5233.2 5235.7 4964.0 5084.8 5173.5 5187.3 5188.5 5084.2 5116.1 5120.1 5150.9 5166.8 4156.6 4157.2 4163.6 4187.1 4193.4 3681.9 3688.3 3705.4 3762.4 3794.3 4923.3 4926.5 4944.9 4946.0 4950.0 5111.7 5113.7 5116.5 5128.5 5140.1 4867.9 4932.3 4947.6 4970.2 5003.6 4582.9 4592.0 4595.2 4601.4 4628.7 5426.4 5463.0 5464.3 5468.8 5471.2 5024.6 5056.7 5063.3 5089.5 5147.3 5352.2 5399.6 5426.1 5442.2 5442.4 5050.5 5088.7 5094.4 5109.5 5125.9 5024.1 5137.0 5153.8 5172.6 5205.7 5087.8 5089.4 5091.5 5092.2 5119.9 4907.0 5079.8 5091.8 5092.5 5095.7 4944.9 4967.4 4993.6 4998.2 5020.1 5100.2 5104.0 5124.9 5129.3 5129.9 4870.5 4930.7 5013.2 5013.6 5033.5 19:14:45 INFO - PROCESS | 3410 | 19:14:45 INFO - PROCESS | 3410 | [#1] ext.html Cycles:180 Average:65124.09 Median:21645.71 stddev:134376.34 (620.8%) stddev-sans-first:134665.98 19:14:45 INFO - PROCESS | 3410 | Values: 603.7 625.2 637.2 639.8 645.2 33917.2 36625.3 44733.0 45587.8 45806.5 48405.0 48719.0 48838.5 48852.3 48917.3 8174.3 9063.2 9215.7 9224.1 9232.3 8124.2 8195.7 10915.7 11183.2 11194.0 10953.3 10995.5 10999.6 11008.5 11009.5 8107.4 10982.2 11051.1 11054.4 11068.8 10691.3 11098.4 11101.9 11105.5 11447.7 42025.8 42778.0 46525.0 46595.0 46598.3 3674.7 3710.2 3847.9 3890.2 3928.2 34644.8 35121.3 35473.5 35847.6 35990.0 4445.8 4450.1 4471.2 4540.1 4596.2 368716.0 370763.0 370890.0 373287.0 374519.0 38737.0 68584.3 68854.0 69079.0 69349.7 39598.6 41917.8 42111.4 42122.2 42185.0 15680.4 15781.4 15790.6 15795.3 15797.7 12398.2 12649.5 13625.4 13686.0 13719.1 9287.5 9451.7 9551.5 9636.9 9680.7 3596.3 3625.6 3637.7 3649.0 3708.7 1062.9 1089.2 1157.7 1171.8 1198.7 34399.3 34948.7 34988.3 35016.3 35218.3 1184.7 1209.9 1223.8 1226.8 1269.9 17932.5 18519.4 18578.8 18667.6 18672.3 652408.0 655412.0 659785.0 660436.0 660968.0 64359.4 64515.4 64744.4 64811.7 65005.7 1311.1 1423.7 1439.5 1455.7 1463.9 34394.8 35200.8 36061.1 36259.6 36507.6 55154.7 55682.0 55763.0 55845.4 55919.0 434252.0 438294.0 438701.0 438945.0 438963.0 27400.2 30233.5 31163.2 31264.4 32709.2 50252.2 50267.0 52244.5 52661.5 56009.2 44162.8 44774.3 44864.3 45063.0 46128.3 42699.0 43429.0 43794.0 44172.3 44674.0 45117.5 45185.3 45806.3 45853.1 46331.5 37884.4 39363.2 39631.4 40197.2 40298.0 29388.4 29813.4 29834.7 29994.9 30084.1 19:14:45 INFO - PROCESS | 3410 | 19:14:45 INFO - PROCESS | 3410 | [#2] jquery.html Cycles:180 Average:29989.51 Median:13197.34 stddev:86792.43 (657.7%) stddev-sans-first:87007.50 19:14:45 INFO - PROCESS | 3410 | Values: 418.3 421.8 424.7 432.4 434.7 18622.7 19032.4 19203.2 20104.9 20599.2 18386.0 18813.9 18902.3 19100.7 19243.2 5345.0 5598.9 5603.7 5616.5 5617.2 4134.6 5639.5 5741.3 6006.4 6314.8 6397.2 6408.7 6414.6 6423.7 6428.2 6135.3 6354.2 6372.7 6376.8 6383.2 3802.7 5386.1 5688.5 5701.2 5706.3 23379.3 23549.9 23800.0 23942.9 23950.3 2444.4 2501.9 2592.2 2745.8 2959.8 14008.9 14772.4 14828.3 14863.7 15338.2 2041.5 2053.1 2054.9 2127.9 2183.2 77238.6 77447.6 77664.2 79307.6 80197.0 11026.3 11175.2 11390.6 11630.3 11650.1 16077.4 16128.2 16277.1 16281.7 16288.8 8164.8 8401.3 8420.5 8527.6 8545.4 7949.6 7980.0 8072.6 8107.8 8113.4 7003.4 7010.7 7065.5 7118.9 7142.1 1800.0 1826.0 1923.6 2058.2 2079.5 995.7 1055.6 1083.6 1121.7 1139.7 19193.9 19471.7 19983.2 20243.2 20467.9 1078.9 1105.5 1140.9 1191.0 1197.3 11406.1 11664.3 11708.6 11739.8 11751.5 512413.0 520631.0 533205.0 539821.0 539982.0 82134.0 84765.0 85581.0 86167.6 87495.1 953.0 982.4 1063.8 1083.8 1099.3 16721.0 17364.7 17460.3 17509.4 17963.8 37145.6 38092.4 40577.6 40799.4 40847.6 53329.7 53380.0 54181.0 54428.5 54565.2 8682.2 9046.5 9056.1 9057.6 9230.0 13079.5 13203.2 13212.0 13219.6 13259.2 11257.8 11598.7 11637.2 11714.9 11798.1 11416.7 11562.9 11577.6 11644.2 11713.5 11653.8 11859.3 11927.9 11975.6 12063.3 7641.6 8090.5 8112.8 8970.1 8997.2 9048.5 11680.7 11723.6 11891.5 12056.2 19:14:45 INFO - PROCESS | 3410 | 19:14:45 INFO - PROCESS | 3410 | [#3] mootools.html Cycles:180 Average:6091.18 Median:465.76 stddev:3596.93 (772.3%) stddev-sans-first:3589.23 19:14:45 INFO - PROCESS | 3410 | Values: 1331.5 1533.7 1554.4 1718.3 1878.7 7983.9 8796.5 8964.5 8969.8 9242.0 8886.6 9048.9 9052.9 9061.5 9065.0 2117.8 2438.0 2450.0 2481.8 2501.8 2482.8 2489.1 2516.6 2521.1 2522.1 2426.1 2427.5 2429.7 2432.3 2441.6 2025.5 2371.1 2437.7 2440.6 2441.3 2445.4 2449.3 2475.3 2533.5 2538.1 9228.3 9290.6 9298.7 9308.6 9329.9 5233.9 5375.0 5378.1 5381.4 5385.0 3289.4 3315.1 3351.4 3437.2 3477.9 1129.8 1130.5 1160.4 1162.8 1187.8 13025.8 13290.8 13321.3 13330.2 13330.8 4804.8 4849.2 4914.3 4929.5 4962.6 11172.9 11239.9 11242.8 11245.9 11272.3 4907.3 5537.0 5540.2 5541.7 5546.4 4563.6 4681.4 4684.3 4903.9 5043.1 4098.4 4124.5 4135.2 4183.4 4184.6 1162.5 1164.1 1172.3 1175.0 1272.5 952.2 981.8 1004.8 1014.3 1022.4 5905.0 5971.7 6181.9 6236.7 6361.7 456.1 462.9 468.7 495.2 497.5 4056.0 4117.6 4159.0 4197.8 4267.1 11403.4 11803.7 11908.8 11931.9 11935.5 11729.8 11745.1 11749.2 11755.2 11768.4 8360.2 8637.4 8678.8 8768.7 8773.6 6099.7 6160.6 6227.8 6274.8 6317.3 10467.7 10798.8 10979.2 10981.8 11082.4 10863.4 11076.3 11108.8 11118.2 11231.3 7637.8 8069.5 8266.6 8373.2 8475.3 9186.0 9220.1 9238.2 9284.1 9293.1 8180.1 8288.8 8361.5 8406.4 8461.7 7948.6 8022.7 8040.8 8086.2 8329.3 7533.2 7554.8 7558.7 7616.5 7700.3 4929.2 4977.4 5001.0 5039.5 5047.6 5036.0 5062.4 5089.8 5100.3 5115.7 19:14:45 INFO - PROCESS | 3410 | 19:14:45 INFO - PROCESS | 3410 | [#4] prototype.html Cycles:180 Average:4434.97 Median:5037.72 stddev:1258.28 (25.0%) stddev-sans-first:1224.05 19:14:45 INFO - PROCESS | 3410 | Values: 358.7 360.6 363.3 366.6 371.0 4939.6 4975.3 4980.3 5000.6 5002.8 4939.7 4944.6 4953.4 4963.8 4969.5 3845.5 3956.7 4034.2 4043.4 4072.0 3966.9 3992.4 4007.8 4008.7 4035.5 3822.9 3974.6 3980.1 3987.0 4000.4 3847.1 3970.2 3982.4 3984.9 4015.6 3617.9 3618.9 3633.7 3640.9 3641.4 4539.4 4613.5 4681.2 4733.5 4738.9 4500.5 4513.1 4518.8 4527.9 4529.0 5145.8 5185.7 5186.1 5206.1 5218.9 3864.5 3945.7 3946.3 3946.5 3952.5 5300.1 5305.8 5306.2 5327.4 5336.2 4005.9 4012.5 4023.4 4026.8 4044.9 4048.2 4070.6 4074.6 4083.6 4097.5 4360.8 4495.6 4500.7 4501.5 4510.5 5073.4 5116.8 5159.6 5165.1 5170.6 1399.6 1412.3 1417.3 1418.3 1418.7 933.0 956.5 972.9 979.8 984.8 5020.6 5054.8 5086.8 5158.9 5164.9 5285.8 5308.8 5311.5 5326.4 5335.0 4977.7 4992.0 5114.8 5144.8 5174.3 2796.2 2802.0 2802.6 2803.6 2803.9 5424.8 5550.6 5561.0 5591.7 5626.9 5392.7 5419.1 5440.0 5441.6 5449.3 5574.2 5584.1 5584.7 5594.2 5617.7 5127.5 5256.4 5264.3 5308.3 5318.1 5222.4 5247.4 5250.3 5274.3 5281.7 5567.2 5579.5 5593.3 5599.2 5629.7 3793.7 3946.2 4001.1 4012.3 4014.2 5323.5 5349.9 5354.5 5361.2 5362.9 5239.7 5242.3 5247.4 5252.3 5262.4 4920.9 5229.6 5233.6 5234.7 5242.6 5147.3 5158.1 5161.8 5165.9 5187.1 4954.7 5235.1 5239.7 5246.3 5262.2 4911.7 5119.5 5119.8 5123.4 5123.7 19:14:45 INFO - PROCESS | 3410 | 19:14:45 INFO - PROCESS | 3410 | [#5] yui.html Cycles:180 Average:20394.25 Median:4575.78 stddev:28371.76 (620.0%) stddev-sans-first:28413.03 19:14:45 INFO - PROCESS | 3410 | Values: 757.0 769.8 770.2 810.2 820.2 15221.5 16162.6 16298.3 16579.3 16907.3 15204.5 15245.4 15282.5 15328.9 15415.8 671.4 799.0 829.9 833.3 848.0 827.7 830.3 835.3 838.3 838.9 876.3 877.4 878.1 878.5 878.8 696.7 831.0 874.3 875.7 877.4 641.1 644.2 644.5 645.3 645.5 14841.4 14874.4 14898.5 14919.1 14934.2 15906.1 16127.0 16260.6 16397.7 16413.9 11923.3 11963.3 11995.7 12121.2 12254.8 3891.2 3895.4 3904.9 3926.0 3945.5 66165.7 66352.0 66481.3 67121.7 67277.0 10886.6 11039.7 11139.9 11282.5 11425.0 22890.8 23153.9 23204.2 23222.2 23298.7 8332.8 8380.0 8475.2 8535.1 8697.7 5056.5 5103.5 5128.4 5224.6 5270.8 3562.7 3691.0 3691.4 3691.8 3698.0 593.8 596.4 604.4 605.5 615.8 712.3 744.5 747.4 749.1 752.2 9703.3 9746.0 9800.0 9809.1 9891.9 583.6 594.8 673.5 679.2 691.8 4561.0 4590.6 4765.3 4792.1 4823.3 107221.5 108439.0 110672.0 111683.0 115840.0 65644.0 71333.6 93527.5 94984.1 95759.5 87415.1 87598.6 87960.0 88215.0 89798.6 10400.9 10538.9 10675.9 10758.4 10801.5 49326.0 50752.2 51242.0 52057.7 53303.0 72037.6 77625.0 78330.0 78481.0 79381.0 12732.7 13175.3 13707.2 13728.5 13822.8 15042.0 15175.2 15591.2 15674.8 15925.9 13676.2 14133.2 14273.8 14649.5 14686.7 12429.4 12540.7 13031.7 14550.2 14981.6 13068.1 13336.3 13642.6 13834.6 13897.8 10714.7 11005.5 11303.4 11506.7 11657.0 11866.9 12024.3 12188.1 12283.9 12511.8 19:14:45 INFO - PROCESS | 3410 | -------- Summary: end -------- 19:14:45 INFO - PROCESS | 3410 | 19:14:45 INFO - TEST-INFO | 3410: exit 0 19:14:45 INFO - TEST-OK | dromaeo_css | took 1113428ms 19:14:45 INFO - TEST-START | kraken 19:14:45 INFO - operating with platform_type : linux_ 19:14:45 INFO - Initialising browser for kraken test... 19:14:45 INFO - TEST-INFO | started process 3600 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpD4S6PS/profile http://localhost:59764/getInfo.html) 19:14:50 INFO - PROCESS | 3600 | __metrics Screen width/height:1600/1200 19:14:50 INFO - PROCESS | 3600 | colorDepth:24 19:14:50 INFO - PROCESS | 3600 | Browser inner width/height: 1024/697 19:14:50 INFO - PROCESS | 3600 | __metrics 19:14:51 ERROR - PROCESS | 3600 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 19:14:52 INFO - TEST-INFO | 3600: exit 0 19:14:52 INFO - Browser initialized. 19:14:52 INFO - Running cycle 1/1 for kraken test... 19:14:52 INFO - TEST-INFO | started process 3690 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpD4S6PS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:15:03 INFO - PROCESS | 3690 | RSS: Main: 148758528 19:15:03 INFO - PROCESS | 3690 | 19:15:06 INFO - PROCESS | 3690 | Cycle 1(1): loaded http://localhost:59764/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59764/tests/kraken/driver.html?testName=audio-beat-detection) 19:15:07 INFO - PROCESS | 3690 | RSS: Main: 198631424 19:15:07 INFO - PROCESS | 3690 | 19:15:10 INFO - PROCESS | 3690 | Cycle 1(1): loaded http://localhost:59764/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59764/tests/kraken/driver.html?testName=audio-dft) 19:15:10 INFO - PROCESS | 3690 | RSS: Main: 196288512 19:15:10 INFO - PROCESS | 3690 | 19:15:13 INFO - PROCESS | 3690 | Cycle 1(1): loaded http://localhost:59764/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59764/tests/kraken/driver.html?testName=audio-fft) 19:15:14 INFO - PROCESS | 3690 | RSS: Main: 282574848 19:15:14 INFO - PROCESS | 3690 | 19:15:16 INFO - PROCESS | 3690 | Cycle 1(1): loaded http://localhost:59764/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59764/tests/kraken/driver.html?testName=audio-oscillator) 19:15:16 INFO - PROCESS | 3690 | RSS: Main: 191803392 19:15:16 INFO - PROCESS | 3690 | 19:15:18 INFO - PROCESS | 3690 | Cycle 1(1): loaded http://localhost:59764/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59764/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:15:19 INFO - PROCESS | 3690 | RSS: Main: 192294912 19:15:19 INFO - PROCESS | 3690 | 19:15:22 INFO - PROCESS | 3690 | Cycle 1(1): loaded http://localhost:59764/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59764/tests/kraken/driver.html?testName=imaging-darkroom) 19:15:23 INFO - PROCESS | 3690 | RSS: Main: 227053568 19:15:23 INFO - PROCESS | 3690 | 19:15:26 INFO - PROCESS | 3690 | Cycle 1(1): loaded http://localhost:59764/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59764/tests/kraken/driver.html?testName=imaging-desaturate) 19:15:27 INFO - PROCESS | 3690 | RSS: Main: 225116160 19:15:27 INFO - PROCESS | 3690 | 19:15:29 INFO - PROCESS | 3690 | Cycle 1(1): loaded http://localhost:59764/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59764/tests/kraken/driver.html?testName=json-parse-financial) 19:15:30 INFO - PROCESS | 3690 | RSS: Main: 225751040 19:15:30 INFO - PROCESS | 3690 | 19:15:32 INFO - PROCESS | 3690 | Cycle 1(1): loaded http://localhost:59764/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59764/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:15:32 INFO - PROCESS | 3690 | RSS: Main: 204591104 19:15:32 INFO - PROCESS | 3690 | 19:15:34 INFO - PROCESS | 3690 | Cycle 1(1): loaded http://localhost:59764/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59764/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:15:34 INFO - PROCESS | 3690 | RSS: Main: 205557760 19:15:34 INFO - PROCESS | 3690 | 19:15:37 INFO - PROCESS | 3690 | Cycle 1(1): loaded http://localhost:59764/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59764/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:15:37 INFO - PROCESS | 3690 | RSS: Main: 210661376 19:15:37 INFO - PROCESS | 3690 | 19:15:40 INFO - PROCESS | 3690 | Cycle 1(1): loaded http://localhost:59764/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59764/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:15:40 INFO - PROCESS | 3690 | RSS: Main: 216739840 19:15:40 INFO - PROCESS | 3690 | 19:15:43 INFO - PROCESS | 3690 | Cycle 1(1): loaded http://localhost:59764/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59764/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:15:44 INFO - PROCESS | 3690 | RSS: Main: 217784320 19:15:44 INFO - PROCESS | 3690 | 19:15:45 INFO - PROCESS | 3690 | Cycle 1(1): loaded http://localhost:59764/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59764/tests/kraken/driver.html?testName=ai-astar) 19:15:46 INFO - PROCESS | 3690 | RSS: Main: 259772416 19:15:46 INFO - PROCESS | 3690 | 19:15:46 INFO - PROCESS | 3690 | __start_tp_report 19:15:46 INFO - PROCESS | 3690 | _x_x_mozilla_page_load 19:15:46 INFO - PROCESS | 3690 | _x_x_mozilla_page_load_details 19:15:46 INFO - PROCESS | 3690 | |i|pagename|runs| 19:15:46 INFO - PROCESS | 3690 | |0;ai-astar;109;103;112;110;111;107;109;109;109;110 19:15:46 INFO - PROCESS | 3690 | |1;audio-beat-detection;160;123;127;173;126;128;151;129;181;130 19:15:46 INFO - PROCESS | 3690 | |2;audio-dft;160;160;161;161;160;159;161;161;159;159 19:15:46 INFO - PROCESS | 3690 | |3;audio-fft;74;73;76;99;74;77;78;75;99;74 19:15:46 INFO - PROCESS | 3690 | |4;audio-oscillator;85;83;116;84;86;85;113;84;85;119 19:15:46 INFO - PROCESS | 3690 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;117;117 19:15:46 INFO - PROCESS | 3690 | |6;imaging-darkroom;145;145;145;145;146;147;146;146;147;146 19:15:46 INFO - PROCESS | 3690 | |7;imaging-desaturate;95;96;95;95;95;95;95;95;95;95 19:15:46 INFO - PROCESS | 3690 | |8;json-parse-financial;56;56;57;58;58;57;57;58;57;59 19:15:46 INFO - PROCESS | 3690 | |9;json-stringify-tinderbox;60;60;60;59;59;59;59;59;59;60 19:15:46 INFO - PROCESS | 3690 | |10;stanford-crypto-aes;82;77;83;77;77;95;83;84;124;79 19:15:46 INFO - PROCESS | 3690 | |11;stanford-crypto-ccm;130;134;123;119;115;124;125;129;141;125 19:15:46 INFO - PROCESS | 3690 | |12;stanford-crypto-pbkdf2;155;154;158;157;156;158;157;159;151;154 19:15:46 INFO - PROCESS | 3690 | |13;stanford-crypto-sha256-iterative;67;63;64;61;63;62;62;63;62;59 19:15:46 INFO - PROCESS | 3690 | __end_tp_report 19:15:46 INFO - PROCESS | 3690 | __start_cc_report 19:15:46 INFO - PROCESS | 3690 | _x_x_mozilla_cycle_collect,1617 19:15:46 INFO - PROCESS | 3690 | __end_cc_report 19:15:46 INFO - PROCESS | 3690 | __startTimestamp1468376146011__endTimestamp 19:15:46 INFO - PROCESS | 3690 | 19:15:46 INFO - PROCESS | 3690 | ------- Summary: start ------- 19:15:46 INFO - PROCESS | 3690 | Number of tests: 14 19:15:46 INFO - PROCESS | 3690 | 19:15:46 INFO - PROCESS | 3690 | [#0] ai-astar Cycles:10 Average:108.90 Median:109.50 stddev:2.47 (2.3%) stddev-sans-first:2.62 19:15:46 INFO - PROCESS | 3690 | Values: 109.0 103.0 112.0 110.0 111.0 107.0 109.0 109.0 109.0 110.0 19:15:46 INFO - PROCESS | 3690 | 19:15:46 INFO - PROCESS | 3690 | [#1] audio-beat-detection Cycles:10 Average:142.80 Median:140.50 stddev:21.68 (15.4%) stddev-sans-first:22.09 19:15:46 INFO - PROCESS | 3690 | Values: 160.0 123.0 127.0 173.0 126.0 128.0 151.0 129.0 181.0 130.0 19:15:46 INFO - PROCESS | 3690 | 19:15:46 INFO - PROCESS | 3690 | [#2] audio-dft Cycles:10 Average:160.10 Median:160.50 stddev:0.88 (0.5%) stddev-sans-first:0.93 19:15:46 INFO - PROCESS | 3690 | Values: 160.0 160.0 161.0 161.0 160.0 159.0 161.0 161.0 159.0 159.0 19:15:46 INFO - PROCESS | 3690 | 19:15:46 INFO - PROCESS | 3690 | [#3] audio-fft Cycles:10 Average:79.90 Median:76.50 stddev:10.18 (13.3%) stddev-sans-first:10.57 19:15:46 INFO - PROCESS | 3690 | Values: 74.0 73.0 76.0 99.0 74.0 77.0 78.0 75.0 99.0 74.0 19:15:46 INFO - PROCESS | 3690 | 19:15:46 INFO - PROCESS | 3690 | [#4] audio-oscillator Cycles:10 Average:94.00 Median:84.50 stddev:15.27 (18.1%) stddev-sans-first:15.84 19:15:46 INFO - PROCESS | 3690 | Values: 85.0 83.0 116.0 84.0 86.0 85.0 113.0 84.0 85.0 119.0 19:15:46 INFO - PROCESS | 3690 | 19:15:46 INFO - PROCESS | 3690 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 19:15:46 INFO - PROCESS | 3690 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 19:15:46 INFO - PROCESS | 3690 | 19:15:46 INFO - PROCESS | 3690 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.79 (0.5%) stddev-sans-first:0.78 19:15:46 INFO - PROCESS | 3690 | Values: 145.0 145.0 145.0 145.0 146.0 147.0 146.0 146.0 147.0 146.0 19:15:46 INFO - PROCESS | 3690 | 19:15:46 INFO - PROCESS | 3690 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 19:15:46 INFO - PROCESS | 3690 | Values: 95.0 96.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 19:15:46 INFO - PROCESS | 3690 | 19:15:46 INFO - PROCESS | 3690 | [#8] json-parse-financial Cycles:10 Average:57.30 Median:57.50 stddev:0.95 (1.6%) stddev-sans-first:0.88 19:15:46 INFO - PROCESS | 3690 | Values: 56.0 56.0 57.0 58.0 58.0 57.0 57.0 58.0 57.0 59.0 19:15:46 INFO - PROCESS | 3690 | 19:15:46 INFO - PROCESS | 3690 | [#9] json-stringify-tinderbox Cycles:10 Average:59.40 Median:59.50 stddev:0.52 (0.9%) stddev-sans-first:0.50 19:15:46 INFO - PROCESS | 3690 | Values: 60.0 60.0 60.0 59.0 59.0 59.0 59.0 59.0 59.0 60.0 19:15:46 INFO - PROCESS | 3690 | 19:15:46 INFO - PROCESS | 3690 | [#10] stanford-crypto-aes Cycles:10 Average:86.10 Median:82.50 stddev:14.36 (17.4%) stddev-sans-first:15.15 19:15:46 INFO - PROCESS | 3690 | Values: 82.0 77.0 83.0 77.0 77.0 95.0 83.0 84.0 124.0 79.0 19:15:46 INFO - PROCESS | 3690 | 19:15:46 INFO - PROCESS | 3690 | [#11] stanford-crypto-ccm Cycles:10 Average:126.50 Median:127.00 stddev:7.43 (5.8%) stddev-sans-first:7.77 19:15:46 INFO - PROCESS | 3690 | Values: 130.0 134.0 123.0 119.0 115.0 124.0 125.0 129.0 141.0 125.0 19:15:46 INFO - PROCESS | 3690 | 19:15:46 INFO - PROCESS | 3690 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:155.90 Median:157.00 stddev:2.42 (1.5%) stddev-sans-first:2.55 19:15:46 INFO - PROCESS | 3690 | Values: 155.0 154.0 158.0 157.0 156.0 158.0 157.0 159.0 151.0 154.0 19:15:46 INFO - PROCESS | 3690 | 19:15:46 INFO - PROCESS | 3690 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.60 Median:63.00 stddev:2.07 (3.3%) stddev-sans-first:1.45 19:15:46 INFO - PROCESS | 3690 | Values: 67.0 63.0 64.0 61.0 63.0 62.0 62.0 63.0 62.0 59.0 19:15:46 INFO - PROCESS | 3690 | -------- Summary: end -------- 19:15:46 INFO - PROCESS | 3690 | 19:15:46 INFO - TEST-INFO | 3690: exit 0 19:15:46 INFO - TEST-OK | kraken | took 60932ms 19:15:46 INFO - SUITE-END | took 1174s 19:15:47 INFO - Completed test suite (00:19:34) 19:15:47 INFO - javascript benchmark 19:15:47 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3144.4340018796615, 3145.5124455709374, 3166.2401023754305, 3166.3034132490843, 3195.520671899215, 4770.451398089221, 4839.3224948507195, 4870.464248932623, 4881.1213981483315, 4886.36477257956, 4842.104210721019, 4849.36958195435, 4870.147724148278, 4873.122837889178, 4885.755712214384, 4366.148601022802, 4439.600435960763, 4479.955200447995, 4493.438320209973, 4537.659675524333, 4484.775761211943, 4493.46078470584, 4496.595306422421, 4524.140413321475, 4528.275475923853, 4458.687891847572, 4481.932771008437, 4500.324951257305, 4515.3227015947705, 4528.094381123772, 4576.83981060663, 4584.977075114603, 4585.816567337302, 4588.128255631419, 4617.284320930261, 4376.518582955872, 4441.444819397575, 4467.039586488888, 4520.095980803852, 4541.137183935041, 4640.443146822369, 4640.721556706575, 4662.0, 4690.671652984258, 4699.342092107107, 5142.357205349332, 5144.356955380577, 5183.45573714762, 5185.222216667492, 5192.013517431714, 5117.872053198663, 5153.149730294497, 5154.92267615986, 5167.612429067835, 5213.27014218006, 4865.95134048655, 4905.264210368473, 4917.680350777188, 4917.704937703714, 4919.163742163805, 5152.227165925066, 5291.973540132351, 5302.09864323066, 5302.628815982921, 5307.416184219733, 5095.821646242438, 5119.948800511947, 5184.066867963803, 5189.221616757516, 5193.870153246199, 5207.661502002357, 5208.765605547759, 5218.817341393033, 5233.188855727369, 5235.685858848481, 4964.0, 5084.8220312288895, 5173.508516690984, 5187.299714538564, 5188.507091826271, 5084.211947148198, 5116.053530096944, 5120.103981803244, 5150.896982060338, 5166.793328266903, 4156.605122513356, 4157.189348077096, 4163.625273725319, 4187.120704651997, 4193.391958166048, 3681.9079523012138, 3688.3176612326806, 3705.4256590228556, 3762.3792074307435, 3794.29805485986, 4923.261510773341, 4926.45808961014, 4944.876378090505, 4945.950540494549, 4950.034743225108, 5111.693298402108, 5113.667611605234, 5116.488351164854, 5128.538431541179, 5140.100482415637, 4867.9269810952865, 4932.28481870134, 4947.604191664658, 4970.204767237297, 5003.5997120230295, 4582.9312560310955, 4592.03567250881, 4595.195840727859, 4601.44782626087, 4628.699134556243, 5426.403095659474, 5463.019331144349, 5464.28964234647, 5468.7539060742365, 5471.206675032098, 5024.57291130258, 5056.6713163644245, 5063.3417655704525, 5089.51649593288, 5147.253648221062, 5352.197170424468, 5399.622026458111, 5426.0504411727, 5442.238086667949, 5442.4285450028765, 5050.469700681376, 5088.6946783193125, 5094.439611642642, 5109.514596113363, 5125.8718532037, 5024.120778863758, 5137.023965446553, 5153.845384638467, 5172.612054095883, 5205.6616319939085, 5087.771050302819, 5089.3638295213095, 5091.465396133352, 5092.185250359925, 5119.897602047864, 4907.0, 5079.796808127633, 5091.770870310919, 5092.490750924878, 5095.745212739423, 4944.8763780905765, 4967.379077615298, 4993.550580447632, 4998.175301075282, 5020.121478741279, 5100.183970564692, 5104.0, 5124.923126153036, 5129.281900533853, 5129.948700513097, 4870.537298956593, 4930.6795058321095, 5013.172826483589, 5013.6490445669915, 5033.496650335083], "value": 4825.82531853095, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [603.6619493083873, 625.1841347042108, 637.1716768201338, 639.8208501619548, 645.216062484082, 33917.15207119823, 36625.26749465012, 44733.0, 45587.77206113973, 45806.541934580644, 48405.0, 48719.0, 48838.51161488384, 48852.267215991786, 48917.26624100633, 8174.3460523158, 9063.229625481841, 9215.723528294162, 9224.07759224079, 9232.261419086457, 8124.22819832115, 8195.71315003975, 10915.672529824118, 11183.217174797768, 11193.992540671337, 10953.34279943202, 10995.505202265917, 10999.560017599286, 11008.504617292201, 11009.504572294227, 8107.391945604103, 10982.176336774733, 11051.115910727123, 11054.392008439532, 11068.833967490455, 10691.30506517074, 11098.44507774608, 11101.944490277498, 11105.500252488657, 11447.713807154805, 42025.78987105045, 42778.0, 46525.0, 46595.0, 46598.301025484645, 3674.6692797648075, 3710.18375957289, 3847.942280865789, 3890.1830615570766, 3928.214357128557, 34644.82677586621, 35121.297574048374, 35473.46789798155, 35847.64152358495, 35990.0, 4445.799939002753, 4450.132224216279, 4471.217536931024, 4540.114677637862, 4596.241620132674, 368716.0, 370763.0, 370890.0, 373287.0, 374519.0, 38737.0, 68584.31415685879, 68854.0, 69079.0, 69349.65325173443, 39598.60401396007, 41917.79041104836, 42111.36832947508, 42122.15755684869, 42185.0, 15680.372785088468, 15781.36874525029, 15790.605234869221, 15795.289211985488, 15797.68404631901, 12398.194117382342, 12649.494020239272, 13625.386857591433, 13686.0, 13719.1082579632, 9287.489188094585, 9451.716448506555, 9551.474668893277, 9636.855447168298, 9680.709578712509, 3596.3166998270244, 3625.5649322081517, 3637.654422829827, 3648.9817550912076, 3708.740388172856, 1062.923687657841, 1089.2103225161695, 1157.7279339355414, 1171.841801356806, 1198.7003249187703, 34399.31201375958, 34948.65051349505, 34988.30023399518, 35016.299674006375, 35218.295634087175, 1184.703824043989, 1209.8911098001222, 1223.8409006829233, 1226.7669142862828, 1269.904757143218, 17932.462026138975, 18519.35182268614, 18578.814211857978, 18667.626647467245, 18672.25310987545, 652408.0, 655412.0, 659785.0, 660436.0, 660968.0, 64359.35640643627, 64515.354846451875, 64744.35255647383, 64811.67594161999, 65005.67497162484, 1311.114997376767, 1423.6546463591806, 1439.4673970630934, 1455.679750454877, 1463.9194844283454, 34394.82802585971, 35200.82399587986, 36061.09847253735, 36259.637403625624, 36507.634923650425, 55154.72422637861, 55682.0, 55763.0, 55845.44154558565, 55919.0, 434252.0, 438294.0, 438701.0, 438945.0, 438963.0, 27400.177994660193, 30233.546496803006, 31163.220919477193, 31264.374712505167, 32709.20099394556, 50252.246216306055, 50267.0, 52244.47755522396, 52661.47338526566, 56009.15986260128, 44162.779186103864, 44774.3283850749, 44864.32703509385, 45063.0, 46128.30807537823, 42699.0, 43429.0, 43794.0, 44172.337414939444, 44674.0, 45117.54882451134, 45185.32222016607, 45806.31290530712, 45853.082938341715, 46331.53668463272, 37884.43173352457, 39363.21273574455, 39631.40552891651, 40197.1960560793, 40298.0, 29388.412231755672, 29813.403731925675, 29834.701652983193, 29994.850025749733, 30084.097477075724], "value": 20659.40979418086, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [418.26176797951604, 421.76591991444747, 424.7111963864573, 432.3773765777282, 434.6957130008994, 18622.720659190105, 19032.429027129172, 19203.231870725172, 20104.899475502603, 20599.1760329587, 18386.0, 18813.905930470362, 18902.338418155367, 19100.713489297672, 19243.23027078915, 5344.973275133629, 5598.916016259759, 5603.691796951186, 5616.494515493605, 5617.157426386034, 4134.64855487284, 5639.520640745542, 5741.282339707536, 6006.399360063981, 6314.842128946767, 6397.1683681121385, 6408.679566021704, 6414.615123092606, 6423.7430502779835, 6428.19647544057, 6135.325114237453, 6354.205724284465, 6372.7132279047555, 6376.840578985516, 6383.202099737533, 3802.714796390254, 5386.111291636876, 5688.544916406678, 5701.230333904911, 5706.258186435737, 23379.298621041227, 23549.94025268867, 23800.0, 23942.880285598636, 23950.28149155528, 2444.3889027743066, 2501.9249422517355, 2592.235290589281, 2745.835249884993, 2959.7632189424794, 14008.85991140096, 14772.409103635842, 14828.3327250274, 14863.70272594542, 15338.156401397919, 2041.5100375909824, 2053.1068984991575, 2054.876707397561, 2127.861688990226, 2183.15948359881, 77238.6138069306, 77447.6127619364, 77664.22335776627, 79307.6034619829, 80197.0, 11026.283291586182, 11175.21773475849, 11390.601328953448, 11630.302181869114, 11650.067994560415, 16077.437289694804, 16128.193590320438, 16277.104759238118, 16281.674366512603, 16288.755668664979, 8164.836703265902, 8401.327893768606, 8420.53687047206, 8527.616257268437, 8545.401821872534, 7949.562774047367, 7979.960100199578, 8072.636731347104, 8107.83784324322, 8113.432059755878, 7003.439724822104, 7010.719571217196, 7065.50541462103, 7118.893216601755, 7142.107236595426, 1799.9550011249823, 1825.963193104781, 1923.5960448305732, 2058.197303051811, 2079.4593405714622, 995.6714284286168, 1055.5619417941468, 1083.5557421457322, 1121.6820236222568, 1139.658102569226, 19193.90403047976, 19471.70489789212, 19983.20067197325, 20243.190272389234, 20467.8976605116, 1078.8975047370486, 1105.5246244115108, 1140.8802075781923, 1190.9702257443632, 1197.26368283505, 11406.144539159597, 11664.300141991507, 11708.590199342982, 11739.823902641467, 11751.47118379675, 512413.0, 520631.0, 533205.0, 539821.0, 539982.0, 82134.0, 84765.0, 85581.0, 86167.56916215378, 87495.12504874996, 952.9952350238343, 982.4301904895144, 1063.7606538528923, 1083.7561548651647, 1099.2689861242345, 16721.0, 17364.73952890733, 17460.30158793634, 17509.38717144894, 17963.7867674407, 37145.628543714214, 38092.42861357137, 40577.594224058565, 40799.38800917929, 40847.591524084375, 53329.733351332994, 53380.0, 54181.0, 54428.45571544234, 54565.18152227799, 8682.175193356621, 9046.502442365732, 9056.13966673165, 9057.637694492147, 9230.030846761261, 13079.476820927057, 13203.207807531195, 13212.0, 13219.603411897659, 13259.204447733167, 11257.831132532854, 11598.652040438801, 11637.185397022127, 11714.941425292818, 11798.056155507367, 11416.714582135513, 11562.94218528902, 11577.59478418285, 11644.2431241969, 11713.531458741554, 11653.76692466163, 11859.288442693465, 11927.880721192678, 11975.580854670394, 12063.276203427822, 7641.57971311561, 8090.514569125871, 8112.797180070545, 8970.10298970124, 8997.190252877272, 9048.547572621474, 11680.70798230051, 11723.648290551297, 11891.464884080064, 12056.156069075432], "value": 9612.040140543802, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1331.4674130347853, 1533.6855944531371, 1554.4093244567064, 1718.278323104296, 1878.736976823244, 7983.9201607983905, 8796.516191609468, 8964.50695211764, 8969.775755606113, 9242.0, 8886.644534218623, 9048.864267036, 9052.90947090529, 9061.456312621247, 9065.04816994216, 2117.798809113132, 2438.0, 2449.9510009799837, 2481.789047930928, 2501.849889006656, 2482.8137889658256, 2489.0790407549143, 2516.6225066240117, 2521.0546045233036, 2522.054229663876, 2426.065964603623, 2427.5387676341525, 2429.7205821330595, 2432.2581612608146, 2441.645961335605, 2025.5037515808647, 2371.0515793682493, 2437.6709144265474, 2440.585100532896, 2441.316431399211, 2445.3519817248443, 2449.317996793526, 2475.2945410557904, 2533.505966336565, 2538.0862889359814, 9228.307876909192, 9290.581923813445, 9298.72103836886, 9308.581113849894, 9329.906700932972, 5233.947660523422, 5375.0, 5378.085725426687, 5381.381141168777, 5385.0, 3289.407906576815, 3315.055209265348, 3351.4302568563403, 3437.226624009603, 3477.94783078254, 1129.8305254211853, 1130.4856290387936, 1160.373398364882, 1162.7965106106483, 1187.8277649740826, 13025.804612930813, 13290.800637990438, 13321.333933303296, 13330.200187988654, 13330.800037999437, 4804.8318308859025, 4849.175640141185, 4914.311996320518, 4929.457759646436, 4962.60299176065, 11172.888271117346, 11239.943800280946, 11242.775144497064, 11245.943770281096, 11272.323660580392, 4907.288443175719, 5537.0, 5540.2243685884005, 5541.722913854291, 5546.362168350611, 4563.612092972135, 4681.438227412732, 4684.320773487825, 4903.901921961541, 5043.117454445457, 4098.381139449901, 4124.52567954689, 4135.234981528427, 4183.372494125844, 4184.581541845791, 1162.5291756838494, 1164.0745607242263, 1172.302480024384, 1174.9588764393204, 1272.4528452765214, 952.2001518724305, 981.8036392721484, 1004.8241557727368, 1014.3102690170607, 1022.3712416863575, 5905.025670764362, 5971.671558064349, 6181.907271390933, 6236.688165591702, 6361.650109244036, 456.1242414564045, 462.858828057439, 468.6526237068428, 495.2175562611066, 497.5074676070664, 4055.9594404055583, 4117.629413352813, 4158.979205103955, 4197.811098500575, 4267.125239325931, 11403.42982850854, 11803.704907377385, 11908.761824763456, 11931.926126648643, 11935.52257909674, 11729.765404691858, 11745.060395168366, 11749.177557571058, 11755.177137600456, 11768.411579420994, 8360.247577717913, 8637.395382323302, 8678.826423471495, 8768.736937891874, 8773.561321933877, 6099.725512351866, 6160.599561028519, 6227.844303892439, 6274.780382686584, 6317.336679648571, 10467.738306542398, 10798.784024319626, 10979.231453798477, 10981.83527247076, 11082.445877706245, 10863.402512861552, 11076.335419874833, 11108.777824443627, 11118.166137539554, 11231.326120432801, 7637.770866874002, 8069.47548409375, 8266.586670666322, 8373.246407823324, 8475.279601233964, 9186.035466275946, 9220.124088211609, 9238.214751746176, 9284.118008789153, 9293.117153870371, 8180.14108518597, 8288.751337459886, 8361.456505327134, 8406.369522285975, 8461.703840365557, 7948.642311095899, 8022.679092836454, 8040.839183216186, 8086.191380862102, 8329.250367466957, 7533.209013053551, 7554.773356799085, 7558.735444259424, 7616.504927179715, 7700.3454706350585, 4929.211326187793, 4977.427595826526, 5001.0, 5039.546440820343, 5047.596192304533, 5035.974820125876, 5062.417821950523, 5089.847304580869, 5100.336956195671, 5115.693058416507], "value": 4736.92701559784, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [358.7309517861604, 360.6177451900985, 363.3205904957729, 366.57843479997985, 371.037158573502, 4939.629527785417, 4975.253711943201, 4980.27785971034, 5000.649954503182, 5002.849914502566, 4939.728314942677, 4944.579710724593, 4953.405591329046, 4963.776630051647, 4969.5030496950285, 3845.5193100862393, 3956.663683586884, 4034.2334956358272, 4043.3934909763475, 4072.0, 3966.9206615867665, 3992.361222204448, 4007.819648115827, 4008.7394319369146, 4035.47538819953, 3822.923541529168, 3974.5627980922077, 3980.104476492795, 3987.0, 4000.439938408625, 3847.0959324558708, 3970.2059588082498, 3982.4424580558743, 3984.860529881469, 4015.6185162409815, 3617.8733744318824, 3618.855245790165, 3633.6555474474612, 3640.8725694600826, 3641.3991691370893, 4539.364488971547, 4613.538646135359, 4681.180793361148, 4733.502982186856, 4738.881527961794, 4500.549945005473, 4513.119941611387, 4518.774061296922, 4527.9359350552595, 4528.954710452919, 5145.819896303648, 5185.688858668492, 5186.118359878829, 5206.114960456732, 5218.921716174261, 3864.478295430109, 3945.6646185074305, 3946.3093958557424, 3946.467226924357, 3952.505936757905, 5300.09898317287, 5305.7612407441375, 5306.204069389584, 5327.360716713981, 5336.226247194135, 4005.8798236052967, 4012.4583181270154, 4023.416604592376, 4026.7986600670433, 4044.8988775280263, 4048.190361927567, 4070.592940705965, 4074.6332830044844, 4083.632473077437, 4097.467329247179, 4360.7819609019425, 4495.595396414273, 4500.729956202638, 4501.549845015472, 4510.526394728572, 5073.416557095981, 5116.8209112681625, 5159.638825282269, 5165.14775062118, 5170.560502357342, 1399.6430910117854, 1412.265621876639, 1417.2771886337837, 1418.319206780751, 1418.7304412161657, 932.9673461428818, 956.4744232948436, 972.8686627305224, 979.7899594001402, 984.7784248544164, 5020.59835213182, 5054.848354549369, 5086.821961231339, 5158.896822063538, 5164.870878227999, 5285.814996475105, 5308.814191503356, 5311.468853114658, 5326.387465441524, 5335.0, 4977.65156439053, 4991.9500804991485, 5114.846554603368, 5144.768485418165, 5174.301469301671, 2796.2170592234206, 2801.9632735887853, 2802.5515917453517, 2803.649543807024, 2803.8598070096823, 5424.810131645373, 5550.639208451437, 5560.972195138998, 5591.692456914909, 5626.915596266059, 5392.730363481889, 5419.132938729785, 5439.972800135974, 5441.591880608891, 5449.3460784706085, 5574.16387541872, 5584.134459158837, 5584.720763961867, 5594.24477695514, 5617.662940223599, 5127.512886275797, 5256.369235691742, 5264.263003179634, 5308.336457942757, 5318.122509785842, 5222.381061870832, 5247.4490178530705, 5250.26496290512, 5274.314339135888, 5281.7095059770545, 5567.164925261243, 5579.497845193952, 5593.328800543961, 5599.244102046172, 5629.662220266797, 3793.6585707286476, 3946.1910308387287, 4001.099752555652, 4012.317905955936, 4014.2172276406986, 5323.4676532348, 5349.893002139857, 5354.464553544614, 5361.222622719606, 5362.865928351823, 5239.738013099253, 5242.318498595158, 5247.370315562157, 5252.290940722954, 5262.368815592204, 4920.876978075434, 5229.581633469389, 5233.607479439133, 5234.685918844882, 5242.580593552583, 5147.279380886754, 5158.09733296664, 5161.7677204525135, 5165.896682066413, 5187.144121220107, 4954.65317427791, 5235.110031294766, 5239.685618862881, 5246.265522826731, 5262.184361423985, 4911.68074075184, 5119.46245644202, 5119.820806271762, 5123.436421993652, 5123.692578445305], "value": 4052.040033555974, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [756.9583672897995, 769.7729169894881, 770.2490072179623, 810.2059981218406, 820.163433298036, 15221.543353699393, 16162.595935101614, 16298.348066077373, 16579.33682652694, 16907.323707051735, 15204.543863684079, 15245.39018439261, 15282.541523754277, 15328.923355383235, 15415.768763468528, 671.3622059043903, 798.9693295648607, 829.8755186721979, 833.2792134803396, 848.0205362805938, 827.7227128911821, 830.3108420011376, 835.3484282259847, 838.337713206566, 838.861587838006, 876.2989608313355, 877.4209022045451, 878.1306506558493, 878.5168157513374, 878.7846977490524, 696.7143471176819, 831.0442990560842, 874.2743522875998, 875.6847534887436, 877.4252864373846, 641.0704478506185, 644.230144976753, 644.5423749138117, 645.2643985856128, 645.4836131095152, 14841.406343746237, 14874.405023799036, 14898.478553250585, 14919.104853708704, 14934.178620175886, 15906.125163116025, 16127.0, 16260.593485162848, 16397.67204655912, 16413.917930410393, 11923.347766807045, 11963.282203067756, 11995.700107497383, 12121.151519393647, 12254.754904901942, 3891.1633998690136, 3895.3962135868987, 3904.8828535143707, 3926.0381206604566, 3945.5265368156006, 66165.66917165383, 66352.00471992925, 66481.335186648, 67121.66439167772, 67277.0, 10886.564537418415, 11039.668809935714, 11139.888601114048, 11282.548698051985, 11425.0, 22890.771092289197, 23153.884230579075, 23204.18785342505, 23222.187223447436, 23298.65052024221, 8332.833343333099, 8380.0, 8475.237228649452, 8535.103814099555, 8697.739067827975, 5056.469070747592, 5103.464136265713, 5128.410232823198, 5224.634275600747, 5270.78916843322, 3562.7327950403824, 3690.9630903691154, 3691.354013047706, 3691.7600355976774, 3698.0385099874225, 593.7506247376112, 596.4095545410013, 604.4439116013278, 605.5065121925704, 615.8429600451946, 712.3232928717636, 744.4974642116549, 747.4132805747462, 749.056189201599, 752.2139364364252, 9703.272254580934, 9745.951270243604, 9800.019998000143, 9809.117179453884, 9891.901080989099, 583.5710752596838, 594.8215535339381, 673.4713250098649, 679.2358596578849, 691.761342336893, 4561.0, 4590.563896429834, 4765.309030190603, 4792.137415265286, 4823.324734537167, 107221.46389268004, 108439.0, 110672.0, 111683.0, 115840.0, 65644.0, 71333.64333178301, 93527.53236233775, 94984.0501594989, 95759.52120239355, 87415.12584874197, 87598.56200718955, 87960.0, 88215.0, 89798.55100724586, 10400.895991039994, 10538.894611054098, 10675.89324106749, 10758.40828754426, 10801.459927003461, 49326.0, 50752.23871642002, 51242.0, 52057.7397113012, 53303.0, 72037.6398118006, 77625.0, 78330.0, 78481.0, 79381.0, 12732.745345093232, 13175.2753598553, 13707.246101464516, 13728.45086196541, 13822.792658109935, 15042.0, 15175.16536590498, 15591.220438978233, 15674.764878526603, 15925.920370398075, 13676.247806370746, 14133.222672752687, 14273.785893211403, 14649.487267945571, 14686.706265874836, 12429.44067516982, 12540.686482837637, 13031.739365212832, 14550.199739014033, 14981.625459363604, 13068.085234033526, 13336.333183340601, 13642.590722278348, 13834.584962451143, 13897.791533127214, 10714.73213169677, 11005.504752286326, 11303.434828258718, 11506.712332191762, 11657.0, 11866.881331186578, 12024.33866137371, 12188.146829721834, 12283.877161228631, 12511.812322815347], "value": 7654.71460366019, "unit": "score"}], "name": "dromaeo_css", "value": 7212.887701437828, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 103.0, 112.0, 110.0, 111.0, 107.0, 109.0, 109.0, 109.0, 110.0], "value": 108.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 123.0, 127.0, 173.0, 126.0, 128.0, 151.0, 129.0, 181.0, 130.0], "value": 142.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 161.0, 161.0, 160.0, 159.0, 161.0, 161.0, 159.0, 159.0], "value": 160.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 73.0, 76.0, 99.0, 74.0, 77.0, 78.0, 75.0, 99.0, 74.0], "value": 79.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 83.0, 116.0, 84.0, 86.0, 85.0, 113.0, 84.0, 85.0, 119.0], "value": 94.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 145.0, 145.0, 146.0, 147.0, 146.0, 146.0, 147.0, 146.0], "value": 145.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 57.0, 58.0, 58.0, 57.0, 57.0, 58.0, 57.0, 59.0], "value": 57.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 60.0, 59.0, 59.0, 59.0, 59.0, 59.0, 59.0, 60.0], "value": 59.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 77.0, 83.0, 77.0, 77.0, 95.0, 83.0, 84.0, 124.0, 79.0], "value": 86.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 134.0, 123.0, 119.0, 115.0, 124.0, 125.0, 129.0, 141.0, 125.0], "value": 126.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 154.0, 158.0, 157.0, 156.0, 158.0, 157.0, 159.0, 151.0, 154.0], "value": 155.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 63.0, 64.0, 61.0, 63.0, 62.0, 62.0, 63.0, 62.0, 59.0], "value": 62.6, "unit": "score"}], "name": "kraken", "value": 1491.3999999999999, "alertThreshold": 2.0}]} 19:15:47 INFO - Return code: 0 19:15:47 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:15:47 ERROR - # TBPL SUCCESS # 19:15:47 INFO - Running post-action listener: _resource_record_post_action 19:15:47 INFO - ##### 19:15:47 INFO - ##### Finished run-tests step (success) 19:15:47 INFO - ##### 19:15:47 INFO - Running post-run listener: _resource_record_post_run 19:15:47 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 8011776; Write bytes: 376897536; Read time: 1804; Write time: 319740 19:15:47 INFO - TinderboxPrint: CPU usage
13.0% 19:15:47 INFO - TinderboxPrint: I/O read bytes / time
8,011,776 / 1,804 19:15:47 INFO - TinderboxPrint: I/O write bytes / time
376,897,536 / 319,740 19:15:47 INFO - TinderboxPrint: CPU idle
8,274.0 (87.0%) 19:15:47 INFO - TinderboxPrint: CPU user
1,193.2 (12.5%) 19:15:47 INFO - TinderboxPrint: Swap in / out
0 / 0 19:15:47 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 2363392; Read time: 0; Write time: 2468 19:15:47 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 8011776; Write bytes: 374534144; Read time: 1804; Write time: 317272 19:15:47 INFO - Running post-run listener: _upload_blobber_files 19:15:47 INFO - Blob upload gear active. 19:15:47 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:15:47 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 19:15:47 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-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 19:15:47 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-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 19:15:48 INFO - (blobuploader) - INFO - Open directory for files ... 19:15:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 19:15:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:15:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:15:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 19:15:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:15:49 INFO - (blobuploader) - INFO - Done attempting. 19:15:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 19:15:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:15:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:15:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 19:15:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:15:49 INFO - (blobuploader) - INFO - Done attempting. 19:15:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:15:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:15:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:15:54 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:15:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:15:54 INFO - (blobuploader) - INFO - Done attempting. 19:15:54 INFO - (blobuploader) - INFO - Iteration through files over. 19:15:54 INFO - Return code: 0 19:15:54 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:15:54 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:15:54 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b7fb2a2cb19902f3f48ca8db7c9ce4697db26deb15800042c52293a892bc743701afe49d7fb15115a76a9b27b5eb7fe677c4223d514973211aeaa988a795110e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/47f75db5c0a33037f7b1e1a22bdec2b602a1ea3991d4424294b199ca458b89a535230ddc2aa7dc1f17bd85e3c8d1ab990ad914432159d0d909a27a65357debb8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1194d077eb29aacab1be41a5166f8b488d88f9103a1293f030e40e9f2ee6a2e45b9c1535a1eb683532664957fc18624309ca237b28881b59417799576901595c"} 19:15:54 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:15:54 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:15:54 INFO - Contents: 19:15:54 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b7fb2a2cb19902f3f48ca8db7c9ce4697db26deb15800042c52293a892bc743701afe49d7fb15115a76a9b27b5eb7fe677c4223d514973211aeaa988a795110e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/47f75db5c0a33037f7b1e1a22bdec2b602a1ea3991d4424294b199ca458b89a535230ddc2aa7dc1f17bd85e3c8d1ab990ad914432159d0d909a27a65357debb8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1194d077eb29aacab1be41a5166f8b488d88f9103a1293f030e40e9f2ee6a2e45b9c1535a1eb683532664957fc18624309ca237b28881b59417799576901595c"} 19:15:54 INFO - Running post-run listener: copy_logs_to_upload_dir 19:15:54 INFO - Copying logs to upload dir... 19:15:54 INFO - mkdir: /builds/slave/test/build/upload/logs 19:15:54 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.069063 ========= master_lag: 0.12 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-07-12 19:15:54.334336) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-12 19:15:54.337638) ========= 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=56c518bb7cbc29fb3c9463e2000001c4-1468374756.115701-1499394416 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b7fb2a2cb19902f3f48ca8db7c9ce4697db26deb15800042c52293a892bc743701afe49d7fb15115a76a9b27b5eb7fe677c4223d514973211aeaa988a795110e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/47f75db5c0a33037f7b1e1a22bdec2b602a1ea3991d4424294b199ca458b89a535230ddc2aa7dc1f17bd85e3c8d1ab990ad914432159d0d909a27a65357debb8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1194d077eb29aacab1be41a5166f8b488d88f9103a1293f030e40e9f2ee6a2e45b9c1535a1eb683532664957fc18624309ca237b28881b59417799576901595c"} build_url:https://queue.taskcluster.net/v1/task/Nn3JUOTFQjyO9V21Tv3zsA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011239 build_url: 'https://queue.taskcluster.net/v1/task/Nn3JUOTFQjyO9V21Tv3zsA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b7fb2a2cb19902f3f48ca8db7c9ce4697db26deb15800042c52293a892bc743701afe49d7fb15115a76a9b27b5eb7fe677c4223d514973211aeaa988a795110e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/47f75db5c0a33037f7b1e1a22bdec2b602a1ea3991d4424294b199ca458b89a535230ddc2aa7dc1f17bd85e3c8d1ab990ad914432159d0d909a27a65357debb8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1194d077eb29aacab1be41a5166f8b488d88f9103a1293f030e40e9f2ee6a2e45b9c1535a1eb683532664957fc18624309ca237b28881b59417799576901595c"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-12 19:15:54.364801) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 19:15:54.365229) ========= 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=56c518bb7cbc29fb3c9463e2000001c4-1468374756.115701-1499394416 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004405 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 19:15:54.445656) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-12 19:15:54.445960) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-12 19:15:54.446261) ========= ========= Total master_lag: 0.28 =========