builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0026 starttime: 1477516100.31 results: success (0) buildid: 20161010141523 builduid: 8a8b986c697f4016a91ebaa5ad5406f4 revision: 6031d730c46ae3b3db353a8d35c99e82117f6479 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-26 14:08:20.308132) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-26 14:08:20.308565) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-26 14:08:20.308844) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-26 14:08:20.331577) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 14:08:20.331874) ========= 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.8YC63bzea8/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.uFuRCxXUHc/Listeners TMPDIR=/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/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 --2016-10-26 14:08:20-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 7.93M=0.001s 2016-10-26 14:08:20 (7.93 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.117516 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 14:08:20.470925) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 14:08:20.471264) ========= 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.8YC63bzea8/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.uFuRCxXUHc/Listeners TMPDIR=/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/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.020094 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 14:08:20.519795) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-26 14:08:20.520155) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 6031d730c46ae3b3db353a8d35c99e82117f6479 --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 6031d730c46ae3b3db353a8d35c99e82117f6479 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.8YC63bzea8/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.uFuRCxXUHc/Listeners TMPDIR=/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/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 2016-10-26 14:08:20,593 truncating revision to first 12 chars 2016-10-26 14:08:20,593 Setting DEBUG logging. 2016-10-26 14:08:20,593 attempt 1/10 2016-10-26 14:08:20,593 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/6031d730c46a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-26 14:08:21,673 unpacking tar archive at: mozilla-aurora-6031d730c46a/testing/mozharness/ program finished with exit code 0 elapsedTime=1.346847 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-26 14:08:21.888544) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-26 14:08:21.888859) ========= script_repo_revision: 6031d730c46ae3b3db353a8d35c99e82117f6479 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-26 14:08:21.889298) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-26 14:08:21.889562) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-26 14:08:21.907732) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-10-26 14:08:21.908009) ========= /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.8YC63bzea8/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.uFuRCxXUHc/Listeners TMPDIR=/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/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 14:08:22 INFO - MultiFileLogger online at 20161026 14:08:22 in /builds/slave/test 14:08:22 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 14:08:22 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:08:22 INFO - {'append_to_log': False, 14:08:22 INFO - 'base_work_dir': '/builds/slave/test', 14:08:22 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 14:08:22 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:08:22 INFO - 'branch': 'Mozilla-Aurora', 14:08:22 INFO - 'buildbot_json_path': 'buildprops.json', 14:08:22 INFO - 'config_files': ('talos/mac_config.py',), 14:08:22 INFO - 'default_actions': ('clobber', 14:08:22 INFO - 'read-buildbot-config', 14:08:22 INFO - 'download-and-extract', 14:08:22 INFO - 'populate-webroot', 14:08:22 INFO - 'create-virtualenv', 14:08:22 INFO - 'install', 14:08:22 INFO - 'run-tests'), 14:08:22 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:08:22 INFO - 'download_minidump_stackwalk': True, 14:08:22 INFO - 'download_symbols': 'ondemand', 14:08:22 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:08:22 INFO - 'tooltool.py': '/tools/tooltool.py', 14:08:22 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:08:22 INFO - '/tools/misc-python/virtualenv.py')}, 14:08:22 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:08:22 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:08:22 INFO - 'installer_path': 'installer.exe', 14:08:22 INFO - 'log_level': 'info', 14:08:22 INFO - 'log_name': 'talos', 14:08:22 INFO - 'log_to_console': True, 14:08:22 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 14:08:22 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 14:08:22 INFO - 'opt_config_files': (), 14:08:22 INFO - 'pip_index': False, 14:08:22 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:08:22 INFO - 'cmd': ('bash', 14:08:22 INFO - '-c', 14:08:22 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:08:22 INFO - 'enabled': True, 14:08:22 INFO - 'halt_on_failure': False, 14:08:22 INFO - 'name': 'check_screen_resolution'},), 14:08:22 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:08:22 INFO - 'cmd': ('bash', 14:08:22 INFO - '-c', 14:08:22 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:08:22 INFO - 'enabled': True, 14:08:22 INFO - 'halt_on_failure': False, 14:08:22 INFO - 'name': 'check_screen_resolution'},), 14:08:22 INFO - 'run_cmd_checks_enabled': True, 14:08:22 INFO - 'sps_profile': False, 14:08:22 INFO - 'sps_profile_interval': 0, 14:08:22 INFO - 'suite': 'dromaeojs', 14:08:22 INFO - 'system_bits': '32', 14:08:22 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:08:22 INFO - 'title': 't-yosemite-r7-0026', 14:08:22 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:08:22 INFO - 'use_talos_json': True, 14:08:22 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:08:22 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:08:22 INFO - 'work_dir': 'build'} 14:08:22 INFO - [mozharness: 2016-10-26 21:08:22.098492Z] Running clobber step. 14:08:22 INFO - Running pre-action listener: _resource_record_pre_action 14:08:22 INFO - Running main action method: clobber 14:08:22 INFO - rmtree: /builds/slave/test/build 14:08:22 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:08:24 INFO - Running post-action listener: _resource_record_post_action 14:08:24 INFO - [mozharness: 2016-10-26 21:08:24.287577Z] Finished clobber step (success) 14:08:24 INFO - [mozharness: 2016-10-26 21:08:24.287824Z] Running read-buildbot-config step. 14:08:24 INFO - Running pre-action listener: _resource_record_pre_action 14:08:24 INFO - Running main action method: read_buildbot_config 14:08:24 INFO - Using buildbot properties: 14:08:24 INFO - { 14:08:24 INFO - "project": "", 14:08:24 INFO - "product": "firefox", 14:08:24 INFO - "script_repo_revision": "production", 14:08:24 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 14:08:24 INFO - "repository": "", 14:08:24 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 14:08:24 INFO - "buildid": "20161010141523", 14:08:24 INFO - "pgo_build": "False", 14:08:24 INFO - "basedir": "/builds/slave/test", 14:08:24 INFO - "buildnumber": 19, 14:08:24 INFO - "slavename": "t-yosemite-r7-0026", 14:08:24 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 14:08:24 INFO - "platform": "yosemite_r7", 14:08:24 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 14:08:24 INFO - "branch": "mozilla-aurora", 14:08:24 INFO - "repo_path": "releases/mozilla-aurora", 14:08:24 INFO - "revision": "6031d730c46ae3b3db353a8d35c99e82117f6479", 14:08:24 INFO - "stage_platform": "macosx64", 14:08:24 INFO - "builduid": "8a8b986c697f4016a91ebaa5ad5406f4", 14:08:24 INFO - "slavebuilddir": "test" 14:08:24 INFO - } 14:08:24 INFO - Found installer url https://queue.taskcluster.net/v1/task/B80AX5jXRCOwcCWqBAhbJg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg. 14:08:24 INFO - Running post-action listener: _resource_record_post_action 14:08:24 INFO - [mozharness: 2016-10-26 21:08:24.293691Z] Finished read-buildbot-config step (success) 14:08:24 INFO - [mozharness: 2016-10-26 21:08:24.293908Z] Running download-and-extract step. 14:08:24 INFO - Running pre-action listener: _resource_record_pre_action 14:08:24 INFO - Running main action method: download_and_extract 14:08:24 INFO - mkdir: /builds/slave/test/build/tests 14:08:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:08:24 INFO - trying https://queue.taskcluster.net/v1/task/B80AX5jXRCOwcCWqBAhbJg/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json 14:08:24 INFO - Downloading https://queue.taskcluster.net/v1/task/B80AX5jXRCOwcCWqBAhbJg/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 14:08:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/B80AX5jXRCOwcCWqBAhbJg/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json'}, attempt #1 14:08:25 INFO - Downloaded 1199 bytes. 14:08:25 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 14:08:25 INFO - Using the following test package requirements: 14:08:25 INFO - {u'common': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 14:08:25 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 14:08:25 INFO - u'firefox-51.0a2.en-US.mac.cppunittest.tests.zip'], 14:08:25 INFO - u'gtest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 14:08:25 INFO - u'firefox-51.0a2.en-US.mac.gtest.tests.zip'], 14:08:25 INFO - u'jittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 14:08:25 INFO - u'jsshell-mac.zip'], 14:08:25 INFO - u'mochitest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 14:08:25 INFO - u'firefox-51.0a2.en-US.mac.mochitest.tests.zip'], 14:08:25 INFO - u'mozbase': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 14:08:25 INFO - u'reftest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 14:08:25 INFO - u'firefox-51.0a2.en-US.mac.reftest.tests.zip'], 14:08:25 INFO - u'talos': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 14:08:25 INFO - u'firefox-51.0a2.en-US.mac.talos.tests.zip'], 14:08:25 INFO - u'web-platform': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 14:08:25 INFO - u'firefox-51.0a2.en-US.mac.web-platform.tests.zip'], 14:08:25 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 14:08:25 INFO - u'firefox-51.0a2.en-US.mac.xpcshell.tests.zip']} 14:08:25 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip'] for test suite category: common 14:08:25 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/B80AX5jXRCOwcCWqBAhbJg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 14:08:25 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/B80AX5jXRCOwcCWqBAhbJg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 14:08:25 INFO - Fetch https://queue.taskcluster.net/v1/task/B80AX5jXRCOwcCWqBAhbJg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 14:08:25 INFO - Expected file size: 16435047 14:08:32 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip', u'firefox-51.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 14:08:32 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/B80AX5jXRCOwcCWqBAhbJg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 14:08:32 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/B80AX5jXRCOwcCWqBAhbJg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 14:08:32 INFO - Fetch https://queue.taskcluster.net/v1/task/B80AX5jXRCOwcCWqBAhbJg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 14:08:33 INFO - Expected file size: 16435047 14:08:40 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/B80AX5jXRCOwcCWqBAhbJg/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip 14:08:40 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/B80AX5jXRCOwcCWqBAhbJg/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip'}, attempt #1 14:08:40 INFO - Fetch https://queue.taskcluster.net/v1/task/B80AX5jXRCOwcCWqBAhbJg/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip into memory 14:08:40 INFO - Expected file size: 14414059 14:08: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')]} 14:08:41 INFO - trying https://queue.taskcluster.net/v1/task/B80AX5jXRCOwcCWqBAhbJg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 14:08:41 INFO - Downloading https://queue.taskcluster.net/v1/task/B80AX5jXRCOwcCWqBAhbJg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg 14:08:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/B80AX5jXRCOwcCWqBAhbJg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg'}, attempt #1 14:08:44 INFO - Downloaded 115371581 bytes. 14:08:44 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/B80AX5jXRCOwcCWqBAhbJg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 14:08:44 INFO - mkdir: /builds/slave/test/properties 14:08:44 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:08:44 INFO - Writing to file /builds/slave/test/properties/build_url 14:08:44 INFO - Contents: 14:08:44 INFO - build_url:https://queue.taskcluster.net/v1/task/B80AX5jXRCOwcCWqBAhbJg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 14:08:44 INFO - Running post-action listener: _resource_record_post_action 14:08:44 INFO - Running post-action listener: set_extra_try_arguments 14:08:44 INFO - [mozharness: 2016-10-26 21:08:44.836598Z] Finished download-and-extract step (success) 14:08:44 INFO - [mozharness: 2016-10-26 21:08:44.836714Z] Running populate-webroot step. 14:08:44 INFO - Running pre-action listener: _resource_record_pre_action 14:08:44 INFO - Running main action method: populate_webroot 14:08:44 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:08:44 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:08:44 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:08:44 INFO - '--tppagecycles', 14:08:44 INFO - '7'], 14:08:44 INFO - 'tests': ['tsvgm']}}, 14:08:44 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:08:44 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:08:44 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:08:44 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:08:44 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:08:44 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:08:44 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:08:44 INFO - 'talos_options': ['--disable-e10s'], 14:08:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:08:44 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:08:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:08:44 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:08:44 INFO - 'talos_options': ['--disable-e10s'], 14:08:44 INFO - 'tests': ['damp', 'tps']}, 14:08:44 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:08:44 INFO - 'tests': ['damp', 'tps']}, 14:08:44 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:08:44 INFO - 'tests': ['dromaeo_dom']}, 14:08:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:08:44 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:08:44 INFO - 'tests': ['basic_compositor_video']}, 14:08:44 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 14:08:44 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:08:44 INFO - 'tests': ['a11yr', 14:08:44 INFO - 'ts_paint', 14:08:44 INFO - 'tpaint', 14:08:44 INFO - 'sessionrestore', 14:08:44 INFO - 'sessionrestore_no_auto_restore', 14:08:44 INFO - 'tabpaint']}, 14:08:44 INFO - 'other-e10s': {'tests': ['a11yr', 14:08:44 INFO - 'ts_paint', 14:08:44 INFO - 'tpaint', 14:08:44 INFO - 'sessionrestore', 14:08:44 INFO - 'sessionrestore_no_auto_restore', 14:08:44 INFO - 'tabpaint']}, 14:08:44 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:08:44 INFO - 'ts_paint', 14:08:44 INFO - 'tpaint', 14:08:44 INFO - 'sessionrestore', 14:08:44 INFO - 'sessionrestore_no_auto_restore', 14:08:44 INFO - 'tabpaint']}, 14:08:44 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:08:44 INFO - 'ts_paint', 14:08:44 INFO - 'tpaint', 14:08:44 INFO - 'sessionrestore', 14:08:44 INFO - 'sessionrestore_no_auto_restore', 14:08:44 INFO - 'tabpaint']}, 14:08:44 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:08:44 INFO - 'tests': ['a11yr', 14:08:44 INFO - 'ts_paint', 14:08:44 INFO - 'tpaint', 14:08:44 INFO - 'sessionrestore', 14:08:44 INFO - 'sessionrestore_no_auto_restore', 14:08:44 INFO - 'tabpaint']}, 14:08:44 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:08:44 INFO - 'tests': ['a11yr', 14:08:44 INFO - 'ts_paint', 14:08:44 INFO - 'tpaint', 14:08:44 INFO - 'sessionrestore', 14:08:44 INFO - 'sessionrestore_no_auto_restore', 14:08:44 INFO - 'tabpaint']}, 14:08:44 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:08:44 INFO - 'tests': ['tsvgx', 14:08:44 INFO - 'tsvgr_opacity', 14:08:44 INFO - 'tart', 14:08:44 INFO - 'tscrollx', 14:08:44 INFO - 'cart']}, 14:08:44 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:08:44 INFO - 'tsvgr_opacity', 14:08:44 INFO - 'tart', 14:08:44 INFO - 'tscrollx', 14:08:44 INFO - 'cart']}, 14:08:44 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:08:44 INFO - 'talos_options': ['--disable-e10s'], 14:08:44 INFO - 'tests': ['tp5o']}, 14:08:44 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:08:44 INFO - 'tests': ['tp5o']}, 14:08:44 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:08:44 INFO - 'talos_options': ['--disable-e10s', 14:08:44 INFO - '--xperf_path', 14:08:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:08:44 INFO - 'tests': ['tp5n']}, 14:08:44 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:08:44 INFO - 'talos_options': ['--xperf_path', 14:08:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:08:44 INFO - 'tests': ['tp5n']}}, 14:08:44 INFO - 'talos.zip': {'path': '', 14:08:44 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:08:44 INFO - Running post-action listener: _resource_record_post_action 14:08:44 INFO - [mozharness: 2016-10-26 21:08:44.855276Z] Finished populate-webroot step (success) 14:08:44 INFO - [mozharness: 2016-10-26 21:08:44.855365Z] Running create-virtualenv step. 14:08:44 INFO - Running pre-action listener: _resource_record_pre_action 14:08:44 INFO - Running main action method: create_virtualenv 14:08:44 INFO - Creating virtualenv /builds/slave/test/build/venv 14:08:44 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 14:08:44 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:08:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:08:44 INFO - Using real prefix '/tools/python27' 14:08:44 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:08:45 INFO - Installing distribute.............................................................................................................................................................................................done. 14:08:48 INFO - Installing pip.................done. 14:08:48 INFO - Return code: 0 14:08:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:08:48 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')]} 14:08:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:08:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:08:48 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')]} 14:08:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:08:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:08:48 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 0x1012df490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101255570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fecdac805a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1010f3d30>, '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 0x100f59db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1010ebb20>, '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.8YC63bzea8/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.uFuRCxXUHc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/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 14:08:48 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 14:08:48 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 14:08:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8YC63bzea8/Render', 14:08:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:08:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:08:48 INFO - 'HOME': '/Users/cltbld', 14:08:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:08:48 INFO - 'LOGNAME': 'cltbld', 14:08:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:08:48 INFO - 'MOZ_NO_REMOTE': '1', 14:08:48 INFO - 'NO_EM_RESTART': '1', 14:08:48 INFO - 'PAGER': '/bin/cat', 14:08:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:08:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:08:48 INFO - 'PWD': '/builds/slave/test', 14:08:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:08:48 INFO - 'SHELL': '/bin/bash', 14:08:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uFuRCxXUHc/Listeners', 14:08:48 INFO - 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/', 14:08:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:08:48 INFO - 'USER': 'cltbld', 14:08:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:08:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:08:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:08:48 INFO - 'XPC_FLAGS': '0x0', 14:08:48 INFO - 'XPC_SERVICE_NAME': '0', 14:08:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:08:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:08:48 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 14:08:48 INFO - Cleaning up... 14:08:48 INFO - Return code: 0 14:08:48 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:08:48 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')]} 14:08:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:08:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:08:48 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')]} 14:08:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:08:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:08:48 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 0x1012df490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101255570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fecdac805a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1010f3d30>, '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 0x100f59db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1010ebb20>, '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.8YC63bzea8/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.uFuRCxXUHc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/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 14:08:48 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 14:08:48 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 14:08:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8YC63bzea8/Render', 14:08:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:08:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:08:48 INFO - 'HOME': '/Users/cltbld', 14:08:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:08:48 INFO - 'LOGNAME': 'cltbld', 14:08:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:08:48 INFO - 'MOZ_NO_REMOTE': '1', 14:08:48 INFO - 'NO_EM_RESTART': '1', 14:08:48 INFO - 'PAGER': '/bin/cat', 14:08:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:08:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:08:48 INFO - 'PWD': '/builds/slave/test', 14:08:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:08:48 INFO - 'SHELL': '/bin/bash', 14:08:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uFuRCxXUHc/Listeners', 14:08:48 INFO - 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/', 14:08:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:08:48 INFO - 'USER': 'cltbld', 14:08:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:08:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:08:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:08:48 INFO - 'XPC_FLAGS': '0x0', 14:08:48 INFO - 'XPC_SERVICE_NAME': '0', 14:08:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:08:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:08:49 INFO - Downloading/unpacking psutil>=3.1.1 14:08: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 14:08: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 14:08: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 14:08: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 14:08: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 14:08: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 14:08:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:08:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:08:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:08:52 INFO - Installing collected packages: psutil 14:08:52 INFO - Running setup.py install for psutil 14:08:52 INFO - building 'psutil._psutil_osx' extension 14:08:52 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 14:08:52 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 14:08:52 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 14:08:52 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 14:08:52 INFO - building 'psutil._psutil_posix' extension 14:08:52 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 14:08:52 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 14:08:52 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 14:08:52 INFO - ^ 14:08:52 INFO - 1 warning generated. 14:08:52 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 14:08:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:08:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:08:52 INFO - Successfully installed psutil 14:08:52 INFO - Cleaning up... 14:08:53 INFO - Return code: 0 14:08:53 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:08:53 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')]} 14:08:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:08:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:08:53 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')]} 14:08:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:08:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:08:53 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 0x1012df490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101255570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fecdac805a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1010f3d30>, '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 0x100f59db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1010ebb20>, '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.8YC63bzea8/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.uFuRCxXUHc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/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 14:08:53 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 14:08:53 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 14:08:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8YC63bzea8/Render', 14:08:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:08:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:08:53 INFO - 'HOME': '/Users/cltbld', 14:08:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:08:53 INFO - 'LOGNAME': 'cltbld', 14:08:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:08:53 INFO - 'MOZ_NO_REMOTE': '1', 14:08:53 INFO - 'NO_EM_RESTART': '1', 14:08:53 INFO - 'PAGER': '/bin/cat', 14:08:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:08:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:08:53 INFO - 'PWD': '/builds/slave/test', 14:08:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:08:53 INFO - 'SHELL': '/bin/bash', 14:08:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uFuRCxXUHc/Listeners', 14:08:53 INFO - 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/', 14:08:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:08:53 INFO - 'USER': 'cltbld', 14:08:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:08:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:08:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:08:53 INFO - 'XPC_FLAGS': '0x0', 14:08:53 INFO - 'XPC_SERVICE_NAME': '0', 14:08:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:08:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:08:53 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:08:53 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 14:08:53 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 14:08:53 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 14:08:53 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 14:08:53 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 14:08:53 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 14:08:55 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:08:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:08:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:08:55 INFO - Installing collected packages: mozsystemmonitor 14:08:55 INFO - Running setup.py install for mozsystemmonitor 14:08:56 INFO - Successfully installed mozsystemmonitor 14:08:56 INFO - Cleaning up... 14:08:56 INFO - Return code: 0 14:08:56 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:08:56 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')]} 14:08:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:08:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:08:56 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')]} 14:08:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:08:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:08:56 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 0x1012df490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101255570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fecdac805a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1010f3d30>, '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 0x100f59db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1010ebb20>, '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.8YC63bzea8/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.uFuRCxXUHc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/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 14:08:56 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 14:08:56 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 14:08:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8YC63bzea8/Render', 14:08:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:08:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:08:56 INFO - 'HOME': '/Users/cltbld', 14:08:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:08:56 INFO - 'LOGNAME': 'cltbld', 14:08:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:08:56 INFO - 'MOZ_NO_REMOTE': '1', 14:08:56 INFO - 'NO_EM_RESTART': '1', 14:08:56 INFO - 'PAGER': '/bin/cat', 14:08:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:08:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:08:56 INFO - 'PWD': '/builds/slave/test', 14:08:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:08:56 INFO - 'SHELL': '/bin/bash', 14:08:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uFuRCxXUHc/Listeners', 14:08:56 INFO - 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/', 14:08:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:08:56 INFO - 'USER': 'cltbld', 14:08:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:08:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:08:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:08:56 INFO - 'XPC_FLAGS': '0x0', 14:08:56 INFO - 'XPC_SERVICE_NAME': '0', 14:08:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:08:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:08:56 INFO - Downloading/unpacking jsonschema==2.5.1 14:08:56 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 14:08:56 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 14:08:56 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 14:08:56 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 14:08:56 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 14:08:56 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 14:08:58 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:08:58 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:08:58 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 14:08:58 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 14:08:58 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 14:08:58 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 14:08:58 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 14:08:58 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 14:08:59 INFO - Downloading functools32-3.2.3-2.tar.gz 14:08:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:08:59 INFO - warning: no files found matching '*.txt' 14:08:59 INFO - no previously-included directories found matching 'build' 14:08:59 INFO - no previously-included directories found matching 'dist' 14:08:59 INFO - no previously-included directories found matching '.git*' 14:08:59 INFO - Installing collected packages: jsonschema, functools32 14:08:59 INFO - Running setup.py install for functools32 14:08:59 INFO - warning: no files found matching '*.txt' 14:08:59 INFO - no previously-included directories found matching 'build' 14:08:59 INFO - no previously-included directories found matching 'dist' 14:08:59 INFO - no previously-included directories found matching '.git*' 14:08:59 INFO - Successfully installed jsonschema functools32 14:08:59 INFO - Cleaning up... 14:08:59 INFO - Return code: 0 14:08:59 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 14:08:59 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')]} 14:08:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:08:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:08:59 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')]} 14:08:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:08:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:08:59 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 0x1012df490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101255570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fecdac805a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1010f3d30>, '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 0x100f59db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1010ebb20>, '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.8YC63bzea8/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.uFuRCxXUHc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/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 14:08:59 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 14:08:59 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 14:08:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8YC63bzea8/Render', 14:08:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:08:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:08:59 INFO - 'HOME': '/Users/cltbld', 14:08:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:08:59 INFO - 'LOGNAME': 'cltbld', 14:08:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:08:59 INFO - 'MOZ_NO_REMOTE': '1', 14:08:59 INFO - 'NO_EM_RESTART': '1', 14:08:59 INFO - 'PAGER': '/bin/cat', 14:08:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:08:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:08:59 INFO - 'PWD': '/builds/slave/test', 14:08:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:08:59 INFO - 'SHELL': '/bin/bash', 14:08:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uFuRCxXUHc/Listeners', 14:08:59 INFO - 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/', 14:08:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:08:59 INFO - 'USER': 'cltbld', 14:08:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:08:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:08:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:08:59 INFO - 'XPC_FLAGS': '0x0', 14:08:59 INFO - 'XPC_SERVICE_NAME': '0', 14:08:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:08:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:08:59 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 14:08:59 INFO - Cleaning up... 14:08:59 INFO - Return code: 0 14:08:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:08:59 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')]} 14:08:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:08:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:08:59 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')]} 14:08:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:08:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:08:59 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 0x1012df490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101255570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fecdac805a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1010f3d30>, '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 0x100f59db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1010ebb20>, '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.8YC63bzea8/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.uFuRCxXUHc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/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 14:08:59 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 14:08:59 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 14:08:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8YC63bzea8/Render', 14:08:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:08:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:08:59 INFO - 'HOME': '/Users/cltbld', 14:08:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:08:59 INFO - 'LOGNAME': 'cltbld', 14:08:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:08:59 INFO - 'MOZ_NO_REMOTE': '1', 14:08:59 INFO - 'NO_EM_RESTART': '1', 14:08:59 INFO - 'PAGER': '/bin/cat', 14:08:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:08:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:08:59 INFO - 'PWD': '/builds/slave/test', 14:08:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:08:59 INFO - 'SHELL': '/bin/bash', 14:08:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uFuRCxXUHc/Listeners', 14:08:59 INFO - 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/', 14:08:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:08:59 INFO - 'USER': 'cltbld', 14:08:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:08:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:08:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:08:59 INFO - 'XPC_FLAGS': '0x0', 14:08:59 INFO - 'XPC_SERVICE_NAME': '0', 14:08:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:09:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:09:00 INFO - Downloading/unpacking blobuploader==1.2.4 14:09:00 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 14:09:00 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 14:09:00 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 14:09:00 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 14:09:00 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 14:09:00 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 14:09:02 INFO - Downloading blobuploader-1.2.4.tar.gz 14:09:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:09:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:09:02 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 14:09:02 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 14:09:02 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 14:09:02 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 14:09:02 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 14:09:02 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 14:09:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:09:03 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:09:03 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 14:09:03 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 14:09:03 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 14:09:03 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 14:09:03 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 14:09:03 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 14:09:03 INFO - Downloading docopt-0.6.1.tar.gz 14:09:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:09:03 INFO - Installing collected packages: blobuploader, requests, docopt 14:09:03 INFO - Running setup.py install for blobuploader 14:09:04 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:09:04 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:09:04 INFO - Running setup.py install for requests 14:09:04 INFO - Running setup.py install for docopt 14:09:04 INFO - Successfully installed blobuploader requests docopt 14:09:04 INFO - Cleaning up... 14:09:04 INFO - Return code: 0 14:09:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:09:04 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')]} 14:09:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:09:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:09:04 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')]} 14:09:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:09:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:09:04 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 0x1012df490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101255570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fecdac805a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1010f3d30>, '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 0x100f59db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1010ebb20>, '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.8YC63bzea8/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.uFuRCxXUHc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/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 14:09:04 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 14:09:04 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 14:09:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8YC63bzea8/Render', 14:09:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:09:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:09:04 INFO - 'HOME': '/Users/cltbld', 14:09:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:09:04 INFO - 'LOGNAME': 'cltbld', 14:09:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:09:04 INFO - 'MOZ_NO_REMOTE': '1', 14:09:04 INFO - 'NO_EM_RESTART': '1', 14:09:04 INFO - 'PAGER': '/bin/cat', 14:09:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:09:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:09:04 INFO - 'PWD': '/builds/slave/test', 14:09:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:09:04 INFO - 'SHELL': '/bin/bash', 14:09:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uFuRCxXUHc/Listeners', 14:09:04 INFO - 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/', 14:09:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:09:04 INFO - 'USER': 'cltbld', 14:09:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:09:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:09:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:09:04 INFO - 'XPC_FLAGS': '0x0', 14:09:04 INFO - 'XPC_SERVICE_NAME': '0', 14:09:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:09:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:09:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:09:05 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-QIxDEH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:09:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:09:05 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-RchVeG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:09:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:09:05 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-LI9YyB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:09:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:09:05 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-EQpPu0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:09:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:09:05 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-6R0di3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:09:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:09:05 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-mX18fd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:09:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:09:05 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-6CpHNg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:09:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:09:05 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-oYok3L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:09:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:09:05 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-f28mSE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:09:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:09:06 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-LMXpP9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:09:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:09:06 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-ih4SVf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:09:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:09:06 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-tiBMBv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:09:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:09:06 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-gAFRHL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:09:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:09:06 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-tn4lOF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:09:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:09:06 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-thnH8D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:09:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:09:06 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-sqdBn3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:09:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:09:06 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-dnNmvx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:09:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:09:06 INFO - Running setup.py install for manifestparser 14:09:07 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:09:07 INFO - Running setup.py install for mozcrash 14:09:07 INFO - Running setup.py install for mozdebug 14:09:07 INFO - Running setup.py install for mozdevice 14:09:07 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:09:07 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:09:07 INFO - Running setup.py install for mozfile 14:09:07 INFO - Running setup.py install for mozhttpd 14:09:07 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:09:07 INFO - Running setup.py install for mozinfo 14:09:07 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:09:07 INFO - Running setup.py install for mozInstall 14:09:08 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:09:08 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:09:08 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:09:08 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:09:08 INFO - Running setup.py install for mozleak 14:09:08 INFO - Running setup.py install for mozlog 14:09:08 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:09:08 INFO - Running setup.py install for moznetwork 14:09:08 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:09:08 INFO - Running setup.py install for mozprocess 14:09:08 INFO - Running setup.py install for mozprofile 14:09:08 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:09:08 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:09:08 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:09:08 INFO - Running setup.py install for mozrunner 14:09:09 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:09:09 INFO - Running setup.py install for mozscreenshot 14:09:09 INFO - Running setup.py install for moztest 14:09:09 INFO - Running setup.py install for mozversion 14:09:09 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:09:09 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:09:09 INFO - Cleaning up... 14:09:09 INFO - Return code: 0 14:09:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:09: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')]} 14:09:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:09:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:09: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')]} 14:09:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:09:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:09:09 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 0x1012df490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101255570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fecdac805a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1010f3d30>, '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 0x100f59db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1010ebb20>, '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.8YC63bzea8/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.uFuRCxXUHc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/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 14:09:09 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 14:09:09 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 14:09:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8YC63bzea8/Render', 14:09:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:09:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:09:09 INFO - 'HOME': '/Users/cltbld', 14:09:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:09:09 INFO - 'LOGNAME': 'cltbld', 14:09:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:09:09 INFO - 'MOZ_NO_REMOTE': '1', 14:09:09 INFO - 'NO_EM_RESTART': '1', 14:09:09 INFO - 'PAGER': '/bin/cat', 14:09:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:09:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:09:09 INFO - 'PWD': '/builds/slave/test', 14:09:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:09:09 INFO - 'SHELL': '/bin/bash', 14:09:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uFuRCxXUHc/Listeners', 14:09:09 INFO - 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/', 14:09:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:09:09 INFO - 'USER': 'cltbld', 14:09:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:09:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:09:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:09:09 INFO - 'XPC_FLAGS': '0x0', 14:09:09 INFO - 'XPC_SERVICE_NAME': '0', 14:09:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:09:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:09:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:09:09 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-Rk0bn2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:09:09 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)) 14:09:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:09:09 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-8dNnDp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:09:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:09:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:09:10 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-FoC4AT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:09:10 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)) 14:09:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:09:10 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-th5kVp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:09:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:09:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:09:10 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-QwgT2m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:09:10 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)) 14:09:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:09:10 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-yolFYF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:09:10 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)) 14:09:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:09:10 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-h6TAeU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:09:10 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)) 14:09:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:09:10 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-tAcIeB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:09:10 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)) 14:09:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:09:10 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-lmPWID-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:09:10 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)) 14:09:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:09:10 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-FYgKG_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:09:10 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)) 14:09:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:09:10 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-kP4ce3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:09:10 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)) 14:09:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:09:10 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-10pT2v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:09:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 14:09:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:09:11 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-IAo9Fg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:09:11 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)) 14:09:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:09:11 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-Bf1L2P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:09:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 14:09:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:09:11 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-fklKsW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:09:11 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)) 14:09:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:09:11 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-Po9im7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:09:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 14:09:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:09:11 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-vmFBkP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:09:11 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)) 14:09:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:09:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:09:11 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)) 14:09:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:09:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:09:11 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:09:11 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 14:09:11 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 14:09:11 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 14:09:11 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 14:09:11 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 14:09:11 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 14:09:14 INFO - Downloading blessings-1.6.tar.gz 14:09:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:09:14 INFO - Installing collected packages: blessings 14:09:14 INFO - Running setup.py install for blessings 14:09:14 INFO - Successfully installed blessings 14:09:14 INFO - Cleaning up... 14:09:14 INFO - Return code: 0 14:09:14 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:09:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:09:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:09:14 INFO - Reading from file tmpfile_stdout 14:09:14 INFO - Current package versions: 14:09:14 INFO - blessings == 1.6 14:09:14 INFO - blobuploader == 1.2.4 14:09:14 INFO - docopt == 0.6.1 14:09:14 INFO - functools32 == 3.2.3-2 14:09:14 INFO - jsonschema == 2.5.1 14:09:14 INFO - manifestparser == 1.1 14:09:14 INFO - mozInstall == 1.12 14:09:14 INFO - mozcrash == 0.17 14:09:14 INFO - mozdebug == 0.1 14:09:14 INFO - mozdevice == 0.48 14:09:14 INFO - mozfile == 1.2 14:09:14 INFO - mozhttpd == 0.7 14:09:14 INFO - mozinfo == 0.9 14:09:14 INFO - mozleak == 0.1 14:09:14 INFO - mozlog == 3.4 14:09:14 INFO - moznetwork == 0.27 14:09:14 INFO - mozprocess == 0.23 14:09:14 INFO - mozprofile == 0.28 14:09:14 INFO - mozrunner == 6.12 14:09:14 INFO - mozscreenshot == 0.1 14:09:14 INFO - mozsystemmonitor == 0.3 14:09:14 INFO - moztest == 0.7 14:09:14 INFO - mozversion == 1.4 14:09:14 INFO - psutil == 3.1.1 14:09:14 INFO - requests == 1.2.3 14:09:14 INFO - wsgiref == 0.1.2 14:09:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:09:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:09:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:09:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:09:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:09:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:09:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:09:14 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 0x1012df490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101255570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fecdac805a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1010f3d30>, '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 0x100f59db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1010ebb20>, '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.8YC63bzea8/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.uFuRCxXUHc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/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 14:09:14 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 14:09:14 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 14:09:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8YC63bzea8/Render', 14:09:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:09:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:09:14 INFO - 'HOME': '/Users/cltbld', 14:09:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:09:14 INFO - 'LOGNAME': 'cltbld', 14:09:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:09:14 INFO - 'MOZ_NO_REMOTE': '1', 14:09:14 INFO - 'NO_EM_RESTART': '1', 14:09:14 INFO - 'PAGER': '/bin/cat', 14:09:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:09:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:09:14 INFO - 'PWD': '/builds/slave/test', 14:09:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:09:14 INFO - 'SHELL': '/bin/bash', 14:09:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uFuRCxXUHc/Listeners', 14:09:14 INFO - 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/', 14:09:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:09:14 INFO - 'USER': 'cltbld', 14:09:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:09:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:09:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:09:14 INFO - 'XPC_FLAGS': '0x0', 14:09:14 INFO - 'XPC_SERVICE_NAME': '0', 14:09:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:09:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:09:15 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)) 14:09:15 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)) 14:09:15 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)) 14:09:15 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)) 14:09:15 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)) 14:09:15 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)) 14:09:15 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)) 14:09:15 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)) 14:09:15 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)) 14:09:15 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)) 14:09:15 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)) 14:09:15 INFO - Cleaning up... 14:09:15 INFO - Return code: 0 14:09:15 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:09:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:09:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:09:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:09:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:09:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:09:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:09:15 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 0x1012df490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101255570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fecdac805a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1010f3d30>, '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 0x100f59db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1010ebb20>, '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.8YC63bzea8/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.uFuRCxXUHc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/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 14:09:15 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 14:09:15 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 14:09:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8YC63bzea8/Render', 14:09:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:09:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:09:15 INFO - 'HOME': '/Users/cltbld', 14:09:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:09:15 INFO - 'LOGNAME': 'cltbld', 14:09:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:09:15 INFO - 'MOZ_NO_REMOTE': '1', 14:09:15 INFO - 'NO_EM_RESTART': '1', 14:09:15 INFO - 'PAGER': '/bin/cat', 14:09:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:09:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:09:15 INFO - 'PWD': '/builds/slave/test', 14:09:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:09:15 INFO - 'SHELL': '/bin/bash', 14:09:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uFuRCxXUHc/Listeners', 14:09:15 INFO - 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/', 14:09:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:09:15 INFO - 'USER': 'cltbld', 14:09:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:09:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:09:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:09:15 INFO - 'XPC_FLAGS': '0x0', 14:09:15 INFO - 'XPC_SERVICE_NAME': '0', 14:09:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:09:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:09:15 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:09:15 INFO - Cleaning up... 14:09:15 INFO - Return code: 0 14:09:15 INFO - Running post-action listener: _resource_record_post_action 14:09:15 INFO - Running post-action listener: _start_resource_monitoring 14:09:15 INFO - Starting resource monitoring. 14:09:15 INFO - [mozharness: 2016-10-26 21:09:15.529790Z] Finished create-virtualenv step (success) 14:09:15 INFO - [mozharness: 2016-10-26 21:09:15.530765Z] Running install step. 14:09:15 INFO - Running pre-action listener: _resource_record_pre_action 14:09:15 INFO - Running main action method: install 14:09:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:09:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:09:15 INFO - Reading from file tmpfile_stdout 14:09:15 INFO - Detecting whether we're running mozinstall >=1.0... 14:09:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:09:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:09:15 INFO - Reading from file tmpfile_stdout 14:09:15 INFO - Output received: 14:09:15 INFO - Usage: mozinstall [options] installer 14:09:15 INFO - Options: 14:09:15 INFO - -h, --help show this help message and exit 14:09:15 INFO - -d DEST, --destination=DEST 14:09:15 INFO - Directory to install application into. [default: 14:09:15 INFO - "/builds/slave/test"] 14:09:15 INFO - --app=APP Application being installed. [default: firefox] 14:09:15 INFO - mkdir: /builds/slave/test/build/application 14:09:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 14:09:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 14:09:48 INFO - Reading from file tmpfile_stdout 14:09:48 INFO - Output received: 14:09:48 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 14:09:48 INFO - Running post-action listener: _resource_record_post_action 14:09:48 INFO - [mozharness: 2016-10-26 21:09:48.370891Z] Finished install step (success) 14:09:48 INFO - [mozharness: 2016-10-26 21:09:48.371055Z] Running run-tests step. 14:09:48 INFO - Running pre-action listener: _resource_record_pre_action 14:09:48 INFO - Running main action method: run_tests 14:09:48 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:09:48 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:09:48 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:09:48 INFO - 2016-10-26 14:09:48.385 screenresolution[1960:64776] starting screenresolution argv=screenresolution get 14:09:48 INFO - 2016-10-26 14:09:48.388 screenresolution[1960:64776] Display 0: 1600x1200x32@60 14:09:48 INFO - 2016-10-26 14:09:48.394 screenresolution[1961:64779] starting screenresolution argv=screenresolution list 14:09:48 INFO - Available Modes on Display 0 14:09:48 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:09:48 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:09:48 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:09:48 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:09:48 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:09:48 INFO - Intel Iris: 14:09:48 INFO - Chipset Model: Intel Iris 14:09:48 INFO - Type: GPU 14:09:48 INFO - Bus: Built-In 14:09:48 INFO - VRAM (Dynamic, Max): 1536 MB 14:09:48 INFO - Vendor: Intel (0x8086) 14:09:48 INFO - Device ID: 0x0a2e 14:09:48 INFO - Revision ID: 0x0009 14:09:48 INFO - Displays: 14:09:48 INFO - Display: 14:09:48 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:09:48 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:09:48 INFO - Display Serial Number: 1600x1200 60 14:09:48 INFO - Main Display: Yes 14:09:48 INFO - Mirror: Off 14:09:48 INFO - Online: Yes 14:09:48 INFO - Rotation: Supported 14:09:48 INFO - Return code: 0 14:09:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:09:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:09:48 INFO - Python 2.7.3 14:09:48 INFO - Return code: 0 14:09:48 INFO - grabbing minidump binary from tooltool 14:09:48 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')]} 14:09:48 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 0x1010f3d30>, '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 0x100f59db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1010ebb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:09:48 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 14:09:48 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 14:09:48 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 14:09:48 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:09:48 INFO - Return code: 0 14:09:48 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 14:09:48 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:09:48 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:09:48 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 14:09:48 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:09:48 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/B80AX5jXRCOwcCWqBAhbJg/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0026', '--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 14:09:48 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/B80AX5jXRCOwcCWqBAhbJg/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0026 --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 14:09:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8YC63bzea8/Render', 14:09:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:09:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:09:48 INFO - 'HOME': '/Users/cltbld', 14:09:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:09:48 INFO - 'LOGNAME': 'cltbld', 14:09:48 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:09:48 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 14:09:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:09:48 INFO - 'MOZ_NO_REMOTE': '1', 14:09:48 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:09:48 INFO - 'NO_EM_RESTART': '1', 14:09:48 INFO - 'PAGER': '/bin/cat', 14:09:48 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:09:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:09:48 INFO - 'PWD': '/builds/slave/test', 14:09:48 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:09:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:09:48 INFO - 'SHELL': '/bin/bash', 14:09:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uFuRCxXUHc/Listeners', 14:09:48 INFO - 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/', 14:09:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:09:48 INFO - 'USER': 'cltbld', 14:09:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:09:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:09:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:09:48 INFO - 'XPC_FLAGS': '0x0', 14:09:48 INFO - 'XPC_SERVICE_NAME': '0', 14:09:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:09:48 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/B80AX5jXRCOwcCWqBAhbJg/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0026', '--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 14:09:48 INFO - mozversion application_buildid: 20161010141523 14:09:48 INFO - mozversion application_changeset: 6031d730c46ae3b3db353a8d35c99e82117f6479 14:09:48 INFO - mozversion application_display_name: FirefoxDeveloperEdition 14:09:48 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:09:48 INFO - mozversion application_name: Firefox 14:09:48 INFO - mozversion application_remotingname: firefox-dev 14:09:48 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 14:09:48 INFO - mozversion application_vendor: Mozilla 14:09:48 INFO - mozversion application_version: 51.0a2 14:09:48 INFO - mozversion platform_buildid: 20161010141523 14:09:48 INFO - mozversion platform_changeset: 6031d730c46ae3b3db353a8d35c99e82117f6479 14:09:48 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 14:09:48 INFO - mozversion platform_version: 51.0a2 14:09:48 INFO - using testdate: 1477516188 14:09:48 INFO - actual date: 1477516188 14:09:48 INFO - starting webserver on 'localhost:50872' 14:09:48 INFO - SUITE-START | Running 2 tests 14:09:48 INFO - TEST-START | dromaeo_css 14:09:48 INFO - operating with platform_type : mac_ 14:09:48 INFO - Initialising browser for dromaeo_css test... 14:09:48 INFO - TEST-INFO | started process 1971 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/tmpwYJJn3/profile http://localhost:50872/getInfo.html) 14:09:51 INFO - PROCESS | 1971 | __metrics Screen width/height:1600/1200 14:09:51 INFO - PROCESS | 1971 | colorDepth:24 14:09:51 INFO - PROCESS | 1971 | Browser inner width/height: 1024/689 14:09:51 INFO - PROCESS | 1971 | __metrics 14:09:51 INFO - PROCESS | 1971 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 14:09:51 INFO - PROCESS | 1971 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:09:52 INFO - TEST-INFO | 1971: exit 0 14:09:52 INFO - Browser initialized. 14:09:52 INFO - Running cycle 1/1 for dromaeo_css test... 14:09:52 INFO - TEST-INFO | started process 1973 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/tmpwYJJn3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:10:04 INFO - PROCESS | 1973 | RSS: Main: 219086848 14:10:04 INFO - PROCESS | 1973 | 14:10:56 INFO - PROCESS | 1973 | 1477516256085 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 14:13:07 INFO - PROCESS | 1973 | Cycle 1(1): loaded http://localhost:50872/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50872/tests/dromaeo/cssquery-ext.html) 14:13:08 INFO - PROCESS | 1973 | RSS: Main: 325586944 14:13:08 INFO - PROCESS | 1973 | 14:16:11 INFO - PROCESS | 1973 | Cycle 1(1): loaded http://localhost:50872/tests/dromaeo/cssquery-ext.html (next: http://localhost:50872/tests/dromaeo/cssquery-jquery.html) 14:16:12 INFO - PROCESS | 1973 | RSS: Main: 349822976 14:16:12 INFO - PROCESS | 1973 | 14:19:14 INFO - PROCESS | 1973 | Cycle 1(1): loaded http://localhost:50872/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50872/tests/dromaeo/cssquery-mootools.html) 14:19:15 INFO - PROCESS | 1973 | RSS: Main: 349347840 14:19:15 INFO - PROCESS | 1973 | 14:22:17 INFO - PROCESS | 1973 | Cycle 1(1): loaded http://localhost:50872/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50872/tests/dromaeo/cssquery-prototype.html) 14:22:17 INFO - PROCESS | 1973 | RSS: Main: 322015232 14:22:17 INFO - PROCESS | 1973 | 14:25:21 INFO - PROCESS | 1973 | Cycle 1(1): loaded http://localhost:50872/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50872/tests/dromaeo/cssquery-yui.html) 14:25:21 INFO - PROCESS | 1973 | RSS: Main: 313753600 14:25:21 INFO - PROCESS | 1973 | 14:28:25 INFO - PROCESS | 1973 | Cycle 1(1): loaded http://localhost:50872/tests/dromaeo/cssquery-yui.html (next: http://localhost:50872/tests/dromaeo/cssquery-dojo.html) 14:28:25 INFO - PROCESS | 1973 | RSS: Main: 360095744 14:28:25 INFO - PROCESS | 1973 | 14:28:25 INFO - PROCESS | 1973 | __start_tp_report 14:28:25 INFO - PROCESS | 1973 | _x_x_mozilla_page_load 14:28:25 INFO - PROCESS | 1973 | _x_x_mozilla_page_load_details 14:28:25 INFO - PROCESS | 1973 | |i|pagename|runs| 14:28:25 INFO - PROCESS | 1973 | |0;dojo.html;2813.2966758310417;3300.521424393463;3305.074579117848;3342.2312868040335;3354.09439451348;5657.688827114507;5716.428357164282;5716.685582292972;5737.827865164052;5805.3323867755225;5677.744501497432;5777.653340799555;5779.913301300473;5796.449337312949;5811.418858114197;5241.371035475749;5256.894862102756;5260.658057226287;5272.499112584298;5331.306930099082;5193.5325820676135;5203.687778733288;5228.633995620308;5242.659227150242;5272.446393128724;5317.9468205318035;5320.866978325554;5326.840194794162;5329.866753331159;5369.570434365241;5306.336707911511;5311.601629877775;5320.334958130234;5320.787168513255;5379.838604841861;5128.897422051576;5133.743312834344;5181.766820493087;5256.448072952323;5261.394939581921;5560.582956278296;5651.378348381675;5749.770009199627;5751.252337196138;5855.326637436707;6198.163247961513;6260.217472815898;6275.058741188813;6310.589811662273;6328.588641738273;6217.533684973645;6262.968685156545;6318.936810631881;6324.462420694246;6332.176817013758;5642.435756424325;5716.942830571724;5736.541076713853;5746.166805813175;5777.7977770777825;6266.122742816009;6278.843028924313;6283.183186185766;6299.370062993756;6308;5535.6955367455175;5856.238688970492;6191.996881512463;6227.813165605039;6239.188905442355;6127.80043271483;6190.442860142609;6193.628382297076;6267.341929097379;6296.5592408531875;6253.874922501524;6270.7491700331475;6281.403266689657;6290.654014029181;6291.496680265568;6135.355787642323;6279.497640188774;6297;6299.7795077173;6321.1782468278825;4854.563089321978;4911.607071434277;4913.410390753133;4925.827596034122;4988.7505624718615;3745.3632882410056;4446.688731788744;4452.821887124479;4505.909881802346;4524.049949510574;5818.8254352369495;5839.065749480063;5865.155220416539;5869.236999190078;5898.705064746746;5719.741656835489;5824.213731146241;6242.032484964838;6275.278342990615;6280.811575652647;4789.976050119797;5738.08190689496;5820.708964551755;5837.153612726216;5913.940860591339;5403.054465468527;5430.891382172414;5435.918461223085;5442.673439593558;5449.209864569694;6379.96810015947;6400.871982560323;6409.423151916257;6416.037594360883;6423.743050277936;6162.414570615784;6183.5671502994355;6233.5636505446;6285.120083188266;6310.6844657766005;6390.9041364378645;6413;6414.486841052611;6416.069669897745;6437.356264373712;6242.469390101892;6268.091126786681;6278.497720182466;6289.49684025286;6291.6539590321145;6133.080037994337;6168.753249870135;6172.629642221481;6204.441600255998;6254.874902502015;6195.566310358232;6210.068489726577;6215.12988181664;6223.937760622517;6243.313235544178;5185.662931909414;5946.375630558902;5959.225300711053;6000.909986350295;6208.627482351073;5817.912731308949;5920.555958303058;5930.140129681085;5950.851228719317;6019.187409699634;6045.0327947528185;6120.0205129226715;6144.955357589131;6199.256089269316;6203.193584833943;5814.5639077068545;6069.423404776539;6070.484008859296;6074.3318234994995;6076.240469941257 14:28:25 INFO - PROCESS | 1973 | |1;ext.html;500.6445423749138;512.9589632829374;520.4977197004889;526.6576725128666;543.9420327463084;30814.921477748285;39719.40420893689;41820.163596728045;41852.372214416806;41976.58023419765;43343.566564334425;43861.90345241362;43875.56124438754;43897.34153987693;44061.7796911015;9709.95145024274;9912.90087099127;9916.90083099167;9924.305298629099;9938.006199380077;8790.648374065062;9028.548572571379;9034.909650903473;9129.315301352424;9148.771280718001;11907.821382679267;12207.328596927166;12213.145079844415;12354.135210535222;12385;12228.144029917908;12236.388180590979;12250.938745306306;12257.816132758016;12261.632151035394;8676.566171691453;8953.283737301066;11933;12017.218880772722;12034.69913252167;40177.598224017675;40243.99390015273;40247.19505609901;42068.579314207076;42073.78963105196;3262.755293352984;3277.655846136169;3290.3748287825238;3325.6341802401716;3342.649021852719;28828;30619.38761224763;32090.679093209237;32200.355992880246;32528.837355813306;3122.0275840202953;3215.3087086276328;3218.806871587689;3281.212508997847;3293.6212335581477;501899;508670;508963;509461;510467.447662763;61782.38217617766;63455.36544634494;64053.67973160197;64093.35906640874;64102;66933.66533167304;67096;67103.66448167728;67140.66429667821;67206.66396667986;16678.749818752727;16950.15249237533;16951.067691277098;16964.236609352607;16985.745213821803;12812.359382030862;12816.102872799001;13108.2135071896;13129.474821007243;13137.540186093442;16950.576235593962;17243.310267589408;17305.221265043103;17741.90456105382;19426.4172074838;6040.154378387029;7009.2990700929495;7142.142942846787;7284.798008328672;7679.155292917774;825.8678611422143;949.4018768176005;996.5714742660581;1035.5288343803702;1037.7613148975777;30111.397772044438;30692;30820.537691934638;31216;31466.842665786524;974.8983648477317;1063.2079101069753;1138.4592318648577;1152.4468255237532;1156.2888823373564;14744.705105897821;15948.362065517482;15997.28012239452;16090;16186.514404567883;660517;668682;669231;669258;671610;51595;58265.41734582685;59004.40995589989;59120.40879591235;59145;1145.9427028648702;1245.701031752373;1281.7500587385557;1372.766629672958;1398.2519352146553;24487.38781530476;29387.559186612645;30579.388412231187;30816.383672326876;30875;49254.75372623114;49872.75318116931;49969.25046124238;50045.749771250914;50049;513084;514352;515140;515142;675949;33987.4901876477;40784;41488.585114148475;41754.16491670089;42180.73457796271;46033;46067.92694328696;46498.30252546147;46575.76712116553;46797.2980405301;31564.526532101576;35927.28145437129;38471.03822404462;38538.421923670605;39096.80451597837;37037.62962370342;37154.88535343944;38336.616633833306;39288.803555982035;39292.82121536358;37652.246955060196;37894.62105378911;38215.61784382121;38356.42465363078;38406.039849003995;32954.67045329516;34129.31741365208;34843.30313393768;34968.475472867416;35021.29957400787;25375.305568469154;25375.98496060137;25551;25918.481630367663;26138.73861261363 14:28:25 INFO - PROCESS | 1973 | |2;jquery.html;346.2400031929915;371.8735629885839;373.24790547047706;384.69993405143987;400.96591789697874;15160.469383571577;15589.986650867686;16779.24493397797;20625.896870515662;21512.8924355378;20292.695609565868;20394;20995.160193592237;21024;21264.4683882903;4439.689221754463;5247.816326428576;5465.289512363387;5467.234587157801;5480.945190548104;5947.821565353046;6146.877062458748;6163.137160797492;6173.506119510451;6214.9378506215035;5843.094320380348;6075.878482430348;6147.385261473839;6154.169187159743;6161.414665606782;6135.294441139259;6156.7845125420845;6158.199434073586;6173.876522469571;6179.289381721114;5683.886322273573;5816.505597024258;5900.97049514754;5901.02633065548;5903.055511118243;13466.451358093847;13472.663183420394;13528.323583820867;13655.180689158582;13718.17690938547;1960.9901950490157;2239.7648246934164;2241.8766967816764;2273.9658905116435;2342.2973108067513;9745.756356091084;9817.90182098177;9828.361156524874;10077.798444031077;10302.9484852576;1838.0258463014623;1846.9722954155698;1855.9536011599682;1921.327535362626;1924.9903750481299;123367;124173;130837.34581327127;132714.3364283182;132716;11061.391623460626;11277.830832537518;11332.546698132148;11652.883471165349;11720.355380453986;14897;14908.180050097131;14910.70178596422;14922;14968.101913885203;8573.914260857437;8675.6529738811;8695.73912782605;8763.605637746317;8850.557472126367;8662;8683.739487815375;8703.47779133254;8814.118588141262;8871.733847984571;3762.9435558466644;4575.679702420799;4583.839565615188;4588.0135770808765;4657.231556793091;1856.6565185440736;1923.3268356075262;1926.6435709393807;1929.2668785861563;1931.2564662604998;375.0941476334621;381.6450700848238;393.9054626889526;819.6762278899802;905.0496978172893;11561.479733412016;11676.007539359249;11798.941005294919;11879.406029698654;12189.634310970509;419.6537856268591;426.7013090836427;427.3589615576635;430.9245881970643;455.81995111930604;5968.791092311748;6066.181065556093;6083.239595050619;6084.574079814459;6161.383861613893;233708;234101;534173;602100;617431.912840433;77973;81606;103859.480702596;134060;137182.31408842892;425.11788039817503;438.2440290498928;441.56946976697463;442.54860042756206;444.2048732768373;11296.887031129583;11346.205765596329;11379.203455758017;11520.251183673034;11820;39461.80269098636;50842;51910.22134667908;53197;55644.721776390856;72752.27247727456;73683;75390.62304688442;77485.61257193904;79975;6825.761098361533;7913.406494513049;8165.673373065011;8205.138460461565;8539.975202975435;8979.033955713483;13089.41097650589;13265.33673316311;13540.458381665017;13617.387217575431;11203.047740942111;11402.714932126431;11441.42792860337;11446.885531144582;11483.8277425837;10918.672439826818;10936.070434013198;11227.55089796399;11322.490487927898;11452.312861228353;11418.200725949104;11462.94268528652;11533.308001519936;12042.21725587834;12130.968867646348;7882.172371901097;7908.327792137503;8113.148119447609;8195.180481951757;8526.82946341082;8181.100078991425;8964.103589640983;10432;10950.288231264942;11075.889241107809 14:28:25 INFO - PROCESS | 1973 | |3;mootools.html;1367.8358596968365;1521.193767303329;1543.020182184313;1740.6692728381606;1911.942641720748;7643.885341719864;7765.9611701941485;8270.834583308339;8596.828063438736;8918.152775486318;8762.167594078568;8857;8860.512671803048;8876.289896808255;8879.023307436193;2354.776296251853;2387.6537902004197;2389.474315650554;2390.8206884483648;2392.9042838286446;2350.1891847312736;2374.7269064057596;2386.7493913139133;2388.199953015733;2394.38943069517;2351.1770880191966;2355.1639168095335;2375.560521303564;2375.6911601491784;2380.262118743195;2324.2910912171783;2358.8820558971984;2359;2361.89371478283;2378.2746262389965;2306.953860922772;2337.5208082343247;2339.812814974798;2344.15610380263;2354.976450235493;8659.610317535726;8781.692640757543;8815.986161591434;8910.465372077631;8914.955425222832;5263;5481.342238931314;5488.341399032101;5491.28613280271;5507.394186639466;3596.766210196355;3632.382494975834;3635.3092912346833;3710.7959062251566;3717.7583457075475;1071.769569542552;1074.5809134437575;1075.4568942683973;1096.2052511928869;1099.5272033025797;9874.456904870229;11616.244944078608;11684.707882302926;11776.352300623548;11776.764464710743;3645.434957581579;4499.887502812456;4691.311127993919;4702.200625893606;4704.553067458654;8985.146411090936;9128.995810460843;9130.995590485041;9134.269258459308;9146.90853091474;5256.237845512379;5257.8159764408065;5262.60530460217;5263.289455923401;5266.631335806534;4163.854265100767;4419.9337009944875;4559.361689363492;4574.153781550423;4930.926036109461;3185.2036990752313;3825.827837747308;3875.6047822783776;3888.3389823730035;3894.299026175259;1161.2045748662194;1170.1574866096396;1174.988250117505;1186.7745128425745;1187.703074231442;833.4124442268186;900.7838118851429;908.4004556992486;924.9722508324761;929.1962452478557;5722.77108915647;5763.827085187451;5958.285005799332;6089.8477538061015;6194.876102477925;433.3369943985707;435.4252386849328;454.8877993306334;458.5849805925576;461.87529367070704;3980.283548961157;3983.5418926823786;3998.960010399917;4008.6793056555407;4031.113155105872;8314.293285070837;10527.789444211074;10879.728006799734;10898.67303980866;10942.617008404668;10795.6221532246;10841.620543280947;10845.07816835562;10851.945740271405;10877.0754485868;7879.527228366316;8188.549629770419;8242.546659933641;8282.420230583923;8296.543690096982;5900.1149827526215;6008.759649613967;6076.118962750465;6132.202813634378;6141.662208578392;10133.39199647994;10213.693589192337;10300.124489418184;10311.690649280534;10330.380177189392;9282.907170928474;9968.800623987625;10382.896171038194;10427.374357538572;10559.366438013743;6200.875982480416;7597.886031709419;7605.277498637621;7692.8461430772195;7718.382529397747;8298.958505207434;8311.127331630092;8321.292690121407;8368.539730314891;8420.410571259952;7492.737754178577;7510.511816731895;7538.434617403607;7558.395328373607;7567.621618919142;7309.890351644836;7323.2676732326345;7382.593957332183;7385;7491.175970643116;7005.719771209298;7010.298970102949;7072.328128827753;7087.893681594884;7109.680064397218;4883.413990321184;4906.901861962812;4954.752262386938;5098;5212.791488340424;4857.781399837087;4964.304997300309;4977.4524802271;5014.648974571745;5177.378714554277 14:28:25 INFO - PROCESS | 1973 | |4;prototype.html;279.4285685772595;296.79521130419994;305.16993776926756;307.3668243418558;310.92537790930186;5170.819021334254;5180.2488639147305;5251.816186433471;5285.339332583427;5289.206619007151;4857.465678775341;4871.683340582868;4998.5501304882555;5057.342545469084;5130.410002849673;3378.2567835076306;4004.6395824375945;4005.8798236052967;4020.517537895457;4047.7571345719202;3357.2949680567112;4048.696347773914;4054.2702313583545;4068.9186216275657;4116.053307739222;3367.326534693071;3604.4953706481115;3956;3979.9204015919663;3999.760014399131;3427.3316703242876;3963.3155908738813;3972.463717398143;3972.483577134983;4011.495689116581;3062.892798752033;3271.705546500826;3335.93328133436;3397.2186397128553;3507.5790905091553;4897.559219670211;4997.575206107485;5053.646244762868;5058.898822023539;5077.771500282496;3970.4441378207075;4428.579284967923;4479.843205487792;4529.569690879362;4537.909241815179;5093.363329583802;5341;5359.464053594648;5376.096907669854;5384.7846086156505;3153.290509635314;3356.9328613427597;3599.218386898502;3836.501254836853;3846.2692088503095;4625.9360347120355;5344.4922732340365;5615.775368985195;5624.831255062355;5629.634073785191;3888.7861167635488;3895.7533589251734;3906.4140378942816;3907.492026036597;3921.098147426108;3981.1838573092446;3984.0438294809614;3988.706493766096;3995.220931918248;4014.3175660137845;4373.234683930299;4399.274119770266;4509.233430316854;4539.16025535277;4557.316402539645;4717.8348757794;4883.340748998839;5142.794288228429;5395.543203335156;5449.373322067933;1113.5267511307661;1356.132075471699;1358.6807100331414;1360.2586590308306;1360.6734383748028;858.3390789092364;887.4187407248133;893.6112790935964;903.8734577159203;924.3915586878917;4679.602233810097;5105.310783044316;5127.128388174019;5132.717700526507;5184.94088487794;5017.648764586517;5061.97520991599;5503.284573005483;5534.612577119563;5580.581456390787;4491.505934347219;4872.731999739977;5005.299258103868;5071.46749591295;5076.796928122908;2424;2536.619507073917;2776.236534952904;2888.4511942730815;2973;4885.845433068076;5548.528375088082;5661.575381846378;5674.751554657969;5682.715864206773;4864.270359446041;5324;5607.523360514402;5658.264425624642;5660.518855897212;5650.276665617026;5665.5750818689585;5672.744726487318;5673.716314184357;5696.3164420269;5175.9741201295255;5482.39693633692;5483.300176945159;5484.696427500379;5504.4495550444635;5424.566034717134;5436.836894893001;5441.374241962225;5453.345598528202;5456.590755693418;4610.815567377267;5104.69371837691;5218.356217791384;5666.688332141772;5672.496788351008;3126.421612001787;3834.7123965702126;3845.442595748726;3855.63371479709;3883.3107598194874;4314.54697256796;5456.026465576349;5481.671099734029;5491.611149149972;5515.61390702647;4927.841957140141;5141.66054445219;5330.626856120034;5377.435369286325;5410.702411367412;4159.729617574969;5027.974860125676;5309.814156504503;5310;5335.839924802262;3680.7975561344383;4386.846460373871;4754.97767979886;5179.689218646893;5280.551153152025;5293.735313234246;5355.892882142413;5374.274472946102;5462.808801691922;5475.808346707846;5057.8229761958155;5301.284326616012;5318.680879147263;5331.70675612845;5338.733063346895 14:28:25 INFO - PROCESS | 1973 | |5;yui.html;760.8326168242986;762.2225330163234;762.7406681728211;772.5017363800349;805.9597020148998;15749.606259843495;15760.76358854618;16998;17267.481975540722;17268;16256.918715406406;16450.506484805446;16473.588160296;16507.33970641176;16601.584960375996;669.5547460938494;691.5850489706187;832.6877420967122;849.133883438892;851.0808327006848;685.6743047052635;817.6443247187492;832.6835802395082;842.1452225990624;844.1895780051158;884.5135175653397;885.5173930208019;886.3706768194589;887.4586502233632;887.7159309021116;696.5437638346891;752.135044698601;878.4685265414428;878.7495563764328;883.7525492862009;529.9708516031617;531.7739960516803;532.0556013076781;532.8907573947331;634.3054355480741;15139.54581362561;15536.223188840513;15561.37754489819;15577.221138943007;15591.45429909959;13616.523421680193;13711;13747.518836840663;13772.724545509034;13995.30023498821;12373.752524949541;12615.306158161298;12747.936260318731;12748.908926423373;13161.473541058442;4513.1650644630845;4550.317452382136;4640.262479493811;4677.602403795681;4776.188048031843;125307;129166.70833291735;132277;133092.99999999904;135861;9656.806863862683;10485.213608979357;10616.946915265375;10800.837987430195;10919.508622112024;21016.26443074485;21277.46806329854;21339.46651333698;21375.358739237847;21786.019629116727;8097.554634495159;8222.465539739898;8224;8260.545669988209;8261.13258107902;4406.757628330409;4445.355423463579;4560.840370587013;4691.319758635047;4705.270683044134;3644.927101457956;3773.2453509298252;3795.4306853971575;3796.52543432071;3800.467934489174;677.9288174741581;683.361057411322;686.0943554508002;695.124143579094;702.0767690486994;567.6083502383342;583.3491219847905;641.8077750994385;684.8082536889679;699.867025265198;8097.878531822027;9210.907890921006;9394.107559781809;9526.237900967906;9706.75733106678;551.6910530103155;612.7377602139518;670.5574320948151;675.5035049238805;683.2450142592463;4396.494403143615;4693.296005599187;4708.364370809965;4717.834875779331;4752.809887604526;162193;162294;164020;165444;165695;107459;138259;143125.28437357745;144670;147094;119286;124830;124887.9938340657;125327;129339;8182.345412366877;8703;8985.281177505914;9022.188003079491;9201.76995575116;59328;66715.66642166759;67245.99131012941;68522.65738671274;69113.65443172753;95423;98908;102515;104402.47798760957;105656;11712.824307635221;11977.341246231541;12012.039036876855;12018.579349722717;13003.739925201255;14349.210793406462;14498.565043048726;14607.561773146823;14933;16018.519444416686;13379.063465557707;13732.313384330942;13771.311434428038;14598.854011459749;14953.77569336439;14063.859361406256;14325.011212438249;14410.495632652806;14623.34194961208;14757.409703611735;11002.834957475805;12946.935265323613;13861.584152475441;14432.494862679756;14732.77900831467;10334.328268662513;10619.893801061891;11531.365774882463;11655.067594592581;12040.698982525508;11352.659420217407;11665.825012624988;11729.237599556001;11755.353455560027;11849.940750296193 14:28:25 INFO - PROCESS | 1973 | __end_tp_report 14:28:25 INFO - PROCESS | 1973 | __start_cc_report 14:28:25 INFO - PROCESS | 1973 | _x_x_mozilla_cycle_collect,1098 14:28:25 INFO - PROCESS | 1973 | __end_cc_report 14:28:25 INFO - PROCESS | 1973 | __startTimestamp1477517305596__endTimestamp 14:28:25 INFO - PROCESS | 1973 | 14:28:25 INFO - PROCESS | 1973 | ------- Summary: start ------- 14:28:25 INFO - PROCESS | 1973 | Number of tests: 6 14:28:25 INFO - PROCESS | 1973 | 14:28:25 INFO - PROCESS | 1973 | [#0] dojo.html Cycles:165 Average:5759.10 Median:5920.56 stddev:672.81 (11.4%) stddev-sans-first:633.94 14:28:25 INFO - PROCESS | 1973 | Values: 2813.3 3300.5 3305.1 3342.2 3354.1 5657.7 5716.4 5716.7 5737.8 5805.3 5677.7 5777.7 5779.9 5796.4 5811.4 5241.4 5256.9 5260.7 5272.5 5331.3 5193.5 5203.7 5228.6 5242.7 5272.4 5317.9 5320.9 5326.8 5329.9 5369.6 5306.3 5311.6 5320.3 5320.8 5379.8 5128.9 5133.7 5181.8 5256.4 5261.4 5560.6 5651.4 5749.8 5751.3 5855.3 6198.2 6260.2 6275.1 6310.6 6328.6 6217.5 6263.0 6318.9 6324.5 6332.2 5642.4 5716.9 5736.5 5746.2 5777.8 6266.1 6278.8 6283.2 6299.4 6308.0 5535.7 5856.2 6192.0 6227.8 6239.2 6127.8 6190.4 6193.6 6267.3 6296.6 6253.9 6270.7 6281.4 6290.7 6291.5 6135.4 6279.5 6297.0 6299.8 6321.2 4854.6 4911.6 4913.4 4925.8 4988.8 3745.4 4446.7 4452.8 4505.9 4524.0 5818.8 5839.1 5865.2 5869.2 5898.7 5719.7 5824.2 6242.0 6275.3 6280.8 4790.0 5738.1 5820.7 5837.2 5913.9 5403.1 5430.9 5435.9 5442.7 5449.2 6380.0 6400.9 6409.4 6416.0 6423.7 6162.4 6183.6 6233.6 6285.1 6310.7 6390.9 6413.0 6414.5 6416.1 6437.4 6242.5 6268.1 6278.5 6289.5 6291.7 6133.1 6168.8 6172.6 6204.4 6254.9 6195.6 6210.1 6215.1 6223.9 6243.3 5185.7 5946.4 5959.2 6000.9 6208.6 5817.9 5920.6 5930.1 5950.9 6019.2 6045.0 6120.0 6145.0 6199.3 6203.2 5814.6 6069.4 6070.5 6074.3 6076.2 14:28:25 INFO - PROCESS | 1973 | 14:28:25 INFO - PROCESS | 1973 | [#1] ext.html Cycles:180 Average:71394.06 Median:38438.54 stddev:154761.57 (402.6%) stddev-sans-first:155104.19 14:28:25 INFO - PROCESS | 1973 | Values: 500.6 513.0 520.5 526.7 543.9 30814.9 39719.4 41820.2 41852.4 41976.6 43343.6 43861.9 43875.6 43897.3 44061.8 9710.0 9912.9 9916.9 9924.3 9938.0 8790.6 9028.5 9034.9 9129.3 9148.8 11907.8 12207.3 12213.1 12354.1 12385.0 12228.1 12236.4 12250.9 12257.8 12261.6 8676.6 8953.3 11933.0 12017.2 12034.7 40177.6 40244.0 40247.2 42068.6 42073.8 3262.8 3277.7 3290.4 3325.6 3342.6 28828.0 30619.4 32090.7 32200.4 32528.8 3122.0 3215.3 3218.8 3281.2 3293.6 501899.0 508670.0 508963.0 509461.0 510467.4 61782.4 63455.4 64053.7 64093.4 64102.0 66933.7 67096.0 67103.7 67140.7 67206.7 16678.7 16950.2 16951.1 16964.2 16985.7 12812.4 12816.1 13108.2 13129.5 13137.5 16950.6 17243.3 17305.2 17741.9 19426.4 6040.2 7009.3 7142.1 7284.8 7679.2 825.9 949.4 996.6 1035.5 1037.8 30111.4 30692.0 30820.5 31216.0 31466.8 974.9 1063.2 1138.5 1152.4 1156.3 14744.7 15948.4 15997.3 16090.0 16186.5 660517.0 668682.0 669231.0 669258.0 671610.0 51595.0 58265.4 59004.4 59120.4 59145.0 1145.9 1245.7 1281.8 1372.8 1398.3 24487.4 29387.6 30579.4 30816.4 30875.0 49254.8 49872.8 49969.3 50045.7 50049.0 513084.0 514352.0 515140.0 515142.0 675949.0 33987.5 40784.0 41488.6 41754.2 42180.7 46033.0 46067.9 46498.3 46575.8 46797.3 31564.5 35927.3 38471.0 38538.4 39096.8 37037.6 37154.9 38336.6 39288.8 39292.8 37652.2 37894.6 38215.6 38356.4 38406.0 32954.7 34129.3 34843.3 34968.5 35021.3 25375.3 25376.0 25551.0 25918.5 26138.7 14:28:25 INFO - PROCESS | 1973 | 14:28:25 INFO - PROCESS | 1973 | [#2] jquery.html Cycles:180 Average:29331.06 Median:389.30 stddev:81286.77 (20880.1%) stddev-sans-first:81485.67 14:28:25 INFO - PROCESS | 1973 | Values: 346.2 371.9 373.2 384.7 401.0 15160.5 15590.0 16779.2 20625.9 21512.9 20292.7 20394.0 20995.2 21024.0 21264.5 4439.7 5247.8 5465.3 5467.2 5480.9 5947.8 6146.9 6163.1 6173.5 6214.9 5843.1 6075.9 6147.4 6154.2 6161.4 6135.3 6156.8 6158.2 6173.9 6179.3 5683.9 5816.5 5901.0 5901.0 5903.1 13466.5 13472.7 13528.3 13655.2 13718.2 1961.0 2239.8 2241.9 2274.0 2342.3 9745.8 9817.9 9828.4 10077.8 10302.9 1838.0 1847.0 1856.0 1921.3 1925.0 123367.0 124173.0 130837.3 132714.3 132716.0 11061.4 11277.8 11332.5 11652.9 11720.4 14897.0 14908.2 14910.7 14922.0 14968.1 8573.9 8675.7 8695.7 8763.6 8850.6 8662.0 8683.7 8703.5 8814.1 8871.7 3762.9 4575.7 4583.8 4588.0 4657.2 1856.7 1923.3 1926.6 1929.3 1931.3 375.1 381.6 393.9 819.7 905.0 11561.5 11676.0 11798.9 11879.4 12189.6 419.7 426.7 427.4 430.9 455.8 5968.8 6066.2 6083.2 6084.6 6161.4 233708.0 234101.0 534173.0 602100.0 617431.9 77973.0 81606.0 103859.5 134060.0 137182.3 425.1 438.2 441.6 442.5 444.2 11296.9 11346.2 11379.2 11520.3 11820.0 39461.8 50842.0 51910.2 53197.0 55644.7 72752.3 73683.0 75390.6 77485.6 79975.0 6825.8 7913.4 8165.7 8205.1 8540.0 8979.0 13089.4 13265.3 13540.5 13617.4 11203.0 11402.7 11441.4 11446.9 11483.8 10918.7 10936.1 11227.6 11322.5 11452.3 11418.2 11462.9 11533.3 12042.2 12131.0 7882.2 7908.3 8113.1 8195.2 8526.8 8181.1 8964.1 10432.0 10950.3 11075.9 14:28:25 INFO - PROCESS | 1973 | 14:28:25 INFO - PROCESS | 1973 | [#3] mootools.html Cycles:180 Average:5663.29 Median:4870.60 stddev:3189.81 (65.5%) stddev-sans-first:3182.43 14:28:25 INFO - PROCESS | 1973 | Values: 1367.8 1521.2 1543.0 1740.7 1911.9 7643.9 7766.0 8270.8 8596.8 8918.2 8762.2 8857.0 8860.5 8876.3 8879.0 2354.8 2387.7 2389.5 2390.8 2392.9 2350.2 2374.7 2386.7 2388.2 2394.4 2351.2 2355.2 2375.6 2375.7 2380.3 2324.3 2358.9 2359.0 2361.9 2378.3 2307.0 2337.5 2339.8 2344.2 2355.0 8659.6 8781.7 8816.0 8910.5 8915.0 5263.0 5481.3 5488.3 5491.3 5507.4 3596.8 3632.4 3635.3 3710.8 3717.8 1071.8 1074.6 1075.5 1096.2 1099.5 9874.5 11616.2 11684.7 11776.4 11776.8 3645.4 4499.9 4691.3 4702.2 4704.6 8985.1 9129.0 9131.0 9134.3 9146.9 5256.2 5257.8 5262.6 5263.3 5266.6 4163.9 4419.9 4559.4 4574.2 4930.9 3185.2 3825.8 3875.6 3888.3 3894.3 1161.2 1170.2 1175.0 1186.8 1187.7 833.4 900.8 908.4 925.0 929.2 5722.8 5763.8 5958.3 6089.8 6194.9 433.3 435.4 454.9 458.6 461.9 3980.3 3983.5 3999.0 4008.7 4031.1 8314.3 10527.8 10879.7 10898.7 10942.6 10795.6 10841.6 10845.1 10851.9 10877.1 7879.5 8188.5 8242.5 8282.4 8296.5 5900.1 6008.8 6076.1 6132.2 6141.7 10133.4 10213.7 10300.1 10311.7 10330.4 9282.9 9968.8 10382.9 10427.4 10559.4 6200.9 7597.9 7605.3 7692.8 7718.4 8299.0 8311.1 8321.3 8368.5 8420.4 7492.7 7510.5 7538.4 7558.4 7567.6 7309.9 7323.3 7382.6 7385.0 7491.2 7005.7 7010.3 7072.3 7087.9 7109.7 4883.4 4906.9 4954.8 5098.0 5212.8 4857.8 4964.3 4977.5 5014.6 5177.4 14:28:25 INFO - PROCESS | 1973 | 14:28:25 INFO - PROCESS | 1973 | [#4] prototype.html Cycles:180 Average:4386.27 Median:5011.47 stddev:1327.87 (26.5%) stddev-sans-first:1295.32 14:28:25 INFO - PROCESS | 1973 | Values: 279.4 296.8 305.2 307.4 310.9 5170.8 5180.2 5251.8 5285.3 5289.2 4857.5 4871.7 4998.6 5057.3 5130.4 3378.3 4004.6 4005.9 4020.5 4047.8 3357.3 4048.7 4054.3 4068.9 4116.1 3367.3 3604.5 3956.0 3979.9 3999.8 3427.3 3963.3 3972.5 3972.5 4011.5 3062.9 3271.7 3335.9 3397.2 3507.6 4897.6 4997.6 5053.6 5058.9 5077.8 3970.4 4428.6 4479.8 4529.6 4537.9 5093.4 5341.0 5359.5 5376.1 5384.8 3153.3 3356.9 3599.2 3836.5 3846.3 4625.9 5344.5 5615.8 5624.8 5629.6 3888.8 3895.8 3906.4 3907.5 3921.1 3981.2 3984.0 3988.7 3995.2 4014.3 4373.2 4399.3 4509.2 4539.2 4557.3 4717.8 4883.3 5142.8 5395.5 5449.4 1113.5 1356.1 1358.7 1360.3 1360.7 858.3 887.4 893.6 903.9 924.4 4679.6 5105.3 5127.1 5132.7 5184.9 5017.6 5062.0 5503.3 5534.6 5580.6 4491.5 4872.7 5005.3 5071.5 5076.8 2424.0 2536.6 2776.2 2888.5 2973.0 4885.8 5548.5 5661.6 5674.8 5682.7 4864.3 5324.0 5607.5 5658.3 5660.5 5650.3 5665.6 5672.7 5673.7 5696.3 5176.0 5482.4 5483.3 5484.7 5504.4 5424.6 5436.8 5441.4 5453.3 5456.6 4610.8 5104.7 5218.4 5666.7 5672.5 3126.4 3834.7 3845.4 3855.6 3883.3 4314.5 5456.0 5481.7 5491.6 5515.6 4927.8 5141.7 5330.6 5377.4 5410.7 4159.7 5028.0 5309.8 5310.0 5335.8 3680.8 4386.8 4755.0 5179.7 5280.6 5293.7 5355.9 5374.3 5462.8 5475.8 5057.8 5301.3 5318.7 5331.7 5338.7 14:28:25 INFO - PROCESS | 1973 | 14:28:25 INFO - PROCESS | 1973 | [#5] yui.html Cycles:180 Average:27018.01 Median:21580.69 stddev:44232.43 (205.0%) stddev-sans-first:44312.58 14:28:25 INFO - PROCESS | 1973 | Values: 760.8 762.2 762.7 772.5 806.0 15749.6 15760.8 16998.0 17267.5 17268.0 16256.9 16450.5 16473.6 16507.3 16601.6 669.6 691.6 832.7 849.1 851.1 685.7 817.6 832.7 842.1 844.2 884.5 885.5 886.4 887.5 887.7 696.5 752.1 878.5 878.7 883.8 530.0 531.8 532.1 532.9 634.3 15139.5 15536.2 15561.4 15577.2 15591.5 13616.5 13711.0 13747.5 13772.7 13995.3 12373.8 12615.3 12747.9 12748.9 13161.5 4513.2 4550.3 4640.3 4677.6 4776.2 125307.0 129166.7 132277.0 133093.0 135861.0 9656.8 10485.2 10616.9 10800.8 10919.5 21016.3 21277.5 21339.5 21375.4 21786.0 8097.6 8222.5 8224.0 8260.5 8261.1 4406.8 4445.4 4560.8 4691.3 4705.3 3644.9 3773.2 3795.4 3796.5 3800.5 677.9 683.4 686.1 695.1 702.1 567.6 583.3 641.8 684.8 699.9 8097.9 9210.9 9394.1 9526.2 9706.8 551.7 612.7 670.6 675.5 683.2 4396.5 4693.3 4708.4 4717.8 4752.8 162193.0 162294.0 164020.0 165444.0 165695.0 107459.0 138259.0 143125.3 144670.0 147094.0 119286.0 124830.0 124888.0 125327.0 129339.0 8182.3 8703.0 8985.3 9022.2 9201.8 59328.0 66715.7 67246.0 68522.7 69113.7 95423.0 98908.0 102515.0 104402.5 105656.0 11712.8 11977.3 12012.0 12018.6 13003.7 14349.2 14498.6 14607.6 14933.0 16018.5 13379.1 13732.3 13771.3 14598.9 14953.8 14063.9 14325.0 14410.5 14623.3 14757.4 11002.8 12946.9 13861.6 14432.5 14732.8 10334.3 10619.9 11531.4 11655.1 12040.7 11352.7 11665.8 11729.2 11755.4 11849.9 14:28:25 INFO - PROCESS | 1973 | -------- Summary: end -------- 14:28:25 INFO - PROCESS | 1973 | 14:28:26 INFO - TEST-INFO | 1973: exit 0 14:28:26 INFO - TEST-OK | dromaeo_css | took 1117264ms 14:28:26 INFO - TEST-START | kraken 14:28:26 INFO - operating with platform_type : mac_ 14:28:26 INFO - Initialising browser for kraken test... 14:28:26 INFO - TEST-INFO | started process 1977 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/tmpWe78Ik/profile http://localhost:50872/getInfo.html) 14:28:28 INFO - PROCESS | 1977 | __metrics Screen width/height:1600/1200 14:28:28 INFO - PROCESS | 1977 | colorDepth:24 14:28:28 INFO - PROCESS | 1977 | Browser inner width/height: 1024/689 14:28:28 INFO - PROCESS | 1977 | __metrics 14:28:28 INFO - PROCESS | 1977 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 14:28:28 INFO - PROCESS | 1977 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:28:29 INFO - TEST-INFO | 1977: exit 0 14:28:29 INFO - Browser initialized. 14:28:29 INFO - Running cycle 1/1 for kraken test... 14:28:29 INFO - TEST-INFO | started process 1978 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/tmpWe78Ik/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:28:41 INFO - PROCESS | 1978 | RSS: Main: 219308032 14:28:41 INFO - PROCESS | 1978 | 14:28:44 INFO - PROCESS | 1978 | Cycle 1(1): loaded http://localhost:50872/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50872/tests/kraken/driver.html?testName=audio-beat-detection) 14:28:44 INFO - PROCESS | 1978 | RSS: Main: 270647296 14:28:44 INFO - PROCESS | 1978 | 14:28:47 INFO - PROCESS | 1978 | Cycle 1(1): loaded http://localhost:50872/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50872/tests/kraken/driver.html?testName=audio-dft) 14:28:48 INFO - PROCESS | 1978 | RSS: Main: 281866240 14:28:48 INFO - PROCESS | 1978 | 14:28:51 INFO - PROCESS | 1978 | Cycle 1(1): loaded http://localhost:50872/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50872/tests/kraken/driver.html?testName=audio-fft) 14:28:51 INFO - PROCESS | 1978 | RSS: Main: 378433536 14:28:51 INFO - PROCESS | 1978 | 14:28:53 INFO - PROCESS | 1978 | Cycle 1(1): loaded http://localhost:50872/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50872/tests/kraken/driver.html?testName=audio-oscillator) 14:28:54 INFO - PROCESS | 1978 | RSS: Main: 280453120 14:28:54 INFO - PROCESS | 1978 | 14:28:56 INFO - PROCESS | 1978 | Cycle 1(1): loaded http://localhost:50872/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50872/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:28:57 INFO - PROCESS | 1978 | RSS: Main: 281133056 14:28:57 INFO - PROCESS | 1978 | 14:29:00 INFO - PROCESS | 1978 | Cycle 1(1): loaded http://localhost:50872/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50872/tests/kraken/driver.html?testName=imaging-darkroom) 14:29:00 INFO - PROCESS | 1978 | RSS: Main: 318304256 14:29:00 INFO - PROCESS | 1978 | 14:29:03 INFO - PROCESS | 1978 | Cycle 1(1): loaded http://localhost:50872/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50872/tests/kraken/driver.html?testName=imaging-desaturate) 14:29:04 INFO - PROCESS | 1978 | RSS: Main: 319291392 14:29:04 INFO - PROCESS | 1978 | 14:29:07 INFO - PROCESS | 1978 | Cycle 1(1): loaded http://localhost:50872/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50872/tests/kraken/driver.html?testName=json-parse-financial) 14:29:07 INFO - PROCESS | 1978 | RSS: Main: 316940288 14:29:07 INFO - PROCESS | 1978 | 14:29:09 INFO - PROCESS | 1978 | Cycle 1(1): loaded http://localhost:50872/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50872/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:29:10 INFO - PROCESS | 1978 | RSS: Main: 289927168 14:29:10 INFO - PROCESS | 1978 | 14:29:11 INFO - PROCESS | 1978 | Cycle 1(1): loaded http://localhost:50872/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50872/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:29:12 INFO - PROCESS | 1978 | RSS: Main: 296366080 14:29:12 INFO - PROCESS | 1978 | 14:29:14 INFO - PROCESS | 1978 | Cycle 1(1): loaded http://localhost:50872/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50872/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:29:15 INFO - PROCESS | 1978 | RSS: Main: 300015616 14:29:15 INFO - PROCESS | 1978 | 14:29:18 INFO - PROCESS | 1978 | Cycle 1(1): loaded http://localhost:50872/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50872/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:29:19 INFO - PROCESS | 1978 | RSS: Main: 307437568 14:29:19 INFO - PROCESS | 1978 | 14:29:21 INFO - PROCESS | 1978 | Cycle 1(1): loaded http://localhost:50872/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50872/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:29:22 INFO - PROCESS | 1978 | RSS: Main: 306925568 14:29:22 INFO - PROCESS | 1978 | 14:29:24 INFO - PROCESS | 1978 | Cycle 1(1): loaded http://localhost:50872/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50872/tests/kraken/driver.html?testName=ai-astar) 14:29:24 INFO - PROCESS | 1978 | RSS: Main: 350916608 14:29:24 INFO - PROCESS | 1978 | 14:29:24 INFO - PROCESS | 1978 | __start_tp_report 14:29:24 INFO - PROCESS | 1978 | _x_x_mozilla_page_load 14:29:24 INFO - PROCESS | 1978 | _x_x_mozilla_page_load_details 14:29:24 INFO - PROCESS | 1978 | |i|pagename|runs| 14:29:24 INFO - PROCESS | 1978 | |0;ai-astar;115;115;115;113;113;114;116;162;167;113 14:29:24 INFO - PROCESS | 1978 | |1;audio-beat-detection;147;109;112;142;112;109;108;108;140;111 14:29:24 INFO - PROCESS | 1978 | |2;audio-dft;184;187;184;187;185;183;185;184;186;185 14:29:24 INFO - PROCESS | 1978 | |3;audio-fft;84;59;59;90;61;61;60;58;83;58 14:29:24 INFO - PROCESS | 1978 | |4;audio-oscillator;87;70;94;70;69;69;92;68;69;91 14:29:24 INFO - PROCESS | 1978 | |5;imaging-gaussian-blur;93;130;115;87;87;86;89;130;135;85 14:29:24 INFO - PROCESS | 1978 | |6;imaging-darkroom;131;141;95;95;94;94;94;94;95;95 14:29:24 INFO - PROCESS | 1978 | |7;imaging-desaturate;84;86;84;85;84;107;145;103;84;86 14:29:24 INFO - PROCESS | 1978 | |8;json-parse-financial;58;53;54;54;55;58;58;58;57;58 14:29:24 INFO - PROCESS | 1978 | |9;json-stringify-tinderbox;70;75;71;76;73;72;72;71;72;73 14:29:24 INFO - PROCESS | 1978 | |10;stanford-crypto-aes;84;81;85;83;86;84;83;83;83;83 14:29:24 INFO - PROCESS | 1978 | |11;stanford-crypto-ccm;142;145;147;153;125;139;140;142;197;137 14:29:24 INFO - PROCESS | 1978 | |12;stanford-crypto-pbkdf2;162;164;163;165;170;163;164;164;162;162 14:29:24 INFO - PROCESS | 1978 | |13;stanford-crypto-sha256-iterative;68;79;83;83;82;70;66;66;65;66 14:29:24 INFO - PROCESS | 1978 | __end_tp_report 14:29:24 INFO - PROCESS | 1978 | __start_cc_report 14:29:24 INFO - PROCESS | 1978 | _x_x_mozilla_cycle_collect,2020 14:29:24 INFO - PROCESS | 1978 | __end_cc_report 14:29:24 INFO - PROCESS | 1978 | __startTimestamp1477517364558__endTimestamp 14:29:24 INFO - PROCESS | 1978 | 14:29:24 INFO - PROCESS | 1978 | ------- Summary: start ------- 14:29:24 INFO - PROCESS | 1978 | Number of tests: 14 14:29:24 INFO - PROCESS | 1978 | 14:29:24 INFO - PROCESS | 1978 | [#0] ai-astar Cycles:10 Average:124.30 Median:115.00 stddev:21.24 (18.5%) stddev-sans-first:22.27 14:29:24 INFO - PROCESS | 1978 | Values: 115.0 115.0 115.0 113.0 113.0 114.0 116.0 162.0 167.0 113.0 14:29:24 INFO - PROCESS | 1978 | 14:29:24 INFO - PROCESS | 1978 | [#1] audio-beat-detection Cycles:10 Average:119.80 Median:112.00 stddev:16.16 (14.4%) stddev-sans-first:13.83 14:29:24 INFO - PROCESS | 1978 | Values: 147.0 109.0 112.0 142.0 112.0 109.0 108.0 108.0 140.0 111.0 14:29:24 INFO - PROCESS | 1978 | 14:29:24 INFO - PROCESS | 1978 | [#2] audio-dft Cycles:10 Average:185.00 Median:185.00 stddev:1.33 (0.7%) stddev-sans-first:1.36 14:29:24 INFO - PROCESS | 1978 | Values: 184.0 187.0 184.0 187.0 185.0 183.0 185.0 184.0 186.0 185.0 14:29:24 INFO - PROCESS | 1978 | 14:29:24 INFO - PROCESS | 1978 | [#3] audio-fft Cycles:10 Average:67.30 Median:61.00 stddev:12.84 (21.1%) stddev-sans-first:12.12 14:29:24 INFO - PROCESS | 1978 | Values: 84.0 59.0 59.0 90.0 61.0 61.0 60.0 58.0 83.0 58.0 14:29:24 INFO - PROCESS | 1978 | 14:29:24 INFO - PROCESS | 1978 | [#4] audio-oscillator Cycles:10 Average:77.90 Median:78.50 stddev:11.42 (14.5%) stddev-sans-first:11.62 14:29:24 INFO - PROCESS | 1978 | Values: 87.0 70.0 94.0 70.0 69.0 69.0 92.0 68.0 69.0 91.0 14:29:24 INFO - PROCESS | 1978 | 14:29:24 INFO - PROCESS | 1978 | [#5] imaging-gaussian-blur Cycles:10 Average:103.70 Median:86.50 stddev:21.19 (24.5%) stddev-sans-first:22.12 14:29:24 INFO - PROCESS | 1978 | Values: 93.0 130.0 115.0 87.0 87.0 86.0 89.0 130.0 135.0 85.0 14:29:24 INFO - PROCESS | 1978 | 14:29:24 INFO - PROCESS | 1978 | [#6] imaging-darkroom Cycles:10 Average:102.80 Median:94.50 stddev:17.66 (18.7%) stddev-sans-first:15.51 14:29:24 INFO - PROCESS | 1978 | Values: 131.0 141.0 95.0 95.0 94.0 94.0 94.0 94.0 95.0 95.0 14:29:24 INFO - PROCESS | 1978 | 14:29:24 INFO - PROCESS | 1978 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:84.00 stddev:19.59 (23.3%) stddev-sans-first:20.38 14:29:24 INFO - PROCESS | 1978 | Values: 84.0 86.0 84.0 85.0 84.0 107.0 145.0 103.0 84.0 86.0 14:29:24 INFO - PROCESS | 1978 | 14:29:24 INFO - PROCESS | 1978 | [#8] json-parse-financial Cycles:10 Average:56.30 Median:58.00 stddev:2.06 (3.5%) stddev-sans-first:2.09 14:29:24 INFO - PROCESS | 1978 | Values: 58.0 53.0 54.0 54.0 55.0 58.0 58.0 58.0 57.0 58.0 14:29:24 INFO - PROCESS | 1978 | 14:29:24 INFO - PROCESS | 1978 | [#9] json-stringify-tinderbox Cycles:10 Average:72.50 Median:72.50 stddev:1.84 (2.5%) stddev-sans-first:1.72 14:29:24 INFO - PROCESS | 1978 | Values: 70.0 75.0 71.0 76.0 73.0 72.0 72.0 71.0 72.0 73.0 14:29:24 INFO - PROCESS | 1978 | 14:29:24 INFO - PROCESS | 1978 | [#10] stanford-crypto-aes Cycles:10 Average:83.50 Median:83.50 stddev:1.35 (1.6%) stddev-sans-first:1.42 14:29:24 INFO - PROCESS | 1978 | Values: 84.0 81.0 85.0 83.0 86.0 84.0 83.0 83.0 83.0 83.0 14:29:24 INFO - PROCESS | 1978 | 14:29:24 INFO - PROCESS | 1978 | [#11] stanford-crypto-ccm Cycles:10 Average:146.70 Median:143.50 stddev:19.11 (13.3%) stddev-sans-first:20.19 14:29:24 INFO - PROCESS | 1978 | Values: 142.0 145.0 147.0 153.0 125.0 139.0 140.0 142.0 197.0 137.0 14:29:24 INFO - PROCESS | 1978 | 14:29:24 INFO - PROCESS | 1978 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.90 Median:164.00 stddev:2.38 (1.5%) stddev-sans-first:2.42 14:29:24 INFO - PROCESS | 1978 | Values: 162.0 164.0 163.0 165.0 170.0 163.0 164.0 164.0 162.0 162.0 14:29:24 INFO - PROCESS | 1978 | 14:29:24 INFO - PROCESS | 1978 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.80 Median:74.50 stddev:7.90 (10.6%) stddev-sans-first:8.19 14:29:24 INFO - PROCESS | 1978 | Values: 68.0 79.0 83.0 83.0 82.0 70.0 66.0 66.0 65.0 66.0 14:29:24 INFO - PROCESS | 1978 | -------- Summary: end -------- 14:29:24 INFO - PROCESS | 1978 | 14:29:25 INFO - TEST-INFO | 1978: exit 0 14:29:25 INFO - TEST-OK | kraken | took 59206ms 14:29:25 INFO - SUITE-END | took 1176s 14:29:25 INFO - Completed test suite (00:19:36) 14:29:25 INFO - javascript benchmark 14:29:25 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2813.2966758310417, 3300.521424393463, 3305.074579117848, 3342.2312868040335, 3354.09439451348, 5657.688827114507, 5716.428357164282, 5716.685582292972, 5737.827865164052, 5805.3323867755225, 5677.744501497432, 5777.653340799555, 5779.913301300473, 5796.449337312949, 5811.418858114197, 5241.371035475749, 5256.894862102756, 5260.658057226287, 5272.499112584298, 5331.306930099082, 5193.5325820676135, 5203.687778733288, 5228.633995620308, 5242.659227150242, 5272.446393128724, 5317.9468205318035, 5320.866978325554, 5326.840194794162, 5329.866753331159, 5369.570434365241, 5306.336707911511, 5311.601629877775, 5320.334958130234, 5320.787168513255, 5379.838604841861, 5128.897422051576, 5133.743312834344, 5181.766820493087, 5256.448072952323, 5261.394939581921, 5560.582956278296, 5651.378348381675, 5749.770009199627, 5751.252337196138, 5855.326637436707, 6198.163247961513, 6260.217472815898, 6275.058741188813, 6310.589811662273, 6328.588641738273, 6217.533684973645, 6262.968685156545, 6318.936810631881, 6324.462420694246, 6332.176817013758, 5642.435756424325, 5716.942830571724, 5736.541076713853, 5746.166805813175, 5777.7977770777825, 6266.122742816009, 6278.843028924313, 6283.183186185766, 6299.370062993756, 6308.0, 5535.6955367455175, 5856.238688970492, 6191.996881512463, 6227.813165605039, 6239.188905442355, 6127.80043271483, 6190.442860142609, 6193.628382297076, 6267.341929097379, 6296.5592408531875, 6253.874922501524, 6270.7491700331475, 6281.403266689657, 6290.654014029181, 6291.496680265568, 6135.355787642323, 6279.497640188774, 6297.0, 6299.7795077173, 6321.1782468278825, 4854.563089321978, 4911.607071434277, 4913.410390753133, 4925.827596034122, 4988.7505624718615, 3745.3632882410056, 4446.688731788744, 4452.821887124479, 4505.909881802346, 4524.049949510574, 5818.8254352369495, 5839.065749480063, 5865.155220416539, 5869.236999190078, 5898.705064746746, 5719.741656835489, 5824.213731146241, 6242.032484964838, 6275.278342990615, 6280.811575652647, 4789.976050119797, 5738.08190689496, 5820.708964551755, 5837.153612726216, 5913.940860591339, 5403.054465468527, 5430.891382172414, 5435.918461223085, 5442.673439593558, 5449.209864569694, 6379.96810015947, 6400.871982560323, 6409.423151916257, 6416.037594360883, 6423.743050277936, 6162.414570615784, 6183.5671502994355, 6233.5636505446, 6285.120083188266, 6310.6844657766005, 6390.9041364378645, 6413.0, 6414.486841052611, 6416.069669897745, 6437.356264373712, 6242.469390101892, 6268.091126786681, 6278.497720182466, 6289.49684025286, 6291.6539590321145, 6133.080037994337, 6168.753249870135, 6172.629642221481, 6204.441600255998, 6254.874902502015, 6195.566310358232, 6210.068489726577, 6215.12988181664, 6223.937760622517, 6243.313235544178, 5185.662931909414, 5946.375630558902, 5959.225300711053, 6000.909986350295, 6208.627482351073, 5817.912731308949, 5920.555958303058, 5930.140129681085, 5950.851228719317, 6019.187409699634, 6045.0327947528185, 6120.0205129226715, 6144.955357589131, 6199.256089269316, 6203.193584833943, 5814.5639077068545, 6069.423404776539, 6070.484008859296, 6074.3318234994995, 6076.240469941257], "value": 5713.398819768958, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [500.6445423749138, 512.9589632829374, 520.4977197004889, 526.6576725128666, 543.9420327463084, 30814.921477748285, 39719.40420893689, 41820.163596728045, 41852.372214416806, 41976.58023419765, 43343.566564334425, 43861.90345241362, 43875.56124438754, 43897.34153987693, 44061.7796911015, 9709.95145024274, 9912.90087099127, 9916.90083099167, 9924.305298629099, 9938.006199380077, 8790.648374065062, 9028.548572571379, 9034.909650903473, 9129.315301352424, 9148.771280718001, 11907.821382679267, 12207.328596927166, 12213.145079844415, 12354.135210535222, 12385.0, 12228.144029917908, 12236.388180590979, 12250.938745306306, 12257.816132758016, 12261.632151035394, 8676.566171691453, 8953.283737301066, 11933.0, 12017.218880772722, 12034.69913252167, 40177.598224017675, 40243.99390015273, 40247.19505609901, 42068.579314207076, 42073.78963105196, 3262.755293352984, 3277.655846136169, 3290.3748287825238, 3325.6341802401716, 3342.649021852719, 28828.0, 30619.38761224763, 32090.679093209237, 32200.355992880246, 32528.837355813306, 3122.0275840202953, 3215.3087086276328, 3218.806871587689, 3281.212508997847, 3293.6212335581477, 501899.0, 508670.0, 508963.0, 509461.0, 510467.447662763, 61782.38217617766, 63455.36544634494, 64053.67973160197, 64093.35906640874, 64102.0, 66933.66533167304, 67096.0, 67103.66448167728, 67140.66429667821, 67206.66396667986, 16678.749818752727, 16950.15249237533, 16951.067691277098, 16964.236609352607, 16985.745213821803, 12812.359382030862, 12816.102872799001, 13108.2135071896, 13129.474821007243, 13137.540186093442, 16950.576235593962, 17243.310267589408, 17305.221265043103, 17741.90456105382, 19426.4172074838, 6040.154378387029, 7009.2990700929495, 7142.142942846787, 7284.798008328672, 7679.155292917774, 825.8678611422143, 949.4018768176005, 996.5714742660581, 1035.5288343803702, 1037.7613148975777, 30111.397772044438, 30692.0, 30820.537691934638, 31216.0, 31466.842665786524, 974.8983648477317, 1063.2079101069753, 1138.4592318648577, 1152.4468255237532, 1156.2888823373564, 14744.705105897821, 15948.362065517482, 15997.28012239452, 16090.0, 16186.514404567883, 660517.0, 668682.0, 669231.0, 669258.0, 671610.0, 51595.0, 58265.41734582685, 59004.40995589989, 59120.40879591235, 59145.0, 1145.9427028648702, 1245.701031752373, 1281.7500587385557, 1372.766629672958, 1398.2519352146553, 24487.38781530476, 29387.559186612645, 30579.388412231187, 30816.383672326876, 30875.0, 49254.75372623114, 49872.75318116931, 49969.25046124238, 50045.749771250914, 50049.0, 513084.0, 514352.0, 515140.0, 515142.0, 675949.0, 33987.4901876477, 40784.0, 41488.585114148475, 41754.16491670089, 42180.73457796271, 46033.0, 46067.92694328696, 46498.30252546147, 46575.76712116553, 46797.2980405301, 31564.526532101576, 35927.28145437129, 38471.03822404462, 38538.421923670605, 39096.80451597837, 37037.62962370342, 37154.88535343944, 38336.616633833306, 39288.803555982035, 39292.82121536358, 37652.246955060196, 37894.62105378911, 38215.61784382121, 38356.42465363078, 38406.039849003995, 32954.67045329516, 34129.31741365208, 34843.30313393768, 34968.475472867416, 35021.29957400787, 25375.305568469154, 25375.98496060137, 25551.0, 25918.481630367663, 26138.73861261363], "value": 20561.111866978234, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [346.2400031929915, 371.8735629885839, 373.24790547047706, 384.69993405143987, 400.96591789697874, 15160.469383571577, 15589.986650867686, 16779.24493397797, 20625.896870515662, 21512.8924355378, 20292.695609565868, 20394.0, 20995.160193592237, 21024.0, 21264.4683882903, 4439.689221754463, 5247.816326428576, 5465.289512363387, 5467.234587157801, 5480.945190548104, 5947.821565353046, 6146.877062458748, 6163.137160797492, 6173.506119510451, 6214.9378506215035, 5843.094320380348, 6075.878482430348, 6147.385261473839, 6154.169187159743, 6161.414665606782, 6135.294441139259, 6156.7845125420845, 6158.199434073586, 6173.876522469571, 6179.289381721114, 5683.886322273573, 5816.505597024258, 5900.97049514754, 5901.02633065548, 5903.055511118243, 13466.451358093847, 13472.663183420394, 13528.323583820867, 13655.180689158582, 13718.17690938547, 1960.9901950490157, 2239.7648246934164, 2241.8766967816764, 2273.9658905116435, 2342.2973108067513, 9745.756356091084, 9817.90182098177, 9828.361156524874, 10077.798444031077, 10302.9484852576, 1838.0258463014623, 1846.9722954155698, 1855.9536011599682, 1921.327535362626, 1924.9903750481299, 123367.0, 124173.0, 130837.34581327127, 132714.3364283182, 132716.0, 11061.391623460626, 11277.830832537518, 11332.546698132148, 11652.883471165349, 11720.355380453986, 14897.0, 14908.180050097131, 14910.70178596422, 14922.0, 14968.101913885203, 8573.914260857437, 8675.6529738811, 8695.73912782605, 8763.605637746317, 8850.557472126367, 8662.0, 8683.739487815375, 8703.47779133254, 8814.118588141262, 8871.733847984571, 3762.9435558466644, 4575.679702420799, 4583.839565615188, 4588.0135770808765, 4657.231556793091, 1856.6565185440736, 1923.3268356075262, 1926.6435709393807, 1929.2668785861563, 1931.2564662604998, 375.0941476334621, 381.6450700848238, 393.9054626889526, 819.6762278899802, 905.0496978172893, 11561.479733412016, 11676.007539359249, 11798.941005294919, 11879.406029698654, 12189.634310970509, 419.6537856268591, 426.7013090836427, 427.3589615576635, 430.9245881970643, 455.81995111930604, 5968.791092311748, 6066.181065556093, 6083.239595050619, 6084.574079814459, 6161.383861613893, 233708.0, 234101.0, 534173.0, 602100.0, 617431.912840433, 77973.0, 81606.0, 103859.480702596, 134060.0, 137182.31408842892, 425.11788039817503, 438.2440290498928, 441.56946976697463, 442.54860042756206, 444.2048732768373, 11296.887031129583, 11346.205765596329, 11379.203455758017, 11520.251183673034, 11820.0, 39461.80269098636, 50842.0, 51910.22134667908, 53197.0, 55644.721776390856, 72752.27247727456, 73683.0, 75390.62304688442, 77485.61257193904, 79975.0, 6825.761098361533, 7913.406494513049, 8165.673373065011, 8205.138460461565, 8539.975202975435, 8979.033955713483, 13089.41097650589, 13265.33673316311, 13540.458381665017, 13617.387217575431, 11203.047740942111, 11402.714932126431, 11441.42792860337, 11446.885531144582, 11483.8277425837, 10918.672439826818, 10936.070434013198, 11227.55089796399, 11322.490487927898, 11452.312861228353, 11418.200725949104, 11462.94268528652, 11533.308001519936, 12042.21725587834, 12130.968867646348, 7882.172371901097, 7908.327792137503, 8113.148119447609, 8195.180481951757, 8526.82946341082, 8181.100078991425, 8964.103589640983, 10432.0, 10950.288231264942, 11075.889241107809], "value": 8350.529492424237, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1367.8358596968365, 1521.193767303329, 1543.020182184313, 1740.6692728381606, 1911.942641720748, 7643.885341719864, 7765.9611701941485, 8270.834583308339, 8596.828063438736, 8918.152775486318, 8762.167594078568, 8857.0, 8860.512671803048, 8876.289896808255, 8879.023307436193, 2354.776296251853, 2387.6537902004197, 2389.474315650554, 2390.8206884483648, 2392.9042838286446, 2350.1891847312736, 2374.7269064057596, 2386.7493913139133, 2388.199953015733, 2394.38943069517, 2351.1770880191966, 2355.1639168095335, 2375.560521303564, 2375.6911601491784, 2380.262118743195, 2324.2910912171783, 2358.8820558971984, 2359.0, 2361.89371478283, 2378.2746262389965, 2306.953860922772, 2337.5208082343247, 2339.812814974798, 2344.15610380263, 2354.976450235493, 8659.610317535726, 8781.692640757543, 8815.986161591434, 8910.465372077631, 8914.955425222832, 5263.0, 5481.342238931314, 5488.341399032101, 5491.28613280271, 5507.394186639466, 3596.766210196355, 3632.382494975834, 3635.3092912346833, 3710.7959062251566, 3717.7583457075475, 1071.769569542552, 1074.5809134437575, 1075.4568942683973, 1096.2052511928869, 1099.5272033025797, 9874.456904870229, 11616.244944078608, 11684.707882302926, 11776.352300623548, 11776.764464710743, 3645.434957581579, 4499.887502812456, 4691.311127993919, 4702.200625893606, 4704.553067458654, 8985.146411090936, 9128.995810460843, 9130.995590485041, 9134.269258459308, 9146.90853091474, 5256.237845512379, 5257.8159764408065, 5262.60530460217, 5263.289455923401, 5266.631335806534, 4163.854265100767, 4419.9337009944875, 4559.361689363492, 4574.153781550423, 4930.926036109461, 3185.2036990752313, 3825.827837747308, 3875.6047822783776, 3888.3389823730035, 3894.299026175259, 1161.2045748662194, 1170.1574866096396, 1174.988250117505, 1186.7745128425745, 1187.703074231442, 833.4124442268186, 900.7838118851429, 908.4004556992486, 924.9722508324761, 929.1962452478557, 5722.77108915647, 5763.827085187451, 5958.285005799332, 6089.8477538061015, 6194.876102477925, 433.3369943985707, 435.4252386849328, 454.8877993306334, 458.5849805925576, 461.87529367070704, 3980.283548961157, 3983.5418926823786, 3998.960010399917, 4008.6793056555407, 4031.113155105872, 8314.293285070837, 10527.789444211074, 10879.728006799734, 10898.67303980866, 10942.617008404668, 10795.6221532246, 10841.620543280947, 10845.07816835562, 10851.945740271405, 10877.0754485868, 7879.527228366316, 8188.549629770419, 8242.546659933641, 8282.420230583923, 8296.543690096982, 5900.1149827526215, 6008.759649613967, 6076.118962750465, 6132.202813634378, 6141.662208578392, 10133.39199647994, 10213.693589192337, 10300.124489418184, 10311.690649280534, 10330.380177189392, 9282.907170928474, 9968.800623987625, 10382.896171038194, 10427.374357538572, 10559.366438013743, 6200.875982480416, 7597.886031709419, 7605.277498637621, 7692.8461430772195, 7718.382529397747, 8298.958505207434, 8311.127331630092, 8321.292690121407, 8368.539730314891, 8420.410571259952, 7492.737754178577, 7510.511816731895, 7538.434617403607, 7558.395328373607, 7567.621618919142, 7309.890351644836, 7323.2676732326345, 7382.593957332183, 7385.0, 7491.175970643116, 7005.719771209298, 7010.298970102949, 7072.328128827753, 7087.893681594884, 7109.680064397218, 4883.413990321184, 4906.901861962812, 4954.752262386938, 5098.0, 5212.791488340424, 4857.781399837087, 4964.304997300309, 4977.4524802271, 5014.648974571745, 5177.378714554277], "value": 4474.2626358733305, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [279.4285685772595, 296.79521130419994, 305.16993776926756, 307.3668243418558, 310.92537790930186, 5170.819021334254, 5180.2488639147305, 5251.816186433471, 5285.339332583427, 5289.206619007151, 4857.465678775341, 4871.683340582868, 4998.5501304882555, 5057.342545469084, 5130.410002849673, 3378.2567835076306, 4004.6395824375945, 4005.8798236052967, 4020.517537895457, 4047.7571345719202, 3357.2949680567112, 4048.696347773914, 4054.2702313583545, 4068.9186216275657, 4116.053307739222, 3367.326534693071, 3604.4953706481115, 3956.0, 3979.9204015919663, 3999.760014399131, 3427.3316703242876, 3963.3155908738813, 3972.463717398143, 3972.483577134983, 4011.495689116581, 3062.892798752033, 3271.705546500826, 3335.93328133436, 3397.2186397128553, 3507.5790905091553, 4897.559219670211, 4997.575206107485, 5053.646244762868, 5058.898822023539, 5077.771500282496, 3970.4441378207075, 4428.579284967923, 4479.843205487792, 4529.569690879362, 4537.909241815179, 5093.363329583802, 5341.0, 5359.464053594648, 5376.096907669854, 5384.7846086156505, 3153.290509635314, 3356.9328613427597, 3599.218386898502, 3836.501254836853, 3846.2692088503095, 4625.9360347120355, 5344.4922732340365, 5615.775368985195, 5624.831255062355, 5629.634073785191, 3888.7861167635488, 3895.7533589251734, 3906.4140378942816, 3907.492026036597, 3921.098147426108, 3981.1838573092446, 3984.0438294809614, 3988.706493766096, 3995.220931918248, 4014.3175660137845, 4373.234683930299, 4399.274119770266, 4509.233430316854, 4539.16025535277, 4557.316402539645, 4717.8348757794, 4883.340748998839, 5142.794288228429, 5395.543203335156, 5449.373322067933, 1113.5267511307661, 1356.132075471699, 1358.6807100331414, 1360.2586590308306, 1360.6734383748028, 858.3390789092364, 887.4187407248133, 893.6112790935964, 903.8734577159203, 924.3915586878917, 4679.602233810097, 5105.310783044316, 5127.128388174019, 5132.717700526507, 5184.94088487794, 5017.648764586517, 5061.97520991599, 5503.284573005483, 5534.612577119563, 5580.581456390787, 4491.505934347219, 4872.731999739977, 5005.299258103868, 5071.46749591295, 5076.796928122908, 2424.0, 2536.619507073917, 2776.236534952904, 2888.4511942730815, 2973.0, 4885.845433068076, 5548.528375088082, 5661.575381846378, 5674.751554657969, 5682.715864206773, 4864.270359446041, 5324.0, 5607.523360514402, 5658.264425624642, 5660.518855897212, 5650.276665617026, 5665.5750818689585, 5672.744726487318, 5673.716314184357, 5696.3164420269, 5175.9741201295255, 5482.39693633692, 5483.300176945159, 5484.696427500379, 5504.4495550444635, 5424.566034717134, 5436.836894893001, 5441.374241962225, 5453.345598528202, 5456.590755693418, 4610.815567377267, 5104.69371837691, 5218.356217791384, 5666.688332141772, 5672.496788351008, 3126.421612001787, 3834.7123965702126, 3845.442595748726, 3855.63371479709, 3883.3107598194874, 4314.54697256796, 5456.026465576349, 5481.671099734029, 5491.611149149972, 5515.61390702647, 4927.841957140141, 5141.66054445219, 5330.626856120034, 5377.435369286325, 5410.702411367412, 4159.729617574969, 5027.974860125676, 5309.814156504503, 5310.0, 5335.839924802262, 3680.7975561344383, 4386.846460373871, 4754.97767979886, 5179.689218646893, 5280.551153152025, 5293.735313234246, 5355.892882142413, 5374.274472946102, 5462.808801691922, 5475.808346707846, 5057.8229761958155, 5301.284326616012, 5318.680879147263, 5331.70675612845, 5338.733063346895], "value": 3966.071304063406, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [760.8326168242986, 762.2225330163234, 762.7406681728211, 772.5017363800349, 805.9597020148998, 15749.606259843495, 15760.76358854618, 16998.0, 17267.481975540722, 17268.0, 16256.918715406406, 16450.506484805446, 16473.588160296, 16507.33970641176, 16601.584960375996, 669.5547460938494, 691.5850489706187, 832.6877420967122, 849.133883438892, 851.0808327006848, 685.6743047052635, 817.6443247187492, 832.6835802395082, 842.1452225990624, 844.1895780051158, 884.5135175653397, 885.5173930208019, 886.3706768194589, 887.4586502233632, 887.7159309021116, 696.5437638346891, 752.135044698601, 878.4685265414428, 878.7495563764328, 883.7525492862009, 529.9708516031617, 531.7739960516803, 532.0556013076781, 532.8907573947331, 634.3054355480741, 15139.54581362561, 15536.223188840513, 15561.37754489819, 15577.221138943007, 15591.45429909959, 13616.523421680193, 13711.0, 13747.518836840663, 13772.724545509034, 13995.30023498821, 12373.752524949541, 12615.306158161298, 12747.936260318731, 12748.908926423373, 13161.473541058442, 4513.1650644630845, 4550.317452382136, 4640.262479493811, 4677.602403795681, 4776.188048031843, 125307.0, 129166.70833291735, 132277.0, 133092.99999999904, 135861.0, 9656.806863862683, 10485.213608979357, 10616.946915265375, 10800.837987430195, 10919.508622112024, 21016.26443074485, 21277.46806329854, 21339.46651333698, 21375.358739237847, 21786.019629116727, 8097.554634495159, 8222.465539739898, 8224.0, 8260.545669988209, 8261.13258107902, 4406.757628330409, 4445.355423463579, 4560.840370587013, 4691.319758635047, 4705.270683044134, 3644.927101457956, 3773.2453509298252, 3795.4306853971575, 3796.52543432071, 3800.467934489174, 677.9288174741581, 683.361057411322, 686.0943554508002, 695.124143579094, 702.0767690486994, 567.6083502383342, 583.3491219847905, 641.8077750994385, 684.8082536889679, 699.867025265198, 8097.878531822027, 9210.907890921006, 9394.107559781809, 9526.237900967906, 9706.75733106678, 551.6910530103155, 612.7377602139518, 670.5574320948151, 675.5035049238805, 683.2450142592463, 4396.494403143615, 4693.296005599187, 4708.364370809965, 4717.834875779331, 4752.809887604526, 162193.0, 162294.0, 164020.0, 165444.0, 165695.0, 107459.0, 138259.0, 143125.28437357745, 144670.0, 147094.0, 119286.0, 124830.0, 124887.9938340657, 125327.0, 129339.0, 8182.345412366877, 8703.0, 8985.281177505914, 9022.188003079491, 9201.76995575116, 59328.0, 66715.66642166759, 67245.99131012941, 68522.65738671274, 69113.65443172753, 95423.0, 98908.0, 102515.0, 104402.47798760957, 105656.0, 11712.824307635221, 11977.341246231541, 12012.039036876855, 12018.579349722717, 13003.739925201255, 14349.210793406462, 14498.565043048726, 14607.561773146823, 14933.0, 16018.519444416686, 13379.063465557707, 13732.313384330942, 13771.311434428038, 14598.854011459749, 14953.77569336439, 14063.859361406256, 14325.011212438249, 14410.495632652806, 14623.34194961208, 14757.409703611735, 11002.834957475805, 12946.935265323613, 13861.584152475441, 14432.494862679756, 14732.77900831467, 10334.328268662513, 10619.893801061891, 11531.365774882463, 11655.067594592581, 12040.698982525508, 11352.659420217407, 11665.825012624988, 11729.237599556001, 11755.353455560027, 11849.940750296193], "value": 8019.64402279303, "unit": "score"}], "name": "dromaeo_css", "value": 7202.612504691962, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 115.0, 115.0, 113.0, 113.0, 114.0, 116.0, 162.0, 167.0, 113.0], "value": 124.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 109.0, 112.0, 142.0, 112.0, 109.0, 108.0, 108.0, 140.0, 111.0], "value": 119.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 187.0, 184.0, 187.0, 185.0, 183.0, 185.0, 184.0, 186.0, 185.0], "value": 185.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 59.0, 59.0, 90.0, 61.0, 61.0, 60.0, 58.0, 83.0, 58.0], "value": 67.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 70.0, 94.0, 70.0, 69.0, 69.0, 92.0, 68.0, 69.0, 91.0], "value": 77.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 130.0, 115.0, 87.0, 87.0, 86.0, 89.0, 130.0, 135.0, 85.0], "value": 103.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 141.0, 95.0, 95.0, 94.0, 94.0, 94.0, 94.0, 95.0, 95.0], "value": 102.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 86.0, 84.0, 85.0, 84.0, 107.0, 145.0, 103.0, 84.0, 86.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 53.0, 54.0, 54.0, 55.0, 58.0, 58.0, 58.0, 57.0, 58.0], "value": 56.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 75.0, 71.0, 76.0, 73.0, 72.0, 72.0, 71.0, 72.0, 73.0], "value": 72.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 81.0, 85.0, 83.0, 86.0, 84.0, 83.0, 83.0, 83.0, 83.0], "value": 83.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 145.0, 147.0, 153.0, 125.0, 139.0, 140.0, 142.0, 197.0, 137.0], "value": 146.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 164.0, 163.0, 165.0, 170.0, 163.0, 164.0, 164.0, 162.0, 162.0], "value": 163.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 79.0, 83.0, 83.0, 82.0, 70.0, 66.0, 66.0, 65.0, 66.0], "value": 72.8, "unit": "score"}], "name": "kraken", "value": 1471.3000000000002, "alertThreshold": 2.0}]} 14:29:25 INFO - Return code: 0 14:29:25 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:29:25 INFO - # TBPL SUCCESS # 14:29:25 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:29:25 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:29:25 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:29:25 INFO - 2016-10-26 14:29:25.901 screenresolution[1982:67137] starting screenresolution argv=screenresolution get 14:29:25 INFO - 2016-10-26 14:29:25.904 screenresolution[1982:67137] Display 0: 1600x1200x32@60 14:29:25 INFO - 2016-10-26 14:29:25.910 screenresolution[1983:67140] starting screenresolution argv=screenresolution list 14:29:25 INFO - Available Modes on Display 0 14:29:25 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:29:25 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:29:25 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:29:25 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:29:26 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:29:26 INFO - Intel Iris: 14:29:26 INFO - Chipset Model: Intel Iris 14:29:26 INFO - Type: GPU 14:29:26 INFO - Bus: Built-In 14:29:26 INFO - VRAM (Dynamic, Max): 1536 MB 14:29:26 INFO - Vendor: Intel (0x8086) 14:29:26 INFO - Device ID: 0x0a2e 14:29:26 INFO - Revision ID: 0x0009 14:29:26 INFO - Displays: 14:29:26 INFO - Display: 14:29:26 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:29:26 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:29:26 INFO - Display Serial Number: 1600x1200 60 14:29:26 INFO - Main Display: Yes 14:29:26 INFO - Mirror: Off 14:29:26 INFO - Online: Yes 14:29:26 INFO - Rotation: Supported 14:29:26 INFO - Return code: 0 14:29:26 INFO - Running post-action listener: _resource_record_post_action 14:29:26 INFO - [mozharness: 2016-10-26 21:29:26.144468Z] Finished run-tests step (success) 14:29:26 INFO - Running post-run listener: _resource_record_post_run 14:29:26 INFO - Total resource usage - Wall time: 1210s; CPU: 53.0%; Read bytes: 991232; Write bytes: 662631936; Read time: 7; Write time: 1867 14:29:26 INFO - TinderboxPrint: CPU usage
53.2% 14:29:26 INFO - TinderboxPrint: I/O read bytes / time
991,232 / 7 14:29:26 INFO - TinderboxPrint: I/O write bytes / time
662,631,936 / 1,867 14:29:26 INFO - TinderboxPrint: CPU idle
2,264.0 (46.8%) 14:29:26 INFO - TinderboxPrint: CPU system
967.7 (20.0%) 14:29:26 INFO - TinderboxPrint: CPU user
1,610.1 (33.3%) 14:29:26 INFO - TinderboxPrint: Swap in / out
363,696,128 / 0 14:29:26 INFO - install - Wall time: 33s; CPU: 54.0%; Read bytes: 354920960; Write bytes: 355862016; Read time: 27328; Write time: 647 14:29:26 INFO - run-tests - Wall time: 1178s; CPU: 53.0%; Read bytes: 991232; Write bytes: 296583168; Read time: 7; Write time: 1184 14:29:26 INFO - Running post-run listener: _upload_blobber_files 14:29:26 INFO - Blob upload gear active. 14:29:26 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:29:26 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 14:29:26 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'] 14:29:26 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 14:29:27 INFO - (blobuploader) - INFO - Open directory for files ... 14:29:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:29:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:29:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:29:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:29:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:29:28 INFO - (blobuploader) - INFO - Done attempting. 14:29:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 14:29:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:29:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:29:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:29:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:29:29 INFO - (blobuploader) - INFO - Done attempting. 14:29:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:29:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:29:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:29:32 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:29:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:29:32 INFO - (blobuploader) - INFO - Done attempting. 14:29:32 INFO - (blobuploader) - INFO - Iteration through files over. 14:29:32 INFO - Return code: 0 14:29:32 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:29:32 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:29:32 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4e5794b31709ef2e43e621f6703ebf937eeded409b5b812e2e7dab9643517c063d66d3cbc511a295d43c02a31e0f9fd0912d99f935de495eb699814c2c96f6b1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1cc86f97ef6e6acbd8781ead117310753b34b4282ad721d2888388aa9d8a4613895bfc27dd57d8e88bb930421cdcbd3460505ddeff15ba8f51fe8049a35d1ef7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bc54ce1f79c964dd9a0caff6c2299dbbd1f5734943f290292b7d3c03d709419383c923a710709d7f6940b57784a9d1c1618ab98170cb741c59f30e92900bdd89"} 14:29:32 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:29:32 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:29:32 INFO - Contents: 14:29:32 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4e5794b31709ef2e43e621f6703ebf937eeded409b5b812e2e7dab9643517c063d66d3cbc511a295d43c02a31e0f9fd0912d99f935de495eb699814c2c96f6b1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1cc86f97ef6e6acbd8781ead117310753b34b4282ad721d2888388aa9d8a4613895bfc27dd57d8e88bb930421cdcbd3460505ddeff15ba8f51fe8049a35d1ef7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bc54ce1f79c964dd9a0caff6c2299dbbd1f5734943f290292b7d3c03d709419383c923a710709d7f6940b57784a9d1c1618ab98170cb741c59f30e92900bdd89"} 14:29:32 INFO - Running post-run listener: copy_logs_to_upload_dir 14:29:32 INFO - Copying logs to upload dir... 14:29:32 INFO - mkdir: /builds/slave/test/build/upload/logs 14:29:32 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1270.217076 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-10-26 14:29:32.162169) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-26 14:29:32.165414) ========= 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.8YC63bzea8/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.uFuRCxXUHc/Listeners TMPDIR=/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/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/4e5794b31709ef2e43e621f6703ebf937eeded409b5b812e2e7dab9643517c063d66d3cbc511a295d43c02a31e0f9fd0912d99f935de495eb699814c2c96f6b1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1cc86f97ef6e6acbd8781ead117310753b34b4282ad721d2888388aa9d8a4613895bfc27dd57d8e88bb930421cdcbd3460505ddeff15ba8f51fe8049a35d1ef7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bc54ce1f79c964dd9a0caff6c2299dbbd1f5734943f290292b7d3c03d709419383c923a710709d7f6940b57784a9d1c1618ab98170cb741c59f30e92900bdd89"} build_url:https://queue.taskcluster.net/v1/task/B80AX5jXRCOwcCWqBAhbJg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011543 build_url: 'https://queue.taskcluster.net/v1/task/B80AX5jXRCOwcCWqBAhbJg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4e5794b31709ef2e43e621f6703ebf937eeded409b5b812e2e7dab9643517c063d66d3cbc511a295d43c02a31e0f9fd0912d99f935de495eb699814c2c96f6b1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1cc86f97ef6e6acbd8781ead117310753b34b4282ad721d2888388aa9d8a4613895bfc27dd57d8e88bb930421cdcbd3460505ddeff15ba8f51fe8049a35d1ef7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bc54ce1f79c964dd9a0caff6c2299dbbd1f5734943f290292b7d3c03d709419383c923a710709d7f6940b57784a9d1c1618ab98170cb741c59f30e92900bdd89"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-26 14:29:32.198298) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 14:29:32.198586) ========= 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.8YC63bzea8/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.uFuRCxXUHc/Listeners TMPDIR=/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/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.005312 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 14:29:32.246508) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-26 14:29:32.246775) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-26 14:29:32.247078) ========= ========= Total master_lag: 0.17 =========