builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0338 starttime: 1488561965.68 results: success (0) buildid: 20170303084451 builduid: 1e4d5eaed95844fc920d476769a716e8 revision: b946ece0c9d2bf34a925d13d08be2724f275dfd5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-03 09:26:05.684797) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-03 09:26:05.685252) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-03 09:26:05.685522) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-03 09:26:05.710675) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-03 09:26:05.711055) ========= 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: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Mre7AZMiB0/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.ypL2yH2MfI/Listeners TMPDIR=/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-03-03 09:26:05-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 8.30M=0.001s 2017-03-03 09:26:05 (8.30 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.139070 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-03 09:26:05.873769) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-03 09:26:05.874098) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Mre7AZMiB0/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.ypL2yH2MfI/Listeners TMPDIR=/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.020223 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-03 09:26:05.922882) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-03 09:26:05.923362) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev b946ece0c9d2bf34a925d13d08be2724f275dfd5 --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 b946ece0c9d2bf34a925d13d08be2724f275dfd5 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Mre7AZMiB0/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.ypL2yH2MfI/Listeners TMPDIR=/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-03-03 09:26:06,015 truncating revision to first 12 chars 2017-03-03 09:26:06,016 Setting DEBUG logging. 2017-03-03 09:26:06,016 attempt 1/10 2017-03-03 09:26:06,016 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/b946ece0c9d2?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-03 09:26:07,239 unpacking tar archive at: mozilla-aurora-b946ece0c9d2/testing/mozharness/ program finished with exit code 0 elapsedTime=1.486916 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-03 09:26:07.434271) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-03 09:26:07.434640) ========= script_repo_revision: b946ece0c9d2bf34a925d13d08be2724f275dfd5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-03 09:26:07.435040) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-03 09:26:07.435339) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-03 09:26:07.455360) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2017-03-03 09:26:07.455728) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_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', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Mre7AZMiB0/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.ypL2yH2MfI/Listeners TMPDIR=/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 09:26:07 INFO - MultiFileLogger online at 20170303 09:26:07 in /builds/slave/test 09:26:07 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 09:26:07 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:26:07 INFO - {'append_to_log': False, 09:26:07 INFO - 'base_work_dir': '/builds/slave/test', 09:26:07 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 09:26:07 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:26:07 INFO - 'branch': 'Mozilla-Aurora', 09:26:07 INFO - 'buildbot_json_path': 'buildprops.json', 09:26:07 INFO - 'config_files': ('talos/mac_config.py',), 09:26:07 INFO - 'default_actions': ('clobber', 09:26:07 INFO - 'read-buildbot-config', 09:26:07 INFO - 'download-and-extract', 09:26:07 INFO - 'populate-webroot', 09:26:07 INFO - 'create-virtualenv', 09:26:07 INFO - 'install', 09:26:07 INFO - 'run-tests'), 09:26:07 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:26:07 INFO - 'download_minidump_stackwalk': True, 09:26:07 INFO - 'download_symbols': 'ondemand', 09:26:07 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:26:07 INFO - 'tooltool.py': '/tools/tooltool.py', 09:26:07 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:26:07 INFO - '/tools/misc-python/virtualenv.py')}, 09:26:07 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:26:07 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:26:07 INFO - 'installer_path': 'installer.exe', 09:26:07 INFO - 'log_level': 'info', 09:26:07 INFO - 'log_name': 'talos', 09:26:07 INFO - 'log_to_console': True, 09:26:07 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 09:26:07 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 09:26:07 INFO - 'opt_config_files': (), 09:26:07 INFO - 'pip_index': False, 09:26:07 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:26:07 INFO - 'cmd': ('bash', 09:26:07 INFO - '-c', 09:26:07 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:26:07 INFO - 'enabled': True, 09:26:07 INFO - 'halt_on_failure': False, 09:26:07 INFO - 'name': 'check_screen_resolution'},), 09:26:07 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:26:07 INFO - 'cmd': ('bash', 09:26:07 INFO - '-c', 09:26:07 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:26:07 INFO - 'enabled': True, 09:26:07 INFO - 'halt_on_failure': False, 09:26:07 INFO - 'name': 'check_screen_resolution'},), 09:26:07 INFO - 'run_cmd_checks_enabled': True, 09:26:07 INFO - 'sps_profile': False, 09:26:07 INFO - 'sps_profile_interval': 0, 09:26:07 INFO - 'suite': 'dromaeojs', 09:26:07 INFO - 'system_bits': '32', 09:26:07 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:26:07 INFO - 'title': 't-yosemite-r7-0338', 09:26:07 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:26:07 INFO - 'use_talos_json': True, 09:26:07 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:26:07 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:26:07 INFO - 'work_dir': 'build'} 09:26:07 INFO - [mozharness: 2017-03-03 17:26:07.667476Z] Running clobber step. 09:26:07 INFO - Running pre-action listener: _resource_record_pre_action 09:26:07 INFO - Running main action method: clobber 09:26:07 INFO - rmtree: /builds/slave/test/build 09:26:07 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:26:09 INFO - Running post-action listener: _resource_record_post_action 09:26:09 INFO - [mozharness: 2017-03-03 17:26:09.597422Z] Finished clobber step (success) 09:26:09 INFO - [mozharness: 2017-03-03 17:26:09.597647Z] Running read-buildbot-config step. 09:26:09 INFO - Running pre-action listener: _resource_record_pre_action 09:26:09 INFO - Running main action method: read_buildbot_config 09:26:09 INFO - Using buildbot properties: 09:26:09 INFO - { 09:26:09 INFO - "project": "", 09:26:09 INFO - "product": "firefox", 09:26:09 INFO - "script_repo_revision": "production", 09:26:09 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 09:26:09 INFO - "repository": "", 09:26:09 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 09:26:09 INFO - "buildid": "20170303084451", 09:26:09 INFO - "pgo_build": "False", 09:26:09 INFO - "basedir": "/builds/slave/test", 09:26:09 INFO - "buildnumber": 76, 09:26:09 INFO - "slavename": "t-yosemite-r7-0338", 09:26:09 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 09:26:09 INFO - "platform": "yosemite_r7", 09:26:09 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 09:26:09 INFO - "branch": "mozilla-aurora", 09:26:09 INFO - "repo_path": "releases/mozilla-aurora", 09:26:09 INFO - "revision": "b946ece0c9d2bf34a925d13d08be2724f275dfd5", 09:26:09 INFO - "stage_platform": "macosx64", 09:26:09 INFO - "builduid": "1e4d5eaed95844fc920d476769a716e8", 09:26:09 INFO - "slavebuilddir": "test" 09:26:09 INFO - } 09:26:09 INFO - Found installer url https://queue.taskcluster.net/v1/task/M_o_oOgpTpC3YE29EHfi4Q/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg. 09:26:09 INFO - Running post-action listener: _resource_record_post_action 09:26:09 INFO - [mozharness: 2017-03-03 17:26:09.602899Z] Finished read-buildbot-config step (success) 09:26:09 INFO - [mozharness: 2017-03-03 17:26:09.603107Z] Running download-and-extract step. 09:26:09 INFO - Running pre-action listener: _resource_record_pre_action 09:26:09 INFO - Running main action method: download_and_extract 09:26:09 INFO - mkdir: /builds/slave/test/build/tests 09:26:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:26:09 INFO - trying https://queue.taskcluster.net/v1/task/M_o_oOgpTpC3YE29EHfi4Q/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json 09:26:09 INFO - Downloading https://queue.taskcluster.net/v1/task/M_o_oOgpTpC3YE29EHfi4Q/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 09:26:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/M_o_oOgpTpC3YE29EHfi4Q/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json'}, attempt #1 09:26:11 INFO - Downloaded 1199 bytes. 09:26:11 INFO - Reading from file /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 09:26:11 INFO - Using the following test package requirements: 09:26:11 INFO - {u'common': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 09:26:11 INFO - u'cppunittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 09:26:11 INFO - u'firefox-53.0a2.en-US.mac.cppunittest.tests.zip'], 09:26:11 INFO - u'gtest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 09:26:11 INFO - u'firefox-53.0a2.en-US.mac.gtest.tests.zip'], 09:26:11 INFO - u'jittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 09:26:11 INFO - u'jsshell-mac.zip'], 09:26:11 INFO - u'mochitest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 09:26:11 INFO - u'firefox-53.0a2.en-US.mac.mochitest.tests.zip'], 09:26:11 INFO - u'mozbase': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 09:26:11 INFO - u'reftest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 09:26:11 INFO - u'firefox-53.0a2.en-US.mac.reftest.tests.zip'], 09:26:11 INFO - u'talos': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 09:26:11 INFO - u'firefox-53.0a2.en-US.mac.talos.tests.zip'], 09:26:11 INFO - u'web-platform': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 09:26:11 INFO - u'firefox-53.0a2.en-US.mac.web-platform.tests.zip'], 09:26:11 INFO - u'xpcshell': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 09:26:11 INFO - u'firefox-53.0a2.en-US.mac.xpcshell.tests.zip']} 09:26:11 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip'] for test suite category: common 09:26:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/M_o_oOgpTpC3YE29EHfi4Q/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 09:26:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/M_o_oOgpTpC3YE29EHfi4Q/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 09:26:11 INFO - Fetch https://queue.taskcluster.net/v1/task/M_o_oOgpTpC3YE29EHfi4Q/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 09:26:12 INFO - Expected file size: 16357779 09:26:12 INFO - Obtained file size: 16357779 09:26:18 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip', u'firefox-53.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 09:26:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/M_o_oOgpTpC3YE29EHfi4Q/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 09:26:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/M_o_oOgpTpC3YE29EHfi4Q/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 09:26:18 INFO - Fetch https://queue.taskcluster.net/v1/task/M_o_oOgpTpC3YE29EHfi4Q/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 09:26:19 INFO - Expected file size: 16357779 09:26:19 INFO - Obtained file size: 16357779 09:26:25 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/M_o_oOgpTpC3YE29EHfi4Q/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip 09:26:25 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/M_o_oOgpTpC3YE29EHfi4Q/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip'}, attempt #1 09:26:25 INFO - Fetch https://queue.taskcluster.net/v1/task/M_o_oOgpTpC3YE29EHfi4Q/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip into memory 09:26:26 INFO - Expected file size: 14403650 09:26:26 INFO - Obtained file size: 14403650 09:26: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:26:26 INFO - trying https://queue.taskcluster.net/v1/task/M_o_oOgpTpC3YE29EHfi4Q/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 09:26:26 INFO - Downloading https://queue.taskcluster.net/v1/task/M_o_oOgpTpC3YE29EHfi4Q/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg 09:26:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/M_o_oOgpTpC3YE29EHfi4Q/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg'}, attempt #1 09:26:28 INFO - Downloaded 73900393 bytes. 09:26:28 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/M_o_oOgpTpC3YE29EHfi4Q/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 09:26:28 INFO - mkdir: /builds/slave/test/properties 09:26:28 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:26:28 INFO - Writing to file /builds/slave/test/properties/build_url 09:26:28 INFO - Contents: 09:26:28 INFO - build_url:https://queue.taskcluster.net/v1/task/M_o_oOgpTpC3YE29EHfi4Q/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 09:26:29 INFO - Running post-action listener: _resource_record_post_action 09:26:29 INFO - Running post-action listener: set_extra_try_arguments 09:26:29 INFO - [mozharness: 2017-03-03 17:26:29.628742Z] Finished download-and-extract step (success) 09:26:29 INFO - [mozharness: 2017-03-03 17:26:29.628892Z] Running populate-webroot step. 09:26:29 INFO - Running pre-action listener: _resource_record_pre_action 09:26:29 INFO - Running main action method: populate_webroot 09:26:29 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:26:29 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:26:29 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:26:29 INFO - '--tppagecycles', 09:26:29 INFO - '7'], 09:26:29 INFO - 'tests': ['tsvgm']}}, 09:26:29 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:26:29 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:26:29 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:26:29 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:26:29 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:26:29 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:26:29 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 09:26:29 INFO - 'talos_options': ['--disable-e10s'], 09:26:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:26:29 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 09:26:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:26:29 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 09:26:29 INFO - 'talos_options': ['--disable-e10s'], 09:26:29 INFO - 'tests': ['damp', 'tps']}, 09:26:29 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 09:26:29 INFO - 'tests': ['damp', 'tps']}, 09:26:29 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:26:29 INFO - 'tests': ['dromaeo_dom']}, 09:26:29 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:26:29 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:26:29 INFO - 'tests': ['basic_compositor_video']}, 09:26:29 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:26:29 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:26:29 INFO - 'tests': ['a11yr', 09:26:29 INFO - 'ts_paint', 09:26:29 INFO - 'tpaint', 09:26:29 INFO - 'sessionrestore', 09:26:29 INFO - 'sessionrestore_no_auto_restore', 09:26:29 INFO - 'tabpaint']}, 09:26:29 INFO - 'other-e10s': {'tests': ['a11yr', 09:26:29 INFO - 'ts_paint', 09:26:29 INFO - 'tpaint', 09:26:29 INFO - 'sessionrestore', 09:26:29 INFO - 'sessionrestore_no_auto_restore', 09:26:29 INFO - 'tabpaint']}, 09:26:29 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:26:29 INFO - 'ts_paint', 09:26:29 INFO - 'tpaint', 09:26:29 INFO - 'sessionrestore', 09:26:29 INFO - 'sessionrestore_no_auto_restore', 09:26:29 INFO - 'tabpaint']}, 09:26:29 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:26:29 INFO - 'ts_paint', 09:26:29 INFO - 'tpaint', 09:26:29 INFO - 'sessionrestore', 09:26:29 INFO - 'sessionrestore_no_auto_restore', 09:26:29 INFO - 'tabpaint']}, 09:26:29 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:26:29 INFO - 'tests': ['a11yr', 09:26:29 INFO - 'ts_paint', 09:26:29 INFO - 'tpaint', 09:26:29 INFO - 'sessionrestore', 09:26:29 INFO - 'sessionrestore_no_auto_restore', 09:26:29 INFO - 'tabpaint']}, 09:26:29 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:26:29 INFO - 'tests': ['a11yr', 09:26:29 INFO - 'ts_paint', 09:26:29 INFO - 'tpaint', 09:26:29 INFO - 'sessionrestore', 09:26:29 INFO - 'sessionrestore_no_auto_restore', 09:26:29 INFO - 'tabpaint']}, 09:26:29 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:26:29 INFO - 'tests': ['tsvgx', 09:26:29 INFO - 'tsvgr_opacity', 09:26:29 INFO - 'tart', 09:26:29 INFO - 'tscrollx', 09:26:29 INFO - 'cart', 09:26:29 INFO - 'tsvg_static']}, 09:26:29 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:26:29 INFO - 'tsvgr_opacity', 09:26:29 INFO - 'tart', 09:26:29 INFO - 'tscrollx', 09:26:29 INFO - 'cart', 09:26:29 INFO - 'tsvg_static']}, 09:26:29 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 09:26:29 INFO - 'talos_options': ['--disable-e10s'], 09:26:29 INFO - 'tests': ['tp5o']}, 09:26:29 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 09:26:29 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 09:26:29 INFO - 'talos_options': ['--disable-e10s', 09:26:29 INFO - '--xperf_path', 09:26:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:26:29 INFO - 'tests': ['tp5n']}, 09:26:29 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 09:26:29 INFO - 'talos_options': ['--xperf_path', 09:26:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:26:29 INFO - 'tests': ['tp5n']}}, 09:26:29 INFO - 'talos.zip': {'path': '', 09:26:29 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:26:29 INFO - Running post-action listener: _resource_record_post_action 09:26:29 INFO - [mozharness: 2017-03-03 17:26:29.647139Z] Finished populate-webroot step (success) 09:26:29 INFO - [mozharness: 2017-03-03 17:26:29.647276Z] Running create-virtualenv step. 09:26:29 INFO - Running pre-action listener: _resource_record_pre_action 09:26:29 INFO - Running main action method: create_virtualenv 09:26:29 INFO - Creating virtualenv /builds/slave/test/build/venv 09:26:29 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 09:26:29 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:26:29 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:26:29 INFO - Using real prefix '/tools/python27' 09:26:29 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:26:30 INFO - Installing distribute.............................................................................................................................................................................................done. 09:26:33 INFO - Installing pip.................done. 09:26:33 INFO - Return code: 0 09:26:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:26:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:26:33 INFO - Reading from file tmpfile_stdout 09:26:33 INFO - Output received: 09:26:33 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 09:26:33 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:26:33 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:26:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:26:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:26:33 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:26:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:26:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:26:33 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 0x10dc78b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dc7b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff211d6c9e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10da56d30>, '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 0x10d97ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10da4bbe8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Mre7AZMiB0/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ypL2yH2MfI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:26:33 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 09:26:33 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 09:26:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Mre7AZMiB0/Render', 09:26:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:26:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:26:33 INFO - 'HOME': '/Users/cltbld', 09:26:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:26:33 INFO - 'LOGNAME': 'cltbld', 09:26:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:26:33 INFO - 'MOZ_NO_REMOTE': '1', 09:26:33 INFO - 'NO_EM_RESTART': '1', 09:26:33 INFO - 'PAGER': '/bin/cat', 09:26:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:26:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:26:33 INFO - 'PWD': '/builds/slave/test', 09:26:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:26:33 INFO - 'SHELL': '/bin/bash', 09:26:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ypL2yH2MfI/Listeners', 09:26:33 INFO - 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/', 09:26:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:26:33 INFO - 'USER': 'cltbld', 09:26:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:26:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:26:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:26:33 INFO - 'XPC_FLAGS': '0x0', 09:26:33 INFO - 'XPC_SERVICE_NAME': '0', 09:26:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:26:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:26:33 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 09:26:33 INFO - Cleaning up... 09:26:33 INFO - Return code: 0 09:26:33 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:26:33 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:26:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:26:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:26:33 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:26:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:26:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:26:33 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 0x10dc78b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dc7b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff211d6c9e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10da56d30>, '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 0x10d97ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10da4bbe8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Mre7AZMiB0/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ypL2yH2MfI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:26:33 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 09:26:33 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 09:26:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Mre7AZMiB0/Render', 09:26:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:26:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:26:33 INFO - 'HOME': '/Users/cltbld', 09:26:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:26:33 INFO - 'LOGNAME': 'cltbld', 09:26:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:26:33 INFO - 'MOZ_NO_REMOTE': '1', 09:26:33 INFO - 'NO_EM_RESTART': '1', 09:26:33 INFO - 'PAGER': '/bin/cat', 09:26:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:26:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:26:33 INFO - 'PWD': '/builds/slave/test', 09:26:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:26:33 INFO - 'SHELL': '/bin/bash', 09:26:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ypL2yH2MfI/Listeners', 09:26:33 INFO - 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/', 09:26:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:26:33 INFO - 'USER': 'cltbld', 09:26:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:26:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:26:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:26:33 INFO - 'XPC_FLAGS': '0x0', 09:26:33 INFO - 'XPC_SERVICE_NAME': '0', 09:26:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:26:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:26:34 INFO - Downloading/unpacking psutil>=3.1.1 09:26:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:26:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:26:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:26:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:26:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:26:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:26:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:26:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:26:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:26:37 INFO - Installing collected packages: psutil 09:26:37 INFO - Running setup.py install for psutil 09:26:37 INFO - building 'psutil._psutil_osx' extension 09:26:37 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 09:26:38 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 09:26:38 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 09:26:38 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 09:26:38 INFO - building 'psutil._psutil_posix' extension 09:26:38 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 09:26:38 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 09:26:38 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 09:26:38 INFO - ^ 09:26:38 INFO - 1 warning generated. 09:26:38 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 09:26:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:26:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:26:38 INFO - Successfully installed psutil 09:26:38 INFO - Cleaning up... 09:26:38 INFO - Return code: 0 09:26:38 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:26: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:26:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:26:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:26: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:26:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:26:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:26: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10dc78b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dc7b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff211d6c9e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10da56d30>, '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 0x10d97ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10da4bbe8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Mre7AZMiB0/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ypL2yH2MfI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:26: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 09:26: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 mozsystemmonitor==0.3 09:26:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Mre7AZMiB0/Render', 09:26:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:26:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:26:38 INFO - 'HOME': '/Users/cltbld', 09:26:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:26:38 INFO - 'LOGNAME': 'cltbld', 09:26:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:26:38 INFO - 'MOZ_NO_REMOTE': '1', 09:26:38 INFO - 'NO_EM_RESTART': '1', 09:26:38 INFO - 'PAGER': '/bin/cat', 09:26:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:26:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:26:38 INFO - 'PWD': '/builds/slave/test', 09:26:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:26:38 INFO - 'SHELL': '/bin/bash', 09:26:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ypL2yH2MfI/Listeners', 09:26:38 INFO - 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/', 09:26:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:26:38 INFO - 'USER': 'cltbld', 09:26:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:26:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:26:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:26:38 INFO - 'XPC_FLAGS': '0x0', 09:26:38 INFO - 'XPC_SERVICE_NAME': '0', 09:26:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:26:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:26:38 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:26: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 09:26: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 09:26: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 09:26: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 09:26: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 09:26: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 09:26:41 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:26:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:26:41 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:26:41 INFO - Installing collected packages: mozsystemmonitor 09:26:41 INFO - Running setup.py install for mozsystemmonitor 09:26:41 INFO - Successfully installed mozsystemmonitor 09:26:41 INFO - Cleaning up... 09:26:41 INFO - Return code: 0 09:26:41 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:26:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:26:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:26:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:26:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:26:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:26:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:26:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10dc78b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dc7b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff211d6c9e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10da56d30>, '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 0x10d97ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10da4bbe8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Mre7AZMiB0/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ypL2yH2MfI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:26:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 09:26:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 09:26:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Mre7AZMiB0/Render', 09:26:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:26:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:26:41 INFO - 'HOME': '/Users/cltbld', 09:26:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:26:41 INFO - 'LOGNAME': 'cltbld', 09:26:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:26:41 INFO - 'MOZ_NO_REMOTE': '1', 09:26:41 INFO - 'NO_EM_RESTART': '1', 09:26:41 INFO - 'PAGER': '/bin/cat', 09:26:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:26:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:26:41 INFO - 'PWD': '/builds/slave/test', 09:26:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:26:41 INFO - 'SHELL': '/bin/bash', 09:26:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ypL2yH2MfI/Listeners', 09:26:41 INFO - 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/', 09:26:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:26:41 INFO - 'USER': 'cltbld', 09:26:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:26:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:26:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:26:41 INFO - 'XPC_FLAGS': '0x0', 09:26:41 INFO - 'XPC_SERVICE_NAME': '0', 09:26:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:26:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:26:42 INFO - Downloading/unpacking jsonschema==2.5.1 09:26: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 09:26: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 09:26: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 09:26: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 09:26: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 09:26: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 09:26:44 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:26:44 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:26:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:26:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:26:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:26:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:26:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:26:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:26:45 INFO - Downloading functools32-3.2.3-2.tar.gz 09:26:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:26:45 INFO - warning: no files found matching '*.txt' 09:26:45 INFO - no previously-included directories found matching 'build' 09:26:45 INFO - no previously-included directories found matching 'dist' 09:26:45 INFO - no previously-included directories found matching '.git*' 09:26:45 INFO - Installing collected packages: jsonschema, functools32 09:26:45 INFO - Running setup.py install for functools32 09:26:45 INFO - warning: no files found matching '*.txt' 09:26:45 INFO - no previously-included directories found matching 'build' 09:26:45 INFO - no previously-included directories found matching 'dist' 09:26:45 INFO - no previously-included directories found matching '.git*' 09:26:45 INFO - Successfully installed jsonschema functools32 09:26:45 INFO - Cleaning up... 09:26:45 INFO - Return code: 0 09:26:45 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:26:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:26:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:26:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:26:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:26:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:26:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:26:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10dc78b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dc7b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff211d6c9e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10da56d30>, '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 0x10d97ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10da4bbe8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Mre7AZMiB0/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ypL2yH2MfI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:26:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 09:26:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 09:26:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Mre7AZMiB0/Render', 09:26:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:26:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:26:45 INFO - 'HOME': '/Users/cltbld', 09:26:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:26:45 INFO - 'LOGNAME': 'cltbld', 09:26:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:26:45 INFO - 'MOZ_NO_REMOTE': '1', 09:26:45 INFO - 'NO_EM_RESTART': '1', 09:26:45 INFO - 'PAGER': '/bin/cat', 09:26:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:26:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:26:45 INFO - 'PWD': '/builds/slave/test', 09:26:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:26:45 INFO - 'SHELL': '/bin/bash', 09:26:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ypL2yH2MfI/Listeners', 09:26:45 INFO - 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/', 09:26:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:26:45 INFO - 'USER': 'cltbld', 09:26:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:26:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:26:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:26:45 INFO - 'XPC_FLAGS': '0x0', 09:26:45 INFO - 'XPC_SERVICE_NAME': '0', 09:26:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:26:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:26:45 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:26:45 INFO - Cleaning up... 09:26:45 INFO - Return code: 0 09:26:45 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:26:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:26:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:26:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:26:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:26:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:26:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:26:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10dc78b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dc7b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff211d6c9e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10da56d30>, '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 0x10d97ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10da4bbe8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Mre7AZMiB0/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ypL2yH2MfI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:26:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:26:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:26:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Mre7AZMiB0/Render', 09:26:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:26:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:26:45 INFO - 'HOME': '/Users/cltbld', 09:26:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:26:45 INFO - 'LOGNAME': 'cltbld', 09:26:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:26:45 INFO - 'MOZ_NO_REMOTE': '1', 09:26:45 INFO - 'NO_EM_RESTART': '1', 09:26:45 INFO - 'PAGER': '/bin/cat', 09:26:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:26:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:26:45 INFO - 'PWD': '/builds/slave/test', 09:26:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:26:45 INFO - 'SHELL': '/bin/bash', 09:26:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ypL2yH2MfI/Listeners', 09:26:45 INFO - 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/', 09:26:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:26:45 INFO - 'USER': 'cltbld', 09:26:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:26:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:26:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:26:45 INFO - 'XPC_FLAGS': '0x0', 09:26:45 INFO - 'XPC_SERVICE_NAME': '0', 09:26:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:26:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:26:46 INFO - Downloading/unpacking blobuploader==1.2.4 09:26:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:26:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:26:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:26:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:26:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:26:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:26:48 INFO - Downloading blobuploader-1.2.4.tar.gz 09:26:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:26:48 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:26: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 09:26: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 09:26: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 09:26: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 09:26: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 09:26: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 09:26:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:26:49 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:26:49 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 09:26:49 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 09:26:49 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 09:26:49 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 09:26:49 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 09:26:49 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 09:26:49 INFO - Downloading docopt-0.6.1.tar.gz 09:26:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:26:50 INFO - Installing collected packages: blobuploader, requests, docopt 09:26:50 INFO - Running setup.py install for blobuploader 09:26:50 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:26:50 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:26:50 INFO - Running setup.py install for requests 09:26:50 INFO - Running setup.py install for docopt 09:26:50 INFO - Successfully installed blobuploader requests docopt 09:26:50 INFO - Cleaning up... 09:26:50 INFO - Return code: 0 09:26:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:26:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:26:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:26:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:26:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:26:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:26:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:26:50 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 0x10dc78b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dc7b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff211d6c9e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10da56d30>, '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 0x10d97ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10da4bbe8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Mre7AZMiB0/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ypL2yH2MfI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:26:51 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 09:26:51 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 09:26:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Mre7AZMiB0/Render', 09:26:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:26:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:26:51 INFO - 'HOME': '/Users/cltbld', 09:26:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:26:51 INFO - 'LOGNAME': 'cltbld', 09:26:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:26:51 INFO - 'MOZ_NO_REMOTE': '1', 09:26:51 INFO - 'NO_EM_RESTART': '1', 09:26:51 INFO - 'PAGER': '/bin/cat', 09:26:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:26:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:26:51 INFO - 'PWD': '/builds/slave/test', 09:26:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:26:51 INFO - 'SHELL': '/bin/bash', 09:26:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ypL2yH2MfI/Listeners', 09:26:51 INFO - 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/', 09:26:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:26:51 INFO - 'USER': 'cltbld', 09:26:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:26:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:26:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:26:51 INFO - 'XPC_FLAGS': '0x0', 09:26:51 INFO - 'XPC_SERVICE_NAME': '0', 09:26:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:26:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:26:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:26:51 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-s2AaeM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:26:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:26:51 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-iaZaEN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:26:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:26:51 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-tcvLFv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:26:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:26:51 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-9YqrUf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:26:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:26:51 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-MTIUKN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:26:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:26:51 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-ZNZ_AS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:26:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:26:51 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-uSdr13-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:26:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:26:51 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-4hwHeZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:26:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:26:52 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-2oQFRr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:26:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:26:52 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-NUQCgU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:26:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:26:52 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-Bf_t7v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:26:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:26:52 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-3SoIh0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:26:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:26:52 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-CCmCIj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:26:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:26:52 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-40mObh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:26:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:26:52 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-n5BpnD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:26:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:26:52 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-xzBwBK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:26:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:26:52 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-icCSVN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:26:53 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:26:53 INFO - Running setup.py install for manifestparser 09:26:53 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:26:53 INFO - Running setup.py install for mozcrash 09:26:53 INFO - Running setup.py install for mozdebug 09:26:53 INFO - Running setup.py install for mozdevice 09:26:53 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:26:53 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:26:53 INFO - Running setup.py install for mozfile 09:26:53 INFO - Running setup.py install for mozhttpd 09:26:53 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:26:53 INFO - Running setup.py install for mozinfo 09:26:54 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:26:54 INFO - Running setup.py install for mozInstall 09:26:54 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:26:54 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:26:54 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:26:54 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:26:54 INFO - Running setup.py install for mozleak 09:26:54 INFO - Running setup.py install for mozlog 09:26:54 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:26:54 INFO - Running setup.py install for moznetwork 09:26:54 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:26:54 INFO - Running setup.py install for mozprocess 09:26:54 INFO - Running setup.py install for mozprofile 09:26:55 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:26:55 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:26:55 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:26:55 INFO - Running setup.py install for mozrunner 09:26:55 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:26:55 INFO - Running setup.py install for mozscreenshot 09:26:55 INFO - Running setup.py install for moztest 09:26:55 INFO - Running setup.py install for mozversion 09:26:55 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:26:55 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:26:55 INFO - Cleaning up... 09:26:55 INFO - Return code: 0 09:26:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:26:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:26:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:26:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:26:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:26:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:26:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:26:55 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 0x10dc78b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dc7b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff211d6c9e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10da56d30>, '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 0x10d97ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10da4bbe8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Mre7AZMiB0/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ypL2yH2MfI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:26:55 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 09:26:55 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 09:26:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Mre7AZMiB0/Render', 09:26:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:26:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:26:55 INFO - 'HOME': '/Users/cltbld', 09:26:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:26:55 INFO - 'LOGNAME': 'cltbld', 09:26:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:26:55 INFO - 'MOZ_NO_REMOTE': '1', 09:26:55 INFO - 'NO_EM_RESTART': '1', 09:26:55 INFO - 'PAGER': '/bin/cat', 09:26:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:26:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:26:55 INFO - 'PWD': '/builds/slave/test', 09:26:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:26:55 INFO - 'SHELL': '/bin/bash', 09:26:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ypL2yH2MfI/Listeners', 09:26:55 INFO - 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/', 09:26:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:26:55 INFO - 'USER': 'cltbld', 09:26:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:26:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:26:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:26:55 INFO - 'XPC_FLAGS': '0x0', 09:26:55 INFO - 'XPC_SERVICE_NAME': '0', 09:26:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:26:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:26:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:26:55 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-jD_Nbn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:26:56 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)) 09:26:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:26:56 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-AcK3aC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:26:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 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)) 09:26:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:26:56 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-Bitrgj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:26:56 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)) 09:26:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:26:56 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-wDHIQZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:26:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 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)) 09:26:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:26:56 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-bdnTR_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:26:56 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)) 09:26:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:26:56 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-_Crpnf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:26:56 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)) 09:26:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:26:56 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-pnrZYF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:26:56 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)) 09:26:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:26:56 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-NZ83Ll-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:26:56 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)) 09:26:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:26:56 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-JnkWM9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:26:56 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)) 09:26:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:26:56 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-wSBB0f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:26:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 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)) 09:26:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:26:57 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-b3z5NY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:26:57 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)) 09:26:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:26:57 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-RP_QL5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:26:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 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)) 09:26:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:26:57 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-2TD5XJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:26:57 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)) 09:26:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:26:57 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-TNVkq6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:26:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 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)) 09:26:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:26:57 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-eRDFa1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:26:57 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)) 09:26:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:26:57 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-Hcm7qd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:26:57 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 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)) 09:26:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:26:57 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-St4GIx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:26:57 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)) 09:26:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:26:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:26:57 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)) 09:26:57 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:26:57 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:26:57 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:26:57 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 09:26:57 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 09:26:57 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 09:26:57 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 09:26:57 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 09:26:57 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 09:27:00 INFO - Downloading blessings-1.6.tar.gz 09:27:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:27:00 INFO - Installing collected packages: blessings 09:27:00 INFO - Running setup.py install for blessings 09:27:00 INFO - Successfully installed blessings 09:27:00 INFO - Cleaning up... 09:27:00 INFO - Return code: 0 09:27:00 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:27:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:27:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:27:01 INFO - Reading from file tmpfile_stdout 09:27:01 INFO - Current package versions: 09:27:01 INFO - blessings == 1.6 09:27:01 INFO - blobuploader == 1.2.4 09:27:01 INFO - docopt == 0.6.1 09:27:01 INFO - functools32 == 3.2.3-2 09:27:01 INFO - jsonschema == 2.5.1 09:27:01 INFO - manifestparser == 1.1 09:27:01 INFO - mozInstall == 1.12 09:27:01 INFO - mozcrash == 1.0 09:27:01 INFO - mozdebug == 0.1 09:27:01 INFO - mozdevice == 0.49 09:27:01 INFO - mozfile == 1.2 09:27:01 INFO - mozhttpd == 0.7 09:27:01 INFO - mozinfo == 0.9 09:27:01 INFO - mozleak == 0.1 09:27:01 INFO - mozlog == 3.4 09:27:01 INFO - moznetwork == 0.27 09:27:01 INFO - mozprocess == 0.24 09:27:01 INFO - mozprofile == 0.28 09:27:01 INFO - mozrunner == 6.13 09:27:01 INFO - mozscreenshot == 0.1 09:27:01 INFO - mozsystemmonitor == 0.3 09:27:01 INFO - moztest == 0.8 09:27:01 INFO - mozversion == 1.4 09:27:01 INFO - psutil == 3.1.1 09:27:01 INFO - requests == 1.2.3 09:27:01 INFO - wsgiref == 0.1.2 09:27:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:27:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:27:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:27:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:27:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:27:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:27:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:27:01 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 0x10dc78b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dc7b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff211d6c9e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10da56d30>, '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 0x10d97ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10da4bbe8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Mre7AZMiB0/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ypL2yH2MfI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:27:01 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 09:27:01 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 09:27:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Mre7AZMiB0/Render', 09:27:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:27:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:27:01 INFO - 'HOME': '/Users/cltbld', 09:27:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:27:01 INFO - 'LOGNAME': 'cltbld', 09:27:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:27:01 INFO - 'MOZ_NO_REMOTE': '1', 09:27:01 INFO - 'NO_EM_RESTART': '1', 09:27:01 INFO - 'PAGER': '/bin/cat', 09:27:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:27:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:27:01 INFO - 'PWD': '/builds/slave/test', 09:27:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:27:01 INFO - 'SHELL': '/bin/bash', 09:27:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ypL2yH2MfI/Listeners', 09:27:01 INFO - 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/', 09:27:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:27:01 INFO - 'USER': 'cltbld', 09:27:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:27:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:27:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:27:01 INFO - 'XPC_FLAGS': '0x0', 09:27:01 INFO - 'XPC_SERVICE_NAME': '0', 09:27:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:27:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:27:01 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)) 09:27:01 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)) 09:27:01 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)) 09:27:01 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)) 09:27:01 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)) 09:27:01 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)) 09:27:01 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)) 09:27:01 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)) 09:27:01 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)) 09:27:01 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)) 09:27:01 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)) 09:27:01 INFO - Cleaning up... 09:27:01 INFO - Return code: 0 09:27:01 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:27:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:27:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:27:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:27:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:27:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:27:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:27:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10dc78b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dc7b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff211d6c9e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10da56d30>, '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 0x10d97ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10da4bbe8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Mre7AZMiB0/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ypL2yH2MfI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:27:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 09:27:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:27:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Mre7AZMiB0/Render', 09:27:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:27:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:27:01 INFO - 'HOME': '/Users/cltbld', 09:27:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:27:01 INFO - 'LOGNAME': 'cltbld', 09:27:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:27:01 INFO - 'MOZ_NO_REMOTE': '1', 09:27:01 INFO - 'NO_EM_RESTART': '1', 09:27:01 INFO - 'PAGER': '/bin/cat', 09:27:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:27:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:27:01 INFO - 'PWD': '/builds/slave/test', 09:27:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:27:01 INFO - 'SHELL': '/bin/bash', 09:27:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ypL2yH2MfI/Listeners', 09:27:01 INFO - 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/', 09:27:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:27:01 INFO - 'USER': 'cltbld', 09:27:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:27:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:27:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:27:01 INFO - 'XPC_FLAGS': '0x0', 09:27:01 INFO - 'XPC_SERVICE_NAME': '0', 09:27:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:27:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:27:01 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:27:01 INFO - Cleaning up... 09:27:01 INFO - Return code: 0 09:27:01 INFO - Running post-action listener: _resource_record_post_action 09:27:01 INFO - Running post-action listener: _start_resource_monitoring 09:27:01 INFO - Starting resource monitoring. 09:27:01 INFO - [mozharness: 2017-03-03 17:27:01.737281Z] Finished create-virtualenv step (success) 09:27:01 INFO - [mozharness: 2017-03-03 17:27:01.738316Z] Running install step. 09:27:01 INFO - Running pre-action listener: _resource_record_pre_action 09:27:01 INFO - Running main action method: install 09:27:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:27:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:27:01 INFO - Reading from file tmpfile_stdout 09:27:01 INFO - Detecting whether we're running mozinstall >=1.0... 09:27:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:27:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:27:02 INFO - Reading from file tmpfile_stdout 09:27:02 INFO - Output received: 09:27:02 INFO - Usage: mozinstall [options] installer 09:27:02 INFO - Options: 09:27:02 INFO - -h, --help show this help message and exit 09:27:02 INFO - -d DEST, --destination=DEST 09:27:02 INFO - Directory to install application into. [default: 09:27:02 INFO - "/builds/slave/test"] 09:27:02 INFO - --app=APP Application being installed. [default: firefox] 09:27:02 INFO - mkdir: /builds/slave/test/build/application 09:27:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 09:27:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 09:27:22 INFO - Reading from file tmpfile_stdout 09:27:22 INFO - Output received: 09:27:22 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 09:27:22 INFO - Running post-action listener: _resource_record_post_action 09:27:22 INFO - [mozharness: 2017-03-03 17:27:22.335559Z] Finished install step (success) 09:27:22 INFO - [mozharness: 2017-03-03 17:27:22.335717Z] Running run-tests step. 09:27:22 INFO - Running pre-action listener: _resource_record_pre_action 09:27:22 INFO - Running main action method: run_tests 09:27:22 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:27:22 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:27:22 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:27:22 INFO - 2017-03-03 09:27:22.349 screenresolution[1904:11844] starting screenresolution argv=screenresolution get 09:27:22 INFO - 2017-03-03 09:27:22.351 screenresolution[1904:11844] Display 0: 1600x1200x32@60 09:27:22 INFO - 2017-03-03 09:27:22.357 screenresolution[1905:11847] starting screenresolution argv=screenresolution list 09:27:22 INFO - Available Modes on Display 0 09:27:22 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:27:22 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:27:22 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:27:22 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:27:22 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:27:22 INFO - Intel Iris: 09:27:22 INFO - Chipset Model: Intel Iris 09:27:22 INFO - Type: GPU 09:27:22 INFO - Bus: Built-In 09:27:22 INFO - VRAM (Dynamic, Max): 1536 MB 09:27:22 INFO - Vendor: Intel (0x8086) 09:27:22 INFO - Device ID: 0x0a2e 09:27:22 INFO - Revision ID: 0x0009 09:27:22 INFO - Displays: 09:27:22 INFO - Display: 09:27:22 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:27:22 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:27:22 INFO - Display Serial Number: 1600x1200 60 09:27:22 INFO - Main Display: Yes 09:27:22 INFO - Mirror: Off 09:27:22 INFO - Online: Yes 09:27:22 INFO - Rotation: Supported 09:27:22 INFO - Return code: 0 09:27:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:27:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:27:22 INFO - Python 2.7.3 09:27:22 INFO - Return code: 0 09:27:22 INFO - grabbing minidump binary from tooltool 09:27: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:27:22 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/macosx64/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 0x10da56d30>, '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 0x10d97ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10da4bbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:27:22 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/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 09:27:22 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/macosx64/releng.manifest -o -c /builds/tooltool_cache 09:27:22 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/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 09:27:22 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:27:22 INFO - Return code: 0 09:27:22 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 09:27:22 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:27:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:27:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 09:27:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:27:22 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/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/M_o_oOgpTpC3YE29EHfi4Q/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0338', '--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 09:27:22 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/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/M_o_oOgpTpC3YE29EHfi4Q/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0338 --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 09:27:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Mre7AZMiB0/Render', 09:27:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:27:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:27:22 INFO - 'HOME': '/Users/cltbld', 09:27:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:27:22 INFO - 'LOGNAME': 'cltbld', 09:27:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:27:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 09:27:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:27:22 INFO - 'MOZ_NO_REMOTE': '1', 09:27:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:27:22 INFO - 'NO_EM_RESTART': '1', 09:27:22 INFO - 'PAGER': '/bin/cat', 09:27:22 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:27:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:27:22 INFO - 'PWD': '/builds/slave/test', 09:27:22 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:27:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:27:22 INFO - 'SHELL': '/bin/bash', 09:27:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ypL2yH2MfI/Listeners', 09:27:22 INFO - 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/', 09:27:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:27:22 INFO - 'USER': 'cltbld', 09:27:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:27:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:27:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:27:22 INFO - 'XPC_FLAGS': '0x0', 09:27:22 INFO - 'XPC_SERVICE_NAME': '0', 09:27:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:27:22 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/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/M_o_oOgpTpC3YE29EHfi4Q/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0338', '--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 09:27:22 INFO - mozversion application_buildid: 20170303084451 09:27:22 INFO - mozversion application_changeset: b946ece0c9d2bf34a925d13d08be2724f275dfd5 09:27:22 INFO - mozversion application_display_name: FirefoxDeveloperEdition 09:27:22 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:27:22 INFO - mozversion application_name: Firefox 09:27:22 INFO - mozversion application_remotingname: firefox-dev 09:27:22 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:27:22 INFO - mozversion application_vendor: Mozilla 09:27:22 INFO - mozversion application_version: 53.0a2 09:27:22 INFO - mozversion platform_buildid: 20170303084451 09:27:22 INFO - mozversion platform_changeset: b946ece0c9d2bf34a925d13d08be2724f275dfd5 09:27:22 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:27:22 INFO - mozversion platform_version: 53.0a2 09:27:22 INFO - using testdate: 1488562042 09:27:22 INFO - actual date: 1488562042 09:27:22 INFO - starting webserver on 'localhost:49675' 09:27:22 INFO - SUITE-START | Running 2 tests 09:27:22 INFO - TEST-START | dromaeo_css 09:27:22 INFO - operating with platform_type : mac_ 09:27:22 INFO - Initialising browser for dromaeo_css test... 09:27:22 INFO - TEST-INFO | started process 1915 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/tmp3HtP5H/profile http://localhost:49675/getInfo.html) 09:27:25 INFO - PROCESS | 1915 | __metrics Screen width/height:1600/1200 09:27:25 INFO - PROCESS | 1915 | colorDepth:24 09:27:25 INFO - PROCESS | 1915 | Browser inner width/height: 1024/689 09:27:25 INFO - PROCESS | 1915 | __metrics 09:27:25 INFO - PROCESS | 1915 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:27:25 INFO - PROCESS | 1915 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:27:26 INFO - TEST-INFO | 1915: exit 0 09:27:26 INFO - Browser initialized. 09:27:26 INFO - Running cycle 1/1 for dromaeo_css test... 09:27:26 INFO - TEST-INFO | started process 1917 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/tmp3HtP5H/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:27:38 INFO - PROCESS | 1917 | RSS: Main: 212905984 09:27:38 INFO - PROCESS | 1917 | 09:30:42 INFO - PROCESS | 1917 | Cycle 1(1): loaded http://localhost:49675/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49675/tests/dromaeo/cssquery-ext.html) 09:30:43 INFO - PROCESS | 1917 | RSS: Main: 350367744 09:30:43 INFO - PROCESS | 1917 | 09:32:27 INFO - PROCESS | 1917 | ************************* 09:32:27 INFO - PROCESS | 1917 | A coding exception was thrown and uncaught in a Task. 09:32:27 INFO - PROCESS | 1917 | 09:32:27 ERROR - PROCESS | 1917 | Full message: TypeError: NetworkError when attempting to fetch resource. 09:32:27 INFO - PROCESS | 1917 | Full stack: 09:32:27 INFO - PROCESS | 1917 | ************************* 09:33:46 INFO - PROCESS | 1917 | Cycle 1(1): loaded http://localhost:49675/tests/dromaeo/cssquery-ext.html (next: http://localhost:49675/tests/dromaeo/cssquery-jquery.html) 09:33:47 INFO - PROCESS | 1917 | RSS: Main: 352272384 09:33:47 INFO - PROCESS | 1917 | 09:36:49 INFO - PROCESS | 1917 | Cycle 1(1): loaded http://localhost:49675/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49675/tests/dromaeo/cssquery-mootools.html) 09:36:49 INFO - PROCESS | 1917 | RSS: Main: 317534208 09:36:49 INFO - PROCESS | 1917 | 09:39:52 INFO - PROCESS | 1917 | Cycle 1(1): loaded http://localhost:49675/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49675/tests/dromaeo/cssquery-prototype.html) 09:39:52 INFO - PROCESS | 1917 | RSS: Main: 333131776 09:39:52 INFO - PROCESS | 1917 | 09:42:56 INFO - PROCESS | 1917 | Cycle 1(1): loaded http://localhost:49675/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49675/tests/dromaeo/cssquery-yui.html) 09:42:56 INFO - PROCESS | 1917 | RSS: Main: 313528320 09:42:56 INFO - PROCESS | 1917 | 09:46:00 INFO - PROCESS | 1917 | Cycle 1(1): loaded http://localhost:49675/tests/dromaeo/cssquery-yui.html (next: http://localhost:49675/tests/dromaeo/cssquery-dojo.html) 09:46:00 INFO - PROCESS | 1917 | RSS: Main: 407760896 09:46:00 INFO - PROCESS | 1917 | 09:46:00 INFO - PROCESS | 1917 | __start_tp_report 09:46:00 INFO - PROCESS | 1917 | _x_x_mozilla_page_load 09:46:00 INFO - PROCESS | 1917 | _x_x_mozilla_page_load_details 09:46:00 INFO - PROCESS | 1917 | |i|pagename|runs| 09:46:00 INFO - PROCESS | 1917 | |0;dojo.html;3188.457962146435;3207.871685132595;3230.2247460609447;3277.655846136155;3283.770136090475;5539.695316757582;5623.156526521024;5625.296837895263;5627.465390787879;5632.971835140818;5516.14499752539;5612.7754889804355;5627.6060675752715;5627.746751396197;5653.236813030239;5100.056489549426;5104.515071068243;5145.511176438233;5190.7664155112925;5201.219817027439;5100.056489549426;5102.923456148161;5151.407588127376;5223.37319521656;5278.709670968095;5162.716050617233;5188.688678679291;5202.3497062867145;5207.765650545715;5208.114620514521;5202.635815492917;5203.4796520348045;5205.713685747321;5210.03614331348;5210.843674689728;5089.338386009832;5111.718855462948;5153.768080436389;5154.9484505155215;5159.535641792219;5646.40712725162;5649.689267090308;5656.981743286206;5659.924614323266;5664.971675141639;6079.483243924272;6124.601900876473;6135.171751813493;6178.567500274982;6195.473384762301;6261.561690681654;6266.467350275232;6269.937300627026;6272.15325930998;6278.215223097113;5696.943030569682;5713.085906254979;5727.914081288784;5730.398308177623;5755.395683453219;6093.2078829751845;6134.926457743815;6140.166841500592;6306.905396419057;6449.774257900951;6040.395960403925;6110.847228819315;6133.478654314344;6162.568620196633;6168.383161683885;6261.655608941461;6269.96865015672;6272.874542509216;6275.497960163176;6277.686115694197;6227.377262273736;6233.96883015582;6239.78160764371;6253.468455181361;6260.561760676709;6014.879702405928;6088.847778805565;6106.6336019838955;6118.3269840317525;6252.687365631791;4881.755912204376;4992.925106123411;5008.57427118699;5012.04771093491;5042.268871013755;4398.318260669601;4408.4930233023615;4419.535948725402;4430.712003719748;4449.1991441540185;5537.916931246034;5681.744321505542;5698.544116470673;5733.827985160452;5738.913916291259;5076.36545431821;6102.115193296947;6158.784442544489;6169.074638804215;6182.350853160443;5730.684812335361;5735.225744524436;5735.942640573624;5747.770089196385;5776.393478684761;5335.413104558495;5442.510174084351;5443.673379597237;5453.890922181614;5455.236266922634;6112.908306375497;6208.658523781235;6212.161358216583;6248.218972628421;6297.937020629918;6104.725287362168;6160.291566469734;6189.04069869171;6190.7523699051535;6229.50163986889;6259.2488901332135;6262.624242545279;6274.749010039547;6289.182406287154;6301.684915754102;6092.573519853568;6142.877142457037;6172.475339596184;6176.66028368426;6185.41238582334;5960.5231581474245;6057.606255593372;6120.2947619997085;6122.459144589048;6171.259448866164;6054.939450605438;6091.451769340603;6093.421124993119;6095.908561371494;6114.205153330038;5920.407959204045;6032.517398608188;6047.0929360596265;6059.606125601822;6062.969685151546;5671.43285671446;5692.1746346778655;5832.912506312324;5877.588568800143;5897.616654917417;6107.144999699956;6116.42707509198;6117.522930757332;6131.468419844996;6140.723667435065;4908;5944.346121926498;5958.523318134626;5969.104634304889;5969.224000879858 09:46:00 INFO - PROCESS | 1917 | |1;ext.html;445.41205608596647;470.85347179617656;516.7958656330752;521.5957632834553;532.4861508644158;30046.399072018547;39280.41079383811;40641.59358406415;40927.79536102319;41027.56403525877;42423.15153696924;42864.357034644425;42885.35671964915;42890.571094289124;43033.70898873031;9265.72202833916;9506.191973682211;9512.096350846694;9518.048195180496;9527.666531671393;8382.580870956459;8610;11250;11506.079513638932;11535.826962595567;9729.70810875675;11691.7077073073;11696.239744416629;11704.005159561448;11712.824307635392;9106.544672766402;11176.329420234812;11495.770084598345;11579.073674106052;11608.883911160907;8414.158584141598;8640.697575584887;8641.049484556694;8796.076411976714;11117.055050320732;39210.803945980086;41186.588134118574;41266.38100428496;41283.76148715543;41328.586714132776;3928.371460566296;3945.072907866649;3969.821358038895;3986.3422535281643;4061.6953728470485;29187.85406072956;30010.549841752392;30101.69898301011;30576.54135187974;31373.52939705906;3119.251379668886;3189.9681003189903;3222.7744057915957;3254.902352929416;3255.9023229303157;476663;476965;477009;477561;477868.61065694795;61022.38977610167;61813.690931545054;61837.690811546556;62096;62337.06494402588;65049;65142.67428662921;65218.67390663111;65325;65354.34645653578;16669.666606667797;16909.661806763797;16910.900791448516;16917.984920904786;16919.154042297836;11732.354720490284;12882.098253122378;12937.676558086123;12961.805572916413;12967.740645187232;14282.214723159605;14512.709745805025;16200.51398458048;16332.101734404721;16481;7022.754203602849;7049.330313620198;7100.502964792415;7143.6428178591905;7151.928480715231;879.1779685993616;879.8636211387245;887.4586502233632;917.1974522292994;917.8026724254318;30503;33037.83481082579;33759.649614015165;34117.65882341195;34493.82753086268;1071.410724101741;1073.9516721747384;1113.1651261553834;1117.6870476266658;1224.1981502116128;15027;15745.842541574666;15749.448769293249;15835.762463563056;16131.032138071754;654975;670341;670563;671890;672824;61772.38227617756;62154;62473.37526624766;62612;62876;1469.4269234998146;1479.5857159995219;1491.7613181891063;1517.9165145917082;1526.198745658516;26946.461070778867;29137.85431072831;30074.849625751733;30604.500134466132;30917.536236956013;41127;45919;55694.886102278535;55789;55821.162682558985;604253;606405;606824;607818;610554;35112.297754045285;43101.78449107734;43841;43966.340504893094;44206;36892.077698057765;43197;43485;45400.54599454095;48232.517674822804;35966.280674386886;37551.87344379673;38101.237975240896;38680.22639547137;38715.451381944404;38733.806330969295;38928.80535597304;39710.602893971845;40365.39451908282;41053;37606.435903462014;38025.239495210495;38079.809600952925;38116.618833811306;38544.843654690405;32877.83561082179;33767.15582110467;34409.82795086008;34585.827070864485;35043.82478087593;24484;25180.622290665287;25406.618900716134;25423.87288063622;25919.22242332733 09:46:00 INFO - PROCESS | 1917 | |2;jquery.html;385.50462655487684;390.09303369665525;394.1191437137994;397.83092185821016;418.41422009187136;13674.314771176982;16102.516924492269;20491.897540512313;21509.139634414623;21528;17331;20798.89600551999;21076.683849742265;21117.683234751454;21375.786242137576;5054.570361519275;5319.760610772524;5381.784728610851;5418;5422.132458806592;5287.312649355578;5338.306020217386;5339.759710813023;5342.412334643186;5693.629914055594;5891.734871930774;5938.376470470582;5941.88116237675;5955.404459554032;5966.79116230932;5264.894702105937;5363.383210930754;5596.86007849805;5927.940720592804;5939.198208241897;5138.948610513922;5179.456157103487;5245.973770131163;5256.579473642099;5261.447548007481;13434.059615826896;16998.575035624086;20010;20320.593588128155;26476.47047059048;2487.825852190347;2566.268613445159;2597.8051646126614;2622.6493355921525;2639.4061336199393;9992.45041522716;10063.89936100637;10596.470176491144;13304.935605151564;14278.785818212735;1804.548862784304;1817.3366721146685;1818.5362732503258;1835.8898466092078;1866.4214093631017;142945;144206;145756;147083.52916470804;149603;11719.06247500198;11779.352135632622;11943;11974.281543107441;12043;13819.170849749047;14532.128072315694;15766.605834854221;15795.21023948798;15812.60468488297;6079.148919151322;6134.263888333339;6234.407731265523;8447.281981031558;8825.205731484197;8489.872651910102;8573.614187361583;8735.039145693969;8795.076516965755;8868.733937981871;4607.0785842831565;4684.695494792828;4689.116193540948;4738.31294462308;4863.732494712754;1836.6785812482763;1891.4703882912806;1953.8534609904314;2016.3446879764135;2022.9190832366835;873.4366333714719;970.8640790289365;991.008991008991;1021.8824835143905;1031.2523420520213;22196.778032219794;22299.88500574965;22303.665445018338;22317.888410557844;22326.441838954157;891.5987805487426;1023.5251321762574;1045.927923878016;1050.2333296693305;1064.0955188090215;10272.229582781321;11347.489362978686;11463.78154358082;11511.136664750176;11639.76720465603;423838;431499.84250079177;752348;754946.2252688701;762924;104984;122943;151749.24125379522;154961.22519387555;160190;890.844102282111;926.9304802139867;940.4122423485185;940.9623615055458;941.5904081724472;18921.526961825515;20216.81541754149;20351.59296814085;20361.79638203599;20461.283855065598;47762.044759105316;60372.79254414975;61113.69443152756;62357.68821155865;63143;70330.64834675794;86735;88221;89943;90492.09507904836;8088.272055515032;8358.662613981734;8368.41421100517;8746.825063498567;8783.824323513621;9237.399569027992;12475.126741128033;12924;12966.740665186455;13813;11329.603463878724;11349.716257093638;11367.715807104889;11423.771524569296;11747.236429632047;11010.50452729645;11550.902664246883;11646.708832278922;11713.297202167898;11917.404129793302;11452;11549.769004619693;11658.358790266617;11991.980681642159;12115.939420302842;8340.915680961436;8483.194096560817;8532.104129066358;8652.307815374628;8681.565921703763;10700.30448020876;11463.426828658367;11584.362860042778;11609.6517104487;11615.6515304541 09:46:00 INFO - PROCESS | 1917 | |3;mootools.html;1439.7408466476036;1442.2860683961442;1458.3656109592325;1459.6715738958735;1466.4207637982997;8011.87982180267;8414.49513029217;8422.536760478171;8425.157484251571;8439.113893041227;7309.34215920567;7681.539107653531;7681.65432555535;7740.109887362955;8218.54797986112;1722.7415887616833;2133.893305334735;2236.194969810867;2322.442613772691;2324.848884822481;2352.223766157164;2357.54027964547;2357.6463530470396;2358.7287461941924;2362.444825466023;2279.8372829856726;2320.6751054852334;2325.139698311627;2328.871912044837;2333.3000099970027;1962.6761584338567;2260.9434764130865;2317.258477287252;2326.4183954011496;2326.6044772388736;2267.4331417145713;2279.601069812776;2339.3800642829665;2341.8594884306826;2353.505763789606;8374.958125209396;8415.410921235516;8427.073021967579;8438.493690378597;8470.74587762362;5054.646174767768;5226.947730522722;5228.79084836606;5232;5233.581313494949;3219.951700724491;3390.135515443546;3419.452887538007;3466.9133271668156;3468.115630514228;1110.1396417776207;1153.4694040741185;1154.9422528873606;1163.6916217202447;1196.9162158648899;10880.836787448194;10918.0173784359;10925.650985038175;10935.726606834813;10942.45287735618;3913.5890731473355;4303.182395344875;4658.1848176568965;4728.574428301401;4730.95269047312;9621.134097931219;9628.614855405705;9633.181179599813;9635.988221236668;9646.276529260334;5274.498922602346;5283.656562323436;5285.101532739443;5296.179092240709;5309.469053094737;4261.957380426218;4584.243599805995;4645.5354464553275;4730.787114579852;4827.468978412372;3570.696490798259;3763.284975854579;3764.3976963686227;3789.052736815796;3973.6225058619384;1139.7264656482384;1144.2447984330302;1152.2740673375888;1153.1870031627682;1162.4013632979022;768.4198430185174;856.0198572634299;895.1004240738147;901.7024381953939;908.681961313535;5502;5548.611597188158;5675.716214189274;5759.319189739882;5868.706564671749;982.4449186209912;1006.1548299428368;1010.757418219622;1017.2523195451338;1034.5551412892528;3798.9620103798607;3826.3877779555137;3836.462895194675;3935.193285376491;3943.940840887389;8153.79615509617;10217.591296348062;10224.233182511342;10236.078752912274;10254.948725256327;10053.899461005443;10152.644657437102;10157.644482443078;10172.694819155437;10182.134518565857;7476.514026588255;7794.571298578632;7907.920920790833;7919.326857217201;7924.445288829842;5441.591880608891;5446.564274857923;5491.972540137273;5610.074337734228;5686.061799802987;9061.818763624822;9124;9226.154769046083;9267.76830579241;9369.109934556207;9218.354715170142;9361.672341468016;9443.055694430503;9501.04989501072;9511.66709165176;6684.565503242274;6746.4265537429865;6849.1096157499205;6857.657117144223;6857.759978400732;7400.185979542353;7760.68957241704;7790.610469476617;7821.921780782347;7925.128235894163;6688.3646053624825;7109.253528379446;7152.785416437515;7154.892676609751;7349.007883935814;7259.818504537217;7311.159216689936;7313.963430183028;7319.4144468443465;7363.521371110861;6315.179026726496;6334.1765570475545;6346.746130154742;6411.903821442776;6433.453156481752;4225.429567008538;4792.161371759998;4860.902781944271;4977.203647416396;5025.572826309804;4911.361523001987;4950.108980383421;4961.330220420341;5094.643374963865;5199.506046925536 09:46:00 INFO - PROCESS | 1917 | |4;prototype.html;307.24111444731506;346.8231202086935;352.7477853334863;363.43667315660736;369.98335074921624;4233.195692818363;4528.615067719244;5300.89398212036;5317.601179911508;5352.304200453936;4519.457665080186;4658.417697787777;4910.75446227689;5040.974795126029;5255.816046438375;3954.9604503955024;4032.5967403259588;4111.588841115879;4112.074783173784;4121.567235440266;4081.530623978236;4102.425660407545;4105.671546276306;4131.35963925592;4143.834246630131;3724.9627503724887;3954.762714237155;4063.573324800898;4068.5117785865737;4091.9335735453556;3328.3676101540873;4065.4714887064492;4069.871961328747;4077.633013028827;4105.0763578194965;3198.440272952247;3593.7484376093685;3627.1657518770567;3630.2739452109686;3635.709143268532;5142.871428214287;5157.252198431244;5181.766820493087;5181.81863634771;5183.883018038713;4235.512916014667;4519.457665080178;4529;4556.248219043854;4594.150082234763;4939.259111133359;5544.500994910478;5567.772890843655;5600.179941519023;5601.635893666939;3374.5995411904278;3381;3620.149264922741;3732.9066773330615;3827.9617203827884;5213.2701421800975;5474.945250547484;5781.219535362714;5806.709664516758;5889.4993925515955;3488.598811136752;4077.836886524565;4126.587341265849;4170.374443833449;4229.703920725519;4039.909224509425;4231.978840105779;4266.189424009428;4286.592773686495;4318.956810431855;4403.757793321334;4609.842258053177;4675.438947326343;4744.478107408182;4809.663323567387;5599.412061733541;5604.8995414172905;5606.831795046073;5617.550595952314;5632.97183514088;1194.2177873492876;1368.5962641020922;1377.304461247084;1382.9101108428122;1383.754620841231;761.1285078584989;862.3101518784947;894.8233073508316;915.3866909170871;932.5989824375583;4398.4941731701265;4929.605631549467;4968.335607571432;4979;5017.14365684699;4407.942093897442;4632.521600943546;5447.700376479332;5476.616636835383;5488.56091512678;4239.872803815891;4731.668783185213;4919.909038658556;4957.033378491232;5015.699058056528;2813.817101888371;2829.3209629688727;2839.9432011360072;2849.28767808048;2857.4999375109273;4860.562549370574;5642.4075472075665;5666.583354161459;5670.943290567042;5723.713814309268;4899.603612970286;5078.003977653202;5187.4553171916405;5538.47384498472;5578.442155784389;4924.645722426361;5564.27664403633;5592.860178495489;5621.943780562142;5664.405237450009;4651.418572678415;4798.880027999328;5242.455036539691;5333.42660417529;5406.864828379322;4480.171168333869;4795.856124316276;4959.479254678206;5340.732963351895;5345.251664766858;5033.572146367454;5575.386707462257;5618.415528856608;5622.690752008515;5643.88712225745;3746.9508537609513;3855;3906.902327441837;3922.9215415692097;3948.9210215794947;4855.902881942271;5151.2273159026445;5327.280817089643;5404.135338345845;5517.393086760533;4403.766945255334;4526.592606665285;4944.876378090433;5009.248612708123;5227.738613069408;4306.104186957057;4426.44669416323;4639.791209395517;5070.543651071422;5177.92233116496;4610.815567377267;5081.898362032813;5115.820946266863;5121.129408000724;5136.512031357015;4498.797554110008;5364.865878352916;5365;5366.946330536644;5494.862628434321;5149.897002060013;5401.6218864679095;5403.756830942539;5424.294841670558;5437.265969094122 09:46:00 INFO - PROCESS | 1917 | |5;yui.html;692.3284414118305;703.1421665568012;714.3178264757157;781.9530828150312;831.9001719793624;14746.557603271893;15440.61398465039;15629.374825006986;15650.686986260267;15673.294701738421;14235.71528569428;14273.857261427383;14375.712485750279;14387.568372948803;14400.711985760305;661.5237029338869;681.2812482830611;684.4148253243455;817.1215942861418;829.854775414303;815.759350991456;840.6637345061963;846.851800934837;854.3933806997009;855.9871601925976;885.3315746611299;885.8361203177401;886.1847100667369;886.7339798060589;887.8268737596171;693.8473535822111;884.1688812516214;884.9026607073217;884.9469031858109;885.4333226734863;533.4265664410774;536.1421725239625;536.1957064403394;536.9140937449989;644.1818890009662;15046.699066018728;15105.924470377578;15428.460003899809;15479.380824766995;15504.689906201926;13683.589492315246;13686.863131368758;13703;13745.656358591015;13839.238841863693;12036.939815300955;12160;12190.329531875743;12353.135280530367;12720.173188742794;4231.449911511515;4405.669574781872;4413.205622987861;4418.160549495586;4523.095380923795;104714.47642761738;107198;109171.9999999992;111523.19337646368;115701.42149289284;10540.051102676749;10732.517036733365;10957.83563246552;11035.062019728413;11268.887311126784;22177.667334989987;22541.88729056377;22563.77436225617;22616.208432705105;22640.773592263868;7672.923270767221;7679.2704693054075;7689.477922826882;7700.191479894643;7773.961130194313;4038.091429428414;4121.423000779893;4132.586741325904;4230.407742915994;4299.914001719948;3362.1090411041096;3461.3769521486374;3463.480477928331;3470.6355832637714;3471.5660542432197;628.205320269859;634.5431289471574;644.5294934697697;651.5732195412013;653.5947712418331;509.9184130539096;624.4765053105276;637.2077812682736;656.5633853487473;657.6843115304681;9083.500407477652;9297.488638124833;9651.889318655134;9695.51522423876;9715.659951901649;617.9227596550431;619.5074915442234;631.5569965294134;643.2923783837741;669.4142625202948;3812.3709587917683;4019.2966230909474;4688.9531104689195;4701.4955214331085;4760.690555113906;109129;112203;112719;113321.43339283415;113591;68841.65579172072;85677.14322856817;86818;87264;88809;84888;85366;87979;88013.55993220121;88793.55603221942;9199.86200206984;9211.907880921104;9214.861777073214;9232.446053236827;9232.95383523078;54685.63285917884;54850.725746372605;55246.342609721774;55739.442605575045;55854.882902342535;62601.68699156475;69421.61156776735;73595.6320218417;73812;75984;14073.859261407255;14082.718345633235;14107.788383174055;14256.643583910485;14706.19115948633;14557.708845823236;14606.561803145923;14666.85333146655;15025.323860426088;15078.321475533847;13551.390187441391;13600.7788904781;13819.723605527632;13969.58091257264;13974.79037814454;13153.342332883127;14053.508127215498;14149.504767333094;14216.573502794932;14241.145531268157;13294.335283235607;13440.596782096552;13462.596122116352;13520.526781562598;13534.390952407362;11019.272779748862;11278.943605281922;11334.546618135182;11441.256318339281;11442.942785286354;11116.833247501132;11232.269902456314;11322.433878306216;11448.427578621202;11517.02105321057 09:46:00 INFO - PROCESS | 1917 | __end_tp_report 09:46:00 INFO - PROCESS | 1917 | __start_cc_report 09:46:00 INFO - PROCESS | 1917 | _x_x_mozilla_cycle_collect,1331 09:46:00 INFO - PROCESS | 1917 | __end_cc_report 09:46:00 INFO - PROCESS | 1917 | __startTimestamp1488563160508__endTimestamp 09:46:00 INFO - PROCESS | 1917 | 09:46:00 INFO - PROCESS | 1917 | ------- Summary: start ------- 09:46:00 INFO - PROCESS | 1917 | Number of tests: 6 09:46:00 INFO - PROCESS | 1917 | 09:46:00 INFO - PROCESS | 1917 | [#0] dojo.html Cycles:165 Average:5695.96 Median:5920.41 stddev:643.94 (10.9%) stddev-sans-first:615.14 09:46:00 INFO - PROCESS | 1917 | Values: 3188.5 3207.9 3230.2 3277.7 3283.8 5539.7 5623.2 5625.3 5627.5 5633.0 5516.1 5612.8 5627.6 5627.7 5653.2 5100.1 5104.5 5145.5 5190.8 5201.2 5100.1 5102.9 5151.4 5223.4 5278.7 5162.7 5188.7 5202.3 5207.8 5208.1 5202.6 5203.5 5205.7 5210.0 5210.8 5089.3 5111.7 5153.8 5154.9 5159.5 5646.4 5649.7 5657.0 5659.9 5665.0 6079.5 6124.6 6135.2 6178.6 6195.5 6261.6 6266.5 6269.9 6272.2 6278.2 5696.9 5713.1 5727.9 5730.4 5755.4 6093.2 6134.9 6140.2 6306.9 6449.8 6040.4 6110.8 6133.5 6162.6 6168.4 6261.7 6270.0 6272.9 6275.5 6277.7 6227.4 6234.0 6239.8 6253.5 6260.6 6014.9 6088.8 6106.6 6118.3 6252.7 4881.8 4992.9 5008.6 5012.0 5042.3 4398.3 4408.5 4419.5 4430.7 4449.2 5537.9 5681.7 5698.5 5733.8 5738.9 5076.4 6102.1 6158.8 6169.1 6182.4 5730.7 5735.2 5735.9 5747.8 5776.4 5335.4 5442.5 5443.7 5453.9 5455.2 6112.9 6208.7 6212.2 6248.2 6297.9 6104.7 6160.3 6189.0 6190.8 6229.5 6259.2 6262.6 6274.7 6289.2 6301.7 6092.6 6142.9 6172.5 6176.7 6185.4 5960.5 6057.6 6120.3 6122.5 6171.3 6054.9 6091.5 6093.4 6095.9 6114.2 5920.4 6032.5 6047.1 6059.6 6063.0 5671.4 5692.2 5832.9 5877.6 5897.6 6107.1 6116.4 6117.5 6131.5 6140.7 4908.0 5944.3 5958.5 5969.1 5969.2 09:46:00 INFO - PROCESS | 1917 | 09:46:00 INFO - PROCESS | 1917 | [#1] ext.html Cycles:180 Average:72183.83 Median:3957.45 stddev:157602.28 (3982.4%) stddev-sans-first:157952.36 09:46:00 INFO - PROCESS | 1917 | Values: 445.4 470.9 516.8 521.6 532.5 30046.4 39280.4 40641.6 40927.8 41027.6 42423.2 42864.4 42885.4 42890.6 43033.7 9265.7 9506.2 9512.1 9518.0 9527.7 8382.6 8610.0 11250.0 11506.1 11535.8 9729.7 11691.7 11696.2 11704.0 11712.8 9106.5 11176.3 11495.8 11579.1 11608.9 8414.2 8640.7 8641.0 8796.1 11117.1 39210.8 41186.6 41266.4 41283.8 41328.6 3928.4 3945.1 3969.8 3986.3 4061.7 29187.9 30010.5 30101.7 30576.5 31373.5 3119.3 3190.0 3222.8 3254.9 3255.9 476663.0 476965.0 477009.0 477561.0 477868.6 61022.4 61813.7 61837.7 62096.0 62337.1 65049.0 65142.7 65218.7 65325.0 65354.3 16669.7 16909.7 16910.9 16918.0 16919.2 11732.4 12882.1 12937.7 12961.8 12967.7 14282.2 14512.7 16200.5 16332.1 16481.0 7022.8 7049.3 7100.5 7143.6 7151.9 879.2 879.9 887.5 917.2 917.8 30503.0 33037.8 33759.6 34117.7 34493.8 1071.4 1074.0 1113.2 1117.7 1224.2 15027.0 15745.8 15749.4 15835.8 16131.0 654975.0 670341.0 670563.0 671890.0 672824.0 61772.4 62154.0 62473.4 62612.0 62876.0 1469.4 1479.6 1491.8 1517.9 1526.2 26946.5 29137.9 30074.8 30604.5 30917.5 41127.0 45919.0 55694.9 55789.0 55821.2 604253.0 606405.0 606824.0 607818.0 610554.0 35112.3 43101.8 43841.0 43966.3 44206.0 36892.1 43197.0 43485.0 45400.5 48232.5 35966.3 37551.9 38101.2 38680.2 38715.5 38733.8 38928.8 39710.6 40365.4 41053.0 37606.4 38025.2 38079.8 38116.6 38544.8 32877.8 33767.2 34409.8 34585.8 35043.8 24484.0 25180.6 25406.6 25423.9 25919.2 09:46:00 INFO - PROCESS | 1917 | 09:46:00 INFO - PROCESS | 1917 | [#2] jquery.html Cycles:180 Average:37166.43 Median:22310.78 stddev:108671.42 (487.1%) stddev-sans-first:108941.18 09:46:00 INFO - PROCESS | 1917 | Values: 385.5 390.1 394.1 397.8 418.4 13674.3 16102.5 20491.9 21509.1 21528.0 17331.0 20798.9 21076.7 21117.7 21375.8 5054.6 5319.8 5381.8 5418.0 5422.1 5287.3 5338.3 5339.8 5342.4 5693.6 5891.7 5938.4 5941.9 5955.4 5966.8 5264.9 5363.4 5596.9 5927.9 5939.2 5138.9 5179.5 5246.0 5256.6 5261.4 13434.1 16998.6 20010.0 20320.6 26476.5 2487.8 2566.3 2597.8 2622.6 2639.4 9992.5 10063.9 10596.5 13304.9 14278.8 1804.5 1817.3 1818.5 1835.9 1866.4 142945.0 144206.0 145756.0 147083.5 149603.0 11719.1 11779.4 11943.0 11974.3 12043.0 13819.2 14532.1 15766.6 15795.2 15812.6 6079.1 6134.3 6234.4 8447.3 8825.2 8489.9 8573.6 8735.0 8795.1 8868.7 4607.1 4684.7 4689.1 4738.3 4863.7 1836.7 1891.5 1953.9 2016.3 2022.9 873.4 970.9 991.0 1021.9 1031.3 22196.8 22299.9 22303.7 22317.9 22326.4 891.6 1023.5 1045.9 1050.2 1064.1 10272.2 11347.5 11463.8 11511.1 11639.8 423838.0 431499.8 752348.0 754946.2 762924.0 104984.0 122943.0 151749.2 154961.2 160190.0 890.8 926.9 940.4 941.0 941.6 18921.5 20216.8 20351.6 20361.8 20461.3 47762.0 60372.8 61113.7 62357.7 63143.0 70330.6 86735.0 88221.0 89943.0 90492.1 8088.3 8358.7 8368.4 8746.8 8783.8 9237.4 12475.1 12924.0 12966.7 13813.0 11329.6 11349.7 11367.7 11423.8 11747.2 11010.5 11550.9 11646.7 11713.3 11917.4 11452.0 11549.8 11658.4 11992.0 12115.9 8340.9 8483.2 8532.1 8652.3 8681.6 10700.3 11463.4 11584.4 11609.7 11615.7 09:46:00 INFO - PROCESS | 1917 | 09:46:00 INFO - PROCESS | 1917 | [#3] mootools.html Cycles:180 Average:5426.58 Median:5040.11 stddev:2978.86 (59.1%) stddev-sans-first:2972.15 09:46:00 INFO - PROCESS | 1917 | Values: 1439.7 1442.3 1458.4 1459.7 1466.4 8011.9 8414.5 8422.5 8425.2 8439.1 7309.3 7681.5 7681.7 7740.1 8218.5 1722.7 2133.9 2236.2 2322.4 2324.8 2352.2 2357.5 2357.6 2358.7 2362.4 2279.8 2320.7 2325.1 2328.9 2333.3 1962.7 2260.9 2317.3 2326.4 2326.6 2267.4 2279.6 2339.4 2341.9 2353.5 8375.0 8415.4 8427.1 8438.5 8470.7 5054.6 5226.9 5228.8 5232.0 5233.6 3220.0 3390.1 3419.5 3466.9 3468.1 1110.1 1153.5 1154.9 1163.7 1196.9 10880.8 10918.0 10925.7 10935.7 10942.5 3913.6 4303.2 4658.2 4728.6 4731.0 9621.1 9628.6 9633.2 9636.0 9646.3 5274.5 5283.7 5285.1 5296.2 5309.5 4262.0 4584.2 4645.5 4730.8 4827.5 3570.7 3763.3 3764.4 3789.1 3973.6 1139.7 1144.2 1152.3 1153.2 1162.4 768.4 856.0 895.1 901.7 908.7 5502.0 5548.6 5675.7 5759.3 5868.7 982.4 1006.2 1010.8 1017.3 1034.6 3799.0 3826.4 3836.5 3935.2 3943.9 8153.8 10217.6 10224.2 10236.1 10254.9 10053.9 10152.6 10157.6 10172.7 10182.1 7476.5 7794.6 7907.9 7919.3 7924.4 5441.6 5446.6 5492.0 5610.1 5686.1 9061.8 9124.0 9226.2 9267.8 9369.1 9218.4 9361.7 9443.1 9501.0 9511.7 6684.6 6746.4 6849.1 6857.7 6857.8 7400.2 7760.7 7790.6 7821.9 7925.1 6688.4 7109.3 7152.8 7154.9 7349.0 7259.8 7311.2 7314.0 7319.4 7363.5 6315.2 6334.2 6346.7 6411.9 6433.5 4225.4 4792.2 4860.9 4977.2 5025.6 4911.4 4950.1 4961.3 5094.6 5199.5 09:46:00 INFO - PROCESS | 1917 | 09:46:00 INFO - PROCESS | 1917 | [#4] prototype.html Cycles:180 Average:4402.50 Median:4858.23 stddev:1287.88 (26.5%) stddev-sans-first:1254.28 09:46:00 INFO - PROCESS | 1917 | Values: 307.2 346.8 352.7 363.4 370.0 4233.2 4528.6 5300.9 5317.6 5352.3 4519.5 4658.4 4910.8 5041.0 5255.8 3955.0 4032.6 4111.6 4112.1 4121.6 4081.5 4102.4 4105.7 4131.4 4143.8 3725.0 3954.8 4063.6 4068.5 4091.9 3328.4 4065.5 4069.9 4077.6 4105.1 3198.4 3593.7 3627.2 3630.3 3635.7 5142.9 5157.3 5181.8 5181.8 5183.9 4235.5 4519.5 4529.0 4556.2 4594.2 4939.3 5544.5 5567.8 5600.2 5601.6 3374.6 3381.0 3620.1 3732.9 3828.0 5213.3 5474.9 5781.2 5806.7 5889.5 3488.6 4077.8 4126.6 4170.4 4229.7 4039.9 4232.0 4266.2 4286.6 4319.0 4403.8 4609.8 4675.4 4744.5 4809.7 5599.4 5604.9 5606.8 5617.6 5633.0 1194.2 1368.6 1377.3 1382.9 1383.8 761.1 862.3 894.8 915.4 932.6 4398.5 4929.6 4968.3 4979.0 5017.1 4407.9 4632.5 5447.7 5476.6 5488.6 4239.9 4731.7 4919.9 4957.0 5015.7 2813.8 2829.3 2839.9 2849.3 2857.5 4860.6 5642.4 5666.6 5670.9 5723.7 4899.6 5078.0 5187.5 5538.5 5578.4 4924.6 5564.3 5592.9 5621.9 5664.4 4651.4 4798.9 5242.5 5333.4 5406.9 4480.2 4795.9 4959.5 5340.7 5345.3 5033.6 5575.4 5618.4 5622.7 5643.9 3747.0 3855.0 3906.9 3922.9 3948.9 4855.9 5151.2 5327.3 5404.1 5517.4 4403.8 4526.6 4944.9 5009.2 5227.7 4306.1 4426.4 4639.8 5070.5 5177.9 4610.8 5081.9 5115.8 5121.1 5136.5 4498.8 5364.9 5365.0 5366.9 5494.9 5149.9 5401.6 5403.8 5424.3 5437.3 09:46:00 INFO - PROCESS | 1917 | 09:46:00 INFO - PROCESS | 1917 | [#5] yui.html Cycles:180 Average:21261.15 Median:4230.93 stddev:30943.56 (731.4%) stddev-sans-first:30991.82 09:46:00 INFO - PROCESS | 1917 | Values: 692.3 703.1 714.3 782.0 831.9 14746.6 15440.6 15629.4 15650.7 15673.3 14235.7 14273.9 14375.7 14387.6 14400.7 661.5 681.3 684.4 817.1 829.9 815.8 840.7 846.9 854.4 856.0 885.3 885.8 886.2 886.7 887.8 693.8 884.2 884.9 884.9 885.4 533.4 536.1 536.2 536.9 644.2 15046.7 15105.9 15428.5 15479.4 15504.7 13683.6 13686.9 13703.0 13745.7 13839.2 12036.9 12160.0 12190.3 12353.1 12720.2 4231.4 4405.7 4413.2 4418.2 4523.1 104714.5 107198.0 109172.0 111523.2 115701.4 10540.1 10732.5 10957.8 11035.1 11268.9 22177.7 22541.9 22563.8 22616.2 22640.8 7672.9 7679.3 7689.5 7700.2 7774.0 4038.1 4121.4 4132.6 4230.4 4299.9 3362.1 3461.4 3463.5 3470.6 3471.6 628.2 634.5 644.5 651.6 653.6 509.9 624.5 637.2 656.6 657.7 9083.5 9297.5 9651.9 9695.5 9715.7 617.9 619.5 631.6 643.3 669.4 3812.4 4019.3 4689.0 4701.5 4760.7 109129.0 112203.0 112719.0 113321.4 113591.0 68841.7 85677.1 86818.0 87264.0 88809.0 84888.0 85366.0 87979.0 88013.6 88793.6 9199.9 9211.9 9214.9 9232.4 9233.0 54685.6 54850.7 55246.3 55739.4 55854.9 62601.7 69421.6 73595.6 73812.0 75984.0 14073.9 14082.7 14107.8 14256.6 14706.2 14557.7 14606.6 14666.9 15025.3 15078.3 13551.4 13600.8 13819.7 13969.6 13974.8 13153.3 14053.5 14149.5 14216.6 14241.1 13294.3 13440.6 13462.6 13520.5 13534.4 11019.3 11278.9 11334.5 11441.3 11442.9 11116.8 11232.3 11322.4 11448.4 11517.0 09:46:00 INFO - PROCESS | 1917 | -------- Summary: end -------- 09:46:00 INFO - PROCESS | 1917 | 09:46:01 INFO - TEST-INFO | 1917: exit 0 09:46:01 INFO - TEST-OK | dromaeo_css | took 1118278ms 09:46:01 INFO - TEST-START | kraken 09:46:01 INFO - operating with platform_type : mac_ 09:46:01 INFO - Initialising browser for kraken test... 09:46:01 INFO - TEST-INFO | started process 1922 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/tmpqBKqG9/profile http://localhost:49675/getInfo.html) 09:46:03 INFO - PROCESS | 1922 | __metrics Screen width/height:1600/1200 09:46:03 INFO - PROCESS | 1922 | colorDepth:24 09:46:03 INFO - PROCESS | 1922 | Browser inner width/height: 1024/689 09:46:03 INFO - PROCESS | 1922 | __metrics 09:46:03 INFO - PROCESS | 1922 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:46:03 INFO - PROCESS | 1922 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:46:04 INFO - TEST-INFO | 1922: exit 0 09:46:04 INFO - Browser initialized. 09:46:04 INFO - Running cycle 1/1 for kraken test... 09:46:04 INFO - TEST-INFO | started process 1923 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/tmpqBKqG9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:46:16 INFO - PROCESS | 1923 | RSS: Main: 213078016 09:46:16 INFO - PROCESS | 1923 | 09:46:18 INFO - PROCESS | 1923 | Cycle 1(1): loaded http://localhost:49675/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49675/tests/kraken/driver.html?testName=audio-beat-detection) 09:46:19 INFO - PROCESS | 1923 | RSS: Main: 266334208 09:46:19 INFO - PROCESS | 1923 | 09:46:22 INFO - PROCESS | 1923 | Cycle 1(1): loaded http://localhost:49675/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49675/tests/kraken/driver.html?testName=audio-dft) 09:46:23 INFO - PROCESS | 1923 | RSS: Main: 277004288 09:46:23 INFO - PROCESS | 1923 | 09:46:26 INFO - PROCESS | 1923 | Cycle 1(1): loaded http://localhost:49675/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49675/tests/kraken/driver.html?testName=audio-fft) 09:46:27 INFO - PROCESS | 1923 | RSS: Main: 372531200 09:46:27 INFO - PROCESS | 1923 | 09:46:28 INFO - PROCESS | 1923 | Cycle 1(1): loaded http://localhost:49675/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49675/tests/kraken/driver.html?testName=audio-oscillator) 09:46:29 INFO - PROCESS | 1923 | RSS: Main: 275857408 09:46:29 INFO - PROCESS | 1923 | 09:46:31 INFO - PROCESS | 1923 | Cycle 1(1): loaded http://localhost:49675/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49675/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:46:32 INFO - PROCESS | 1923 | RSS: Main: 278339584 09:46:32 INFO - PROCESS | 1923 | 09:46:35 INFO - PROCESS | 1923 | Cycle 1(1): loaded http://localhost:49675/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49675/tests/kraken/driver.html?testName=imaging-darkroom) 09:46:35 INFO - PROCESS | 1923 | RSS: Main: 318095360 09:46:35 INFO - PROCESS | 1923 | 09:46:38 INFO - PROCESS | 1923 | Cycle 1(1): loaded http://localhost:49675/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49675/tests/kraken/driver.html?testName=imaging-desaturate) 09:46:39 INFO - PROCESS | 1923 | RSS: Main: 319954944 09:46:39 INFO - PROCESS | 1923 | 09:46:42 INFO - PROCESS | 1923 | Cycle 1(1): loaded http://localhost:49675/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49675/tests/kraken/driver.html?testName=json-parse-financial) 09:46:42 INFO - PROCESS | 1923 | RSS: Main: 317792256 09:46:42 INFO - PROCESS | 1923 | 09:46:44 INFO - PROCESS | 1923 | Cycle 1(1): loaded http://localhost:49675/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49675/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:46:44 INFO - PROCESS | 1923 | RSS: Main: 294776832 09:46:44 INFO - PROCESS | 1923 | 09:46:46 INFO - PROCESS | 1923 | Cycle 1(1): loaded http://localhost:49675/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49675/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:46:47 INFO - PROCESS | 1923 | RSS: Main: 298815488 09:46:47 INFO - PROCESS | 1923 | 09:46:49 INFO - PROCESS | 1923 | Cycle 1(1): loaded http://localhost:49675/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49675/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:46:50 INFO - PROCESS | 1923 | RSS: Main: 301412352 09:46:50 INFO - PROCESS | 1923 | 09:46:53 INFO - PROCESS | 1923 | Cycle 1(1): loaded http://localhost:49675/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49675/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:46:54 INFO - PROCESS | 1923 | RSS: Main: 316653568 09:46:54 INFO - PROCESS | 1923 | 09:46:56 INFO - PROCESS | 1923 | Cycle 1(1): loaded http://localhost:49675/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49675/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:46:57 INFO - PROCESS | 1923 | RSS: Main: 310571008 09:46:57 INFO - PROCESS | 1923 | 09:46:59 INFO - PROCESS | 1923 | Cycle 1(1): loaded http://localhost:49675/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49675/tests/kraken/driver.html?testName=ai-astar) 09:46:59 INFO - PROCESS | 1923 | RSS: Main: 354250752 09:46:59 INFO - PROCESS | 1923 | 09:46:59 INFO - PROCESS | 1923 | __start_tp_report 09:46:59 INFO - PROCESS | 1923 | _x_x_mozilla_page_load 09:46:59 INFO - PROCESS | 1923 | _x_x_mozilla_page_load_details 09:46:59 INFO - PROCESS | 1923 | |i|pagename|runs| 09:46:59 INFO - PROCESS | 1923 | |0;ai-astar;116;114;114;113;113;114;113;112;115;112 09:46:59 INFO - PROCESS | 1923 | |1;audio-beat-detection;147;118;140;150;109;120;137;138;149;109 09:46:59 INFO - PROCESS | 1923 | |2;audio-dft;184;183;184;182;182;184;183;203;263;199 09:46:59 INFO - PROCESS | 1923 | |3;audio-fft;80;58;58;90;58;59;59;58;74;58 09:46:59 INFO - PROCESS | 1923 | |4;audio-oscillator;84;70;85;69;67;68;82;67;68;82 09:46:59 INFO - PROCESS | 1923 | |5;imaging-gaussian-blur;90;89;73;114;91;87;91;121;74;121 09:46:59 INFO - PROCESS | 1923 | |6;imaging-darkroom;96;95;96;95;102;96;96;96;96;95 09:46:59 INFO - PROCESS | 1923 | |7;imaging-desaturate;93;85;87;88;85;86;85;88;88;87 09:46:59 INFO - PROCESS | 1923 | |8;json-parse-financial;58;54;54;54;55;59;57;56;55;57 09:46:59 INFO - PROCESS | 1923 | |9;json-stringify-tinderbox;67;73;80;75;74;70;69;86;105;105 09:46:59 INFO - PROCESS | 1923 | |10;stanford-crypto-aes;81;87;81;84;81;82;83;81;100;102 09:46:59 INFO - PROCESS | 1923 | |11;stanford-crypto-ccm;138;136;137;165;143;146;142;134;173;161 09:46:59 INFO - PROCESS | 1923 | |12;stanford-crypto-pbkdf2;169;168;168;168;170;169;171;167;166;165 09:46:59 INFO - PROCESS | 1923 | |13;stanford-crypto-sha256-iterative;66;67;68;56;76;74;81;84;83;71 09:46:59 INFO - PROCESS | 1923 | __end_tp_report 09:46:59 INFO - PROCESS | 1923 | __start_cc_report 09:46:59 INFO - PROCESS | 1923 | _x_x_mozilla_cycle_collect,2153 09:46:59 INFO - PROCESS | 1923 | __end_cc_report 09:46:59 INFO - PROCESS | 1923 | __startTimestamp1488563219641__endTimestamp 09:46:59 INFO - PROCESS | 1923 | 09:46:59 INFO - PROCESS | 1923 | ------- Summary: start ------- 09:46:59 INFO - PROCESS | 1923 | Number of tests: 14 09:46:59 INFO - PROCESS | 1923 | 09:46:59 INFO - PROCESS | 1923 | [#0] ai-astar Cycles:10 Average:113.60 Median:114.00 stddev:1.26 (1.1%) stddev-sans-first:1.00 09:46:59 INFO - PROCESS | 1923 | Values: 116.0 114.0 114.0 113.0 113.0 114.0 113.0 112.0 115.0 112.0 09:46:59 INFO - PROCESS | 1923 | 09:46:59 INFO - PROCESS | 1923 | [#1] audio-beat-detection Cycles:10 Average:131.70 Median:139.00 stddev:16.19 (11.7%) stddev-sans-first:16.20 09:46:59 INFO - PROCESS | 1923 | Values: 147.0 118.0 140.0 150.0 109.0 120.0 137.0 138.0 149.0 109.0 09:46:59 INFO - PROCESS | 1923 | 09:46:59 INFO - PROCESS | 1923 | [#2] audio-dft Cycles:10 Average:194.70 Median:184.00 stddev:25.15 (13.7%) stddev-sans-first:26.37 09:46:59 INFO - PROCESS | 1923 | Values: 184.0 183.0 184.0 182.0 182.0 184.0 183.0 203.0 263.0 199.0 09:46:59 INFO - PROCESS | 1923 | 09:46:59 INFO - PROCESS | 1923 | [#3] audio-fft Cycles:10 Average:65.20 Median:59.00 stddev:11.77 (20.0%) stddev-sans-first:11.20 09:46:59 INFO - PROCESS | 1923 | Values: 80.0 58.0 58.0 90.0 58.0 59.0 59.0 58.0 74.0 58.0 09:46:59 INFO - PROCESS | 1923 | 09:46:59 INFO - PROCESS | 1923 | [#4] audio-oscillator Cycles:10 Average:74.20 Median:76.00 stddev:7.89 (10.4%) stddev-sans-first:7.52 09:46:59 INFO - PROCESS | 1923 | Values: 84.0 70.0 85.0 69.0 67.0 68.0 82.0 67.0 68.0 82.0 09:46:59 INFO - PROCESS | 1923 | 09:46:59 INFO - PROCESS | 1923 | [#5] imaging-gaussian-blur Cycles:10 Average:95.10 Median:88.00 stddev:17.62 (20.0%) stddev-sans-first:18.59 09:46:59 INFO - PROCESS | 1923 | Values: 90.0 89.0 73.0 114.0 91.0 87.0 91.0 121.0 74.0 121.0 09:46:59 INFO - PROCESS | 1923 | 09:46:59 INFO - PROCESS | 1923 | [#6] imaging-darkroom Cycles:10 Average:96.30 Median:96.00 stddev:2.06 (2.1%) stddev-sans-first:2.18 09:46:59 INFO - PROCESS | 1923 | Values: 96.0 95.0 96.0 95.0 102.0 96.0 96.0 96.0 96.0 95.0 09:46:59 INFO - PROCESS | 1923 | 09:46:59 INFO - PROCESS | 1923 | [#7] imaging-desaturate Cycles:10 Average:87.20 Median:87.50 stddev:2.39 (2.7%) stddev-sans-first:1.33 09:46:59 INFO - PROCESS | 1923 | Values: 93.0 85.0 87.0 88.0 85.0 86.0 85.0 88.0 88.0 87.0 09:46:59 INFO - PROCESS | 1923 | 09:46:59 INFO - PROCESS | 1923 | [#8] json-parse-financial Cycles:10 Average:55.90 Median:56.50 stddev:1.79 (3.2%) stddev-sans-first:1.73 09:46:59 INFO - PROCESS | 1923 | Values: 58.0 54.0 54.0 54.0 55.0 59.0 57.0 56.0 55.0 57.0 09:46:59 INFO - PROCESS | 1923 | 09:46:59 INFO - PROCESS | 1923 | [#9] json-stringify-tinderbox Cycles:10 Average:80.40 Median:73.50 stddev:14.08 (19.2%) stddev-sans-first:14.08 09:46:59 INFO - PROCESS | 1923 | Values: 67.0 73.0 80.0 75.0 74.0 70.0 69.0 86.0 105.0 105.0 09:46:59 INFO - PROCESS | 1923 | 09:46:59 INFO - PROCESS | 1923 | [#10] stanford-crypto-aes Cycles:10 Average:86.20 Median:81.50 stddev:8.04 (9.9%) stddev-sans-first:8.30 09:46:59 INFO - PROCESS | 1923 | Values: 81.0 87.0 81.0 84.0 81.0 82.0 83.0 81.0 100.0 102.0 09:46:59 INFO - PROCESS | 1923 | 09:46:59 INFO - PROCESS | 1923 | [#11] stanford-crypto-ccm Cycles:10 Average:147.50 Median:144.50 stddev:13.77 (9.5%) stddev-sans-first:14.17 09:46:59 INFO - PROCESS | 1923 | Values: 138.0 136.0 137.0 165.0 143.0 146.0 142.0 134.0 173.0 161.0 09:46:59 INFO - PROCESS | 1923 | 09:46:59 INFO - PROCESS | 1923 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.10 Median:168.50 stddev:1.79 (1.1%) stddev-sans-first:1.87 09:46:59 INFO - PROCESS | 1923 | Values: 169.0 168.0 168.0 168.0 170.0 169.0 171.0 167.0 166.0 165.0 09:46:59 INFO - PROCESS | 1923 | 09:46:59 INFO - PROCESS | 1923 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.60 Median:75.00 stddev:8.80 (11.7%) stddev-sans-first:9.00 09:46:59 INFO - PROCESS | 1923 | Values: 66.0 67.0 68.0 56.0 76.0 74.0 81.0 84.0 83.0 71.0 09:46:59 INFO - PROCESS | 1923 | -------- Summary: end -------- 09:46:59 INFO - PROCESS | 1923 | 09:47:00 INFO - TEST-INFO | 1923: exit 0 09:47:00 INFO - TEST-OK | kraken | took 59359ms 09:47:00 INFO - SUITE-END | took 1177s 09:47:00 INFO - Completed test suite (00:19:37) 09:47:00 INFO - javascript benchmark 09:47:00 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3188.457962146435, 3207.871685132595, 3230.2247460609447, 3277.655846136155, 3283.770136090475, 5539.695316757582, 5623.156526521024, 5625.296837895263, 5627.465390787879, 5632.971835140818, 5516.14499752539, 5612.7754889804355, 5627.6060675752715, 5627.746751396197, 5653.236813030239, 5100.056489549426, 5104.515071068243, 5145.511176438233, 5190.7664155112925, 5201.219817027439, 5100.056489549426, 5102.923456148161, 5151.407588127376, 5223.37319521656, 5278.709670968095, 5162.716050617233, 5188.688678679291, 5202.3497062867145, 5207.765650545715, 5208.114620514521, 5202.635815492917, 5203.4796520348045, 5205.713685747321, 5210.03614331348, 5210.843674689728, 5089.338386009832, 5111.718855462948, 5153.768080436389, 5154.9484505155215, 5159.535641792219, 5646.40712725162, 5649.689267090308, 5656.981743286206, 5659.924614323266, 5664.971675141639, 6079.483243924272, 6124.601900876473, 6135.171751813493, 6178.567500274982, 6195.473384762301, 6261.561690681654, 6266.467350275232, 6269.937300627026, 6272.15325930998, 6278.215223097113, 5696.943030569682, 5713.085906254979, 5727.914081288784, 5730.398308177623, 5755.395683453219, 6093.2078829751845, 6134.926457743815, 6140.166841500592, 6306.905396419057, 6449.774257900951, 6040.395960403925, 6110.847228819315, 6133.478654314344, 6162.568620196633, 6168.383161683885, 6261.655608941461, 6269.96865015672, 6272.874542509216, 6275.497960163176, 6277.686115694197, 6227.377262273736, 6233.96883015582, 6239.78160764371, 6253.468455181361, 6260.561760676709, 6014.879702405928, 6088.847778805565, 6106.6336019838955, 6118.3269840317525, 6252.687365631791, 4881.755912204376, 4992.925106123411, 5008.57427118699, 5012.04771093491, 5042.268871013755, 4398.318260669601, 4408.4930233023615, 4419.535948725402, 4430.712003719748, 4449.1991441540185, 5537.916931246034, 5681.744321505542, 5698.544116470673, 5733.827985160452, 5738.913916291259, 5076.36545431821, 6102.115193296947, 6158.784442544489, 6169.074638804215, 6182.350853160443, 5730.684812335361, 5735.225744524436, 5735.942640573624, 5747.770089196385, 5776.393478684761, 5335.413104558495, 5442.510174084351, 5443.673379597237, 5453.890922181614, 5455.236266922634, 6112.908306375497, 6208.658523781235, 6212.161358216583, 6248.218972628421, 6297.937020629918, 6104.725287362168, 6160.291566469734, 6189.04069869171, 6190.7523699051535, 6229.50163986889, 6259.2488901332135, 6262.624242545279, 6274.749010039547, 6289.182406287154, 6301.684915754102, 6092.573519853568, 6142.877142457037, 6172.475339596184, 6176.66028368426, 6185.41238582334, 5960.5231581474245, 6057.606255593372, 6120.2947619997085, 6122.459144589048, 6171.259448866164, 6054.939450605438, 6091.451769340603, 6093.421124993119, 6095.908561371494, 6114.205153330038, 5920.407959204045, 6032.517398608188, 6047.0929360596265, 6059.606125601822, 6062.969685151546, 5671.43285671446, 5692.1746346778655, 5832.912506312324, 5877.588568800143, 5897.616654917417, 6107.144999699956, 6116.42707509198, 6117.522930757332, 6131.468419844996, 6140.723667435065, 4908.0, 5944.346121926498, 5958.523318134626, 5969.104634304889, 5969.224000879858], "value": 5653.535011615705, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [445.41205608596647, 470.85347179617656, 516.7958656330752, 521.5957632834553, 532.4861508644158, 30046.399072018547, 39280.41079383811, 40641.59358406415, 40927.79536102319, 41027.56403525877, 42423.15153696924, 42864.357034644425, 42885.35671964915, 42890.571094289124, 43033.70898873031, 9265.72202833916, 9506.191973682211, 9512.096350846694, 9518.048195180496, 9527.666531671393, 8382.580870956459, 8610.0, 11250.0, 11506.079513638932, 11535.826962595567, 9729.70810875675, 11691.7077073073, 11696.239744416629, 11704.005159561448, 11712.824307635392, 9106.544672766402, 11176.329420234812, 11495.770084598345, 11579.073674106052, 11608.883911160907, 8414.158584141598, 8640.697575584887, 8641.049484556694, 8796.076411976714, 11117.055050320732, 39210.803945980086, 41186.588134118574, 41266.38100428496, 41283.76148715543, 41328.586714132776, 3928.371460566296, 3945.072907866649, 3969.821358038895, 3986.3422535281643, 4061.6953728470485, 29187.85406072956, 30010.549841752392, 30101.69898301011, 30576.54135187974, 31373.52939705906, 3119.251379668886, 3189.9681003189903, 3222.7744057915957, 3254.902352929416, 3255.9023229303157, 476663.0, 476965.0, 477009.0, 477561.0, 477868.61065694795, 61022.38977610167, 61813.690931545054, 61837.690811546556, 62096.0, 62337.06494402588, 65049.0, 65142.67428662921, 65218.67390663111, 65325.0, 65354.34645653578, 16669.666606667797, 16909.661806763797, 16910.900791448516, 16917.984920904786, 16919.154042297836, 11732.354720490284, 12882.098253122378, 12937.676558086123, 12961.805572916413, 12967.740645187232, 14282.214723159605, 14512.709745805025, 16200.51398458048, 16332.101734404721, 16481.0, 7022.754203602849, 7049.330313620198, 7100.502964792415, 7143.6428178591905, 7151.928480715231, 879.1779685993616, 879.8636211387245, 887.4586502233632, 917.1974522292994, 917.8026724254318, 30503.0, 33037.83481082579, 33759.649614015165, 34117.65882341195, 34493.82753086268, 1071.410724101741, 1073.9516721747384, 1113.1651261553834, 1117.6870476266658, 1224.1981502116128, 15027.0, 15745.842541574666, 15749.448769293249, 15835.762463563056, 16131.032138071754, 654975.0, 670341.0, 670563.0, 671890.0, 672824.0, 61772.38227617756, 62154.0, 62473.37526624766, 62612.0, 62876.0, 1469.4269234998146, 1479.5857159995219, 1491.7613181891063, 1517.9165145917082, 1526.198745658516, 26946.461070778867, 29137.85431072831, 30074.849625751733, 30604.500134466132, 30917.536236956013, 41127.0, 45919.0, 55694.886102278535, 55789.0, 55821.162682558985, 604253.0, 606405.0, 606824.0, 607818.0, 610554.0, 35112.297754045285, 43101.78449107734, 43841.0, 43966.340504893094, 44206.0, 36892.077698057765, 43197.0, 43485.0, 45400.54599454095, 48232.517674822804, 35966.280674386886, 37551.87344379673, 38101.237975240896, 38680.22639547137, 38715.451381944404, 38733.806330969295, 38928.80535597304, 39710.602893971845, 40365.39451908282, 41053.0, 37606.435903462014, 38025.239495210495, 38079.809600952925, 38116.618833811306, 38544.843654690405, 32877.83561082179, 33767.15582110467, 34409.82795086008, 34585.827070864485, 35043.82478087593, 24484.0, 25180.622290665287, 25406.618900716134, 25423.87288063622, 25919.22242332733], "value": 20523.563018343666, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [385.50462655487684, 390.09303369665525, 394.1191437137994, 397.83092185821016, 418.41422009187136, 13674.314771176982, 16102.516924492269, 20491.897540512313, 21509.139634414623, 21528.0, 17331.0, 20798.89600551999, 21076.683849742265, 21117.683234751454, 21375.786242137576, 5054.570361519275, 5319.760610772524, 5381.784728610851, 5418.0, 5422.132458806592, 5287.312649355578, 5338.306020217386, 5339.759710813023, 5342.412334643186, 5693.629914055594, 5891.734871930774, 5938.376470470582, 5941.88116237675, 5955.404459554032, 5966.79116230932, 5264.894702105937, 5363.383210930754, 5596.86007849805, 5927.940720592804, 5939.198208241897, 5138.948610513922, 5179.456157103487, 5245.973770131163, 5256.579473642099, 5261.447548007481, 13434.059615826896, 16998.575035624086, 20010.0, 20320.593588128155, 26476.47047059048, 2487.825852190347, 2566.268613445159, 2597.8051646126614, 2622.6493355921525, 2639.4061336199393, 9992.45041522716, 10063.89936100637, 10596.470176491144, 13304.935605151564, 14278.785818212735, 1804.548862784304, 1817.3366721146685, 1818.5362732503258, 1835.8898466092078, 1866.4214093631017, 142945.0, 144206.0, 145756.0, 147083.52916470804, 149603.0, 11719.06247500198, 11779.352135632622, 11943.0, 11974.281543107441, 12043.0, 13819.170849749047, 14532.128072315694, 15766.605834854221, 15795.21023948798, 15812.60468488297, 6079.148919151322, 6134.263888333339, 6234.407731265523, 8447.281981031558, 8825.205731484197, 8489.872651910102, 8573.614187361583, 8735.039145693969, 8795.076516965755, 8868.733937981871, 4607.0785842831565, 4684.695494792828, 4689.116193540948, 4738.31294462308, 4863.732494712754, 1836.6785812482763, 1891.4703882912806, 1953.8534609904314, 2016.3446879764135, 2022.9190832366835, 873.4366333714719, 970.8640790289365, 991.008991008991, 1021.8824835143905, 1031.2523420520213, 22196.778032219794, 22299.88500574965, 22303.665445018338, 22317.888410557844, 22326.441838954157, 891.5987805487426, 1023.5251321762574, 1045.927923878016, 1050.2333296693305, 1064.0955188090215, 10272.229582781321, 11347.489362978686, 11463.78154358082, 11511.136664750176, 11639.76720465603, 423838.0, 431499.84250079177, 752348.0, 754946.2252688701, 762924.0, 104984.0, 122943.0, 151749.24125379522, 154961.22519387555, 160190.0, 890.844102282111, 926.9304802139867, 940.4122423485185, 940.9623615055458, 941.5904081724472, 18921.526961825515, 20216.81541754149, 20351.59296814085, 20361.79638203599, 20461.283855065598, 47762.044759105316, 60372.79254414975, 61113.69443152756, 62357.68821155865, 63143.0, 70330.64834675794, 86735.0, 88221.0, 89943.0, 90492.09507904836, 8088.272055515032, 8358.662613981734, 8368.41421100517, 8746.825063498567, 8783.824323513621, 9237.399569027992, 12475.126741128033, 12924.0, 12966.740665186455, 13813.0, 11329.603463878724, 11349.716257093638, 11367.715807104889, 11423.771524569296, 11747.236429632047, 11010.50452729645, 11550.902664246883, 11646.708832278922, 11713.297202167898, 11917.404129793302, 11452.0, 11549.769004619693, 11658.358790266617, 11991.980681642159, 12115.939420302842, 8340.915680961436, 8483.194096560817, 8532.104129066358, 8652.307815374628, 8681.565921703763, 10700.30448020876, 11463.426828658367, 11584.362860042778, 11609.6517104487, 11615.6515304541], "value": 9739.165995871337, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1439.7408466476036, 1442.2860683961442, 1458.3656109592325, 1459.6715738958735, 1466.4207637982997, 8011.87982180267, 8414.49513029217, 8422.536760478171, 8425.157484251571, 8439.113893041227, 7309.34215920567, 7681.539107653531, 7681.65432555535, 7740.109887362955, 8218.54797986112, 1722.7415887616833, 2133.893305334735, 2236.194969810867, 2322.442613772691, 2324.848884822481, 2352.223766157164, 2357.54027964547, 2357.6463530470396, 2358.7287461941924, 2362.444825466023, 2279.8372829856726, 2320.6751054852334, 2325.139698311627, 2328.871912044837, 2333.3000099970027, 1962.6761584338567, 2260.9434764130865, 2317.258477287252, 2326.4183954011496, 2326.6044772388736, 2267.4331417145713, 2279.601069812776, 2339.3800642829665, 2341.8594884306826, 2353.505763789606, 8374.958125209396, 8415.410921235516, 8427.073021967579, 8438.493690378597, 8470.74587762362, 5054.646174767768, 5226.947730522722, 5228.79084836606, 5232.0, 5233.581313494949, 3219.951700724491, 3390.135515443546, 3419.452887538007, 3466.9133271668156, 3468.115630514228, 1110.1396417776207, 1153.4694040741185, 1154.9422528873606, 1163.6916217202447, 1196.9162158648899, 10880.836787448194, 10918.0173784359, 10925.650985038175, 10935.726606834813, 10942.45287735618, 3913.5890731473355, 4303.182395344875, 4658.1848176568965, 4728.574428301401, 4730.95269047312, 9621.134097931219, 9628.614855405705, 9633.181179599813, 9635.988221236668, 9646.276529260334, 5274.498922602346, 5283.656562323436, 5285.101532739443, 5296.179092240709, 5309.469053094737, 4261.957380426218, 4584.243599805995, 4645.5354464553275, 4730.787114579852, 4827.468978412372, 3570.696490798259, 3763.284975854579, 3764.3976963686227, 3789.052736815796, 3973.6225058619384, 1139.7264656482384, 1144.2447984330302, 1152.2740673375888, 1153.1870031627682, 1162.4013632979022, 768.4198430185174, 856.0198572634299, 895.1004240738147, 901.7024381953939, 908.681961313535, 5502.0, 5548.611597188158, 5675.716214189274, 5759.319189739882, 5868.706564671749, 982.4449186209912, 1006.1548299428368, 1010.757418219622, 1017.2523195451338, 1034.5551412892528, 3798.9620103798607, 3826.3877779555137, 3836.462895194675, 3935.193285376491, 3943.940840887389, 8153.79615509617, 10217.591296348062, 10224.233182511342, 10236.078752912274, 10254.948725256327, 10053.899461005443, 10152.644657437102, 10157.644482443078, 10172.694819155437, 10182.134518565857, 7476.514026588255, 7794.571298578632, 7907.920920790833, 7919.326857217201, 7924.445288829842, 5441.591880608891, 5446.564274857923, 5491.972540137273, 5610.074337734228, 5686.061799802987, 9061.818763624822, 9124.0, 9226.154769046083, 9267.76830579241, 9369.109934556207, 9218.354715170142, 9361.672341468016, 9443.055694430503, 9501.04989501072, 9511.66709165176, 6684.565503242274, 6746.4265537429865, 6849.1096157499205, 6857.657117144223, 6857.759978400732, 7400.185979542353, 7760.68957241704, 7790.610469476617, 7821.921780782347, 7925.128235894163, 6688.3646053624825, 7109.253528379446, 7152.785416437515, 7154.892676609751, 7349.007883935814, 7259.818504537217, 7311.159216689936, 7313.963430183028, 7319.4144468443465, 7363.521371110861, 6315.179026726496, 6334.1765570475545, 6346.746130154742, 6411.903821442776, 6433.453156481752, 4225.429567008538, 4792.161371759998, 4860.902781944271, 4977.203647416396, 5025.572826309804, 4911.361523001987, 4950.108980383421, 4961.330220420341, 5094.643374963865, 5199.506046925536], "value": 4399.650116819698, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [307.24111444731506, 346.8231202086935, 352.7477853334863, 363.43667315660736, 369.98335074921624, 4233.195692818363, 4528.615067719244, 5300.89398212036, 5317.601179911508, 5352.304200453936, 4519.457665080186, 4658.417697787777, 4910.75446227689, 5040.974795126029, 5255.816046438375, 3954.9604503955024, 4032.5967403259588, 4111.588841115879, 4112.074783173784, 4121.567235440266, 4081.530623978236, 4102.425660407545, 4105.671546276306, 4131.35963925592, 4143.834246630131, 3724.9627503724887, 3954.762714237155, 4063.573324800898, 4068.5117785865737, 4091.9335735453556, 3328.3676101540873, 4065.4714887064492, 4069.871961328747, 4077.633013028827, 4105.0763578194965, 3198.440272952247, 3593.7484376093685, 3627.1657518770567, 3630.2739452109686, 3635.709143268532, 5142.871428214287, 5157.252198431244, 5181.766820493087, 5181.81863634771, 5183.883018038713, 4235.512916014667, 4519.457665080178, 4529.0, 4556.248219043854, 4594.150082234763, 4939.259111133359, 5544.500994910478, 5567.772890843655, 5600.179941519023, 5601.635893666939, 3374.5995411904278, 3381.0, 3620.149264922741, 3732.9066773330615, 3827.9617203827884, 5213.2701421800975, 5474.945250547484, 5781.219535362714, 5806.709664516758, 5889.4993925515955, 3488.598811136752, 4077.836886524565, 4126.587341265849, 4170.374443833449, 4229.703920725519, 4039.909224509425, 4231.978840105779, 4266.189424009428, 4286.592773686495, 4318.956810431855, 4403.757793321334, 4609.842258053177, 4675.438947326343, 4744.478107408182, 4809.663323567387, 5599.412061733541, 5604.8995414172905, 5606.831795046073, 5617.550595952314, 5632.97183514088, 1194.2177873492876, 1368.5962641020922, 1377.304461247084, 1382.9101108428122, 1383.754620841231, 761.1285078584989, 862.3101518784947, 894.8233073508316, 915.3866909170871, 932.5989824375583, 4398.4941731701265, 4929.605631549467, 4968.335607571432, 4979.0, 5017.14365684699, 4407.942093897442, 4632.521600943546, 5447.700376479332, 5476.616636835383, 5488.56091512678, 4239.872803815891, 4731.668783185213, 4919.909038658556, 4957.033378491232, 5015.699058056528, 2813.817101888371, 2829.3209629688727, 2839.9432011360072, 2849.28767808048, 2857.4999375109273, 4860.562549370574, 5642.4075472075665, 5666.583354161459, 5670.943290567042, 5723.713814309268, 4899.603612970286, 5078.003977653202, 5187.4553171916405, 5538.47384498472, 5578.442155784389, 4924.645722426361, 5564.27664403633, 5592.860178495489, 5621.943780562142, 5664.405237450009, 4651.418572678415, 4798.880027999328, 5242.455036539691, 5333.42660417529, 5406.864828379322, 4480.171168333869, 4795.856124316276, 4959.479254678206, 5340.732963351895, 5345.251664766858, 5033.572146367454, 5575.386707462257, 5618.415528856608, 5622.690752008515, 5643.88712225745, 3746.9508537609513, 3855.0, 3906.902327441837, 3922.9215415692097, 3948.9210215794947, 4855.902881942271, 5151.2273159026445, 5327.280817089643, 5404.135338345845, 5517.393086760533, 4403.766945255334, 4526.592606665285, 4944.876378090433, 5009.248612708123, 5227.738613069408, 4306.104186957057, 4426.44669416323, 4639.791209395517, 5070.543651071422, 5177.92233116496, 4610.815567377267, 5081.898362032813, 5115.820946266863, 5121.129408000724, 5136.512031357015, 4498.797554110008, 5364.865878352916, 5365.0, 5366.946330536644, 5494.862628434321, 5149.897002060013, 5401.6218864679095, 5403.756830942539, 5424.294841670558, 5437.265969094122], "value": 4005.9747457965623, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [692.3284414118305, 703.1421665568012, 714.3178264757157, 781.9530828150312, 831.9001719793624, 14746.557603271893, 15440.61398465039, 15629.374825006986, 15650.686986260267, 15673.294701738421, 14235.71528569428, 14273.857261427383, 14375.712485750279, 14387.568372948803, 14400.711985760305, 661.5237029338869, 681.2812482830611, 684.4148253243455, 817.1215942861418, 829.854775414303, 815.759350991456, 840.6637345061963, 846.851800934837, 854.3933806997009, 855.9871601925976, 885.3315746611299, 885.8361203177401, 886.1847100667369, 886.7339798060589, 887.8268737596171, 693.8473535822111, 884.1688812516214, 884.9026607073217, 884.9469031858109, 885.4333226734863, 533.4265664410774, 536.1421725239625, 536.1957064403394, 536.9140937449989, 644.1818890009662, 15046.699066018728, 15105.924470377578, 15428.460003899809, 15479.380824766995, 15504.689906201926, 13683.589492315246, 13686.863131368758, 13703.0, 13745.656358591015, 13839.238841863693, 12036.939815300955, 12160.0, 12190.329531875743, 12353.135280530367, 12720.173188742794, 4231.449911511515, 4405.669574781872, 4413.205622987861, 4418.160549495586, 4523.095380923795, 104714.47642761738, 107198.0, 109171.9999999992, 111523.19337646368, 115701.42149289284, 10540.051102676749, 10732.517036733365, 10957.83563246552, 11035.062019728413, 11268.887311126784, 22177.667334989987, 22541.88729056377, 22563.77436225617, 22616.208432705105, 22640.773592263868, 7672.923270767221, 7679.2704693054075, 7689.477922826882, 7700.191479894643, 7773.961130194313, 4038.091429428414, 4121.423000779893, 4132.586741325904, 4230.407742915994, 4299.914001719948, 3362.1090411041096, 3461.3769521486374, 3463.480477928331, 3470.6355832637714, 3471.5660542432197, 628.205320269859, 634.5431289471574, 644.5294934697697, 651.5732195412013, 653.5947712418331, 509.9184130539096, 624.4765053105276, 637.2077812682736, 656.5633853487473, 657.6843115304681, 9083.500407477652, 9297.488638124833, 9651.889318655134, 9695.51522423876, 9715.659951901649, 617.9227596550431, 619.5074915442234, 631.5569965294134, 643.2923783837741, 669.4142625202948, 3812.3709587917683, 4019.2966230909474, 4688.9531104689195, 4701.4955214331085, 4760.690555113906, 109129.0, 112203.0, 112719.0, 113321.43339283415, 113591.0, 68841.65579172072, 85677.14322856817, 86818.0, 87264.0, 88809.0, 84888.0, 85366.0, 87979.0, 88013.55993220121, 88793.55603221942, 9199.86200206984, 9211.907880921104, 9214.861777073214, 9232.446053236827, 9232.95383523078, 54685.63285917884, 54850.725746372605, 55246.342609721774, 55739.442605575045, 55854.882902342535, 62601.68699156475, 69421.61156776735, 73595.6320218417, 73812.0, 75984.0, 14073.859261407255, 14082.718345633235, 14107.788383174055, 14256.643583910485, 14706.19115948633, 14557.708845823236, 14606.561803145923, 14666.85333146655, 15025.323860426088, 15078.321475533847, 13551.390187441391, 13600.7788904781, 13819.723605527632, 13969.58091257264, 13974.79037814454, 13153.342332883127, 14053.508127215498, 14149.504767333094, 14216.573502794932, 14241.145531268157, 13294.335283235607, 13440.596782096552, 13462.596122116352, 13520.526781562598, 13534.390952407362, 11019.272779748862, 11278.943605281922, 11334.546618135182, 11441.256318339281, 11442.942785286354, 11116.833247501132, 11232.269902456314, 11322.433878306216, 11448.427578621202, 11517.02105321057], "value": 7499.028872721701, "unit": "score"}], "name": "dromaeo_css", "value": 7284.157176203671, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 114.0, 114.0, 113.0, 113.0, 114.0, 113.0, 112.0, 115.0, 112.0], "value": 113.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 118.0, 140.0, 150.0, 109.0, 120.0, 137.0, 138.0, 149.0, 109.0], "value": 131.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 183.0, 184.0, 182.0, 182.0, 184.0, 183.0, 203.0, 263.0, 199.0], "value": 194.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 58.0, 58.0, 90.0, 58.0, 59.0, 59.0, 58.0, 74.0, 58.0], "value": 65.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 70.0, 85.0, 69.0, 67.0, 68.0, 82.0, 67.0, 68.0, 82.0], "value": 74.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 89.0, 73.0, 114.0, 91.0, 87.0, 91.0, 121.0, 74.0, 121.0], "value": 95.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 96.0, 95.0, 102.0, 96.0, 96.0, 96.0, 96.0, 95.0], "value": 96.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 85.0, 87.0, 88.0, 85.0, 86.0, 85.0, 88.0, 88.0, 87.0], "value": 87.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 54.0, 54.0, 54.0, 55.0, 59.0, 57.0, 56.0, 55.0, 57.0], "value": 55.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 73.0, 80.0, 75.0, 74.0, 70.0, 69.0, 86.0, 105.0, 105.0], "value": 80.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 87.0, 81.0, 84.0, 81.0, 82.0, 83.0, 81.0, 100.0, 102.0], "value": 86.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 136.0, 137.0, 165.0, 143.0, 146.0, 142.0, 134.0, 173.0, 161.0], "value": 147.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 168.0, 168.0, 168.0, 170.0, 169.0, 171.0, 167.0, 166.0, 165.0], "value": 168.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 68.0, 56.0, 76.0, 74.0, 81.0, 84.0, 83.0, 71.0], "value": 72.6, "unit": "score"}], "name": "kraken", "value": 1468.6999999999998, "alertThreshold": 2.0}]} 09:47:00 INFO - Return code: 0 09:47:00 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:47:00 ERROR - # TBPL SUCCESS # 09:47:00 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:47:00 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:47:00 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:47:00 INFO - 2017-03-03 09:47:00.964 screenresolution[1927:13976] starting screenresolution argv=screenresolution get 09:47:00 INFO - 2017-03-03 09:47:00.967 screenresolution[1927:13976] Display 0: 1600x1200x32@60 09:47:00 INFO - 2017-03-03 09:47:00.973 screenresolution[1928:13979] starting screenresolution argv=screenresolution list 09:47:00 INFO - Available Modes on Display 0 09:47:00 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:47:00 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:47:00 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:47:00 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:47:01 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:47:01 INFO - Intel Iris: 09:47:01 INFO - Chipset Model: Intel Iris 09:47:01 INFO - Type: GPU 09:47:01 INFO - Bus: Built-In 09:47:01 INFO - VRAM (Dynamic, Max): 1536 MB 09:47:01 INFO - Vendor: Intel (0x8086) 09:47:01 INFO - Device ID: 0x0a2e 09:47:01 INFO - Revision ID: 0x0009 09:47:01 INFO - Displays: 09:47:01 INFO - Display: 09:47:01 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:47:01 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:47:01 INFO - Display Serial Number: 1600x1200 60 09:47:01 INFO - Main Display: Yes 09:47:01 INFO - Mirror: Off 09:47:01 INFO - Online: Yes 09:47:01 INFO - Rotation: Supported 09:47:01 INFO - Return code: 0 09:47:01 INFO - Running post-action listener: _resource_record_post_action 09:47:01 INFO - [mozharness: 2017-03-03 17:47:01.210258Z] Finished run-tests step (success) 09:47:01 INFO - Running post-run listener: _resource_record_post_run 09:47:01 INFO - Total resource usage - Wall time: 1198s; CPU: 54.0%; Read bytes: 462848; Write bytes: 507507200; Read time: 11; Write time: 1597 09:47:01 INFO - TinderboxPrint: CPU usage
53.5% 09:47:01 INFO - TinderboxPrint: I/O read bytes / time
462,848 / 11 09:47:01 INFO - TinderboxPrint: I/O write bytes / time
507,507,200 / 1,597 09:47:01 INFO - TinderboxPrint: CPU idle
2,226.8 (46.5%) 09:47:01 INFO - TinderboxPrint: CPU system
953.3 (19.9%) 09:47:01 INFO - TinderboxPrint: CPU user
1,613.5 (33.7%) 09:47:01 INFO - TinderboxPrint: Swap in / out
208,453,632 / 0 09:47:01 INFO - install - Wall time: 21s; CPU: 54.0%; Read bytes: 201253376; Write bytes: 202143744; Read time: 15643; Write time: 457 09:47:01 INFO - run-tests - Wall time: 1179s; CPU: 54.0%; Read bytes: 462848; Write bytes: 294668800; Read time: 11; Write time: 1110 09:47:01 INFO - Running post-run listener: _upload_blobber_files 09:47:01 INFO - Blob upload gear active. 09:47:01 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:47:01 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 09:47:01 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'] 09:47:01 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 09:47:02 INFO - (blobuploader) - INFO - Open directory for files ... 09:47:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:47:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:47:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:47:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:47:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:47:02 INFO - (blobuploader) - INFO - Done attempting. 09:47:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:47:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:47:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:47:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:47:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:47:03 INFO - (blobuploader) - INFO - Done attempting. 09:47:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 09:47:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:47:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:47:04 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 09:47:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:47:04 INFO - (blobuploader) - INFO - Done attempting. 09:47:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:47:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:47:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:47:07 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:47:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:47:07 INFO - (blobuploader) - INFO - Done attempting. 09:47:07 INFO - (blobuploader) - INFO - Iteration through files over. 09:47:07 INFO - Return code: 0 09:47:07 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:47:07 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:47:07 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/23d2f77f6f44911667e539b671f12cb69bab14b8a703094600ebd5b6784fefea86c2bcbab91a268cae303b0d8f5f0426b22c674d4fbe12b4c1c963c63bb8944a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/65a4fe2cdf881d00266326656a253829f0b45e02be51887341ab2797b14d3f73d4fd118d885be2db30002ab4f92e0c80c0922c31049c2143bfed1f04a5c078e4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7e2a91f1b5b91c80419f2e20f5e0d1cdb6724a2f9c8c94beaea0c2ecc22cebdfe95ce8de3824212f38258db1340c1bc0d1ed08d82e59e2b1dfa4f957f5add8d9", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ba065f590c645bb95f2a74d950e0fe3cc11d843b436d1ccde6c84a64df6ee8a2856fbdaef92274dea27563fe1ec0a2da1a8e6a2d0a677d180b56e88c69bfe0c5"} 09:47:07 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:47:07 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:47:07 INFO - Contents: 09:47:07 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/23d2f77f6f44911667e539b671f12cb69bab14b8a703094600ebd5b6784fefea86c2bcbab91a268cae303b0d8f5f0426b22c674d4fbe12b4c1c963c63bb8944a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/65a4fe2cdf881d00266326656a253829f0b45e02be51887341ab2797b14d3f73d4fd118d885be2db30002ab4f92e0c80c0922c31049c2143bfed1f04a5c078e4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7e2a91f1b5b91c80419f2e20f5e0d1cdb6724a2f9c8c94beaea0c2ecc22cebdfe95ce8de3824212f38258db1340c1bc0d1ed08d82e59e2b1dfa4f957f5add8d9", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ba065f590c645bb95f2a74d950e0fe3cc11d843b436d1ccde6c84a64df6ee8a2856fbdaef92274dea27563fe1ec0a2da1a8e6a2d0a677d180b56e88c69bfe0c5"} 09:47:07 INFO - Running post-run listener: copy_logs_to_upload_dir 09:47:07 INFO - Copying logs to upload dir... 09:47:07 INFO - mkdir: /builds/slave/test/build/upload/logs 09:47:07 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1259.693431 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2017-03-03 09:47:07.188788) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-03 09:47:07.192045) ========= 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: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Mre7AZMiB0/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test/properties RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.ypL2yH2MfI/Listeners TMPDIR=/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/23d2f77f6f44911667e539b671f12cb69bab14b8a703094600ebd5b6784fefea86c2bcbab91a268cae303b0d8f5f0426b22c674d4fbe12b4c1c963c63bb8944a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/65a4fe2cdf881d00266326656a253829f0b45e02be51887341ab2797b14d3f73d4fd118d885be2db30002ab4f92e0c80c0922c31049c2143bfed1f04a5c078e4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7e2a91f1b5b91c80419f2e20f5e0d1cdb6724a2f9c8c94beaea0c2ecc22cebdfe95ce8de3824212f38258db1340c1bc0d1ed08d82e59e2b1dfa4f957f5add8d9", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ba065f590c645bb95f2a74d950e0fe3cc11d843b436d1ccde6c84a64df6ee8a2856fbdaef92274dea27563fe1ec0a2da1a8e6a2d0a677d180b56e88c69bfe0c5"} build_url:https://queue.taskcluster.net/v1/task/M_o_oOgpTpC3YE29EHfi4Q/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011404 build_url: 'https://queue.taskcluster.net/v1/task/M_o_oOgpTpC3YE29EHfi4Q/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/23d2f77f6f44911667e539b671f12cb69bab14b8a703094600ebd5b6784fefea86c2bcbab91a268cae303b0d8f5f0426b22c674d4fbe12b4c1c963c63bb8944a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/65a4fe2cdf881d00266326656a253829f0b45e02be51887341ab2797b14d3f73d4fd118d885be2db30002ab4f92e0c80c0922c31049c2143bfed1f04a5c078e4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7e2a91f1b5b91c80419f2e20f5e0d1cdb6724a2f9c8c94beaea0c2ecc22cebdfe95ce8de3824212f38258db1340c1bc0d1ed08d82e59e2b1dfa4f957f5add8d9", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ba065f590c645bb95f2a74d950e0fe3cc11d843b436d1ccde6c84a64df6ee8a2856fbdaef92274dea27563fe1ec0a2da1a8e6a2d0a677d180b56e88c69bfe0c5"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-03 09:47:07.228895) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-03 09:47:07.229284) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Mre7AZMiB0/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.ypL2yH2MfI/Listeners TMPDIR=/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.005232 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-03 09:47:07.280000) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-03 09:47:07.280560) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-03 09:47:07.281491) ========= ========= Total master_lag: 0.19 =========