builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0144 starttime: 1477682635.83 results: success (0) buildid: 20161028103259 builduid: 26ce6d95346741df844faa72defe1911 revision: b673d9fc515be72448527c0e3efcf25f2521f5e5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-28 12:23:55.827486) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-28 12:23:55.828005) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-28 12:23:55.828322) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-28 12:23:55.853873) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-28 12:23:55.856180) ========= 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.h2xpHfkexU/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.6PPgRjFIzN/Listeners TMPDIR=/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/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-28 12:23:55-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 204M=0s 2016-10-28 12:23:55 (204 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.129262 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-28 12:23:56.010280) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-28 12:23:56.010883) ========= 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.h2xpHfkexU/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.6PPgRjFIzN/Listeners TMPDIR=/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/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.024798 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-28 12:23:56.060499) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-28 12:23:56.061010) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev b673d9fc515be72448527c0e3efcf25f2521f5e5 --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 b673d9fc515be72448527c0e3efcf25f2521f5e5 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.h2xpHfkexU/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.6PPgRjFIzN/Listeners TMPDIR=/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/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-28 12:23:56,140 truncating revision to first 12 chars 2016-10-28 12:23:56,140 Setting DEBUG logging. 2016-10-28 12:23:56,140 attempt 1/10 2016-10-28 12:23:56,140 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/b673d9fc515b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-28 12:23:56,771 unpacking tar archive at: mozilla-aurora-b673d9fc515b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.894512 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-28 12:23:56.978700) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-28 12:23:56.979008) ========= script_repo_revision: b673d9fc515be72448527c0e3efcf25f2521f5e5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-28 12:23:56.979419) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-28 12:23:56.979690) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-28 12:23:56.998614) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-10-28 12:23:56.998911) ========= /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.h2xpHfkexU/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.6PPgRjFIzN/Listeners TMPDIR=/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/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 12:23:57 INFO - MultiFileLogger online at 20161028 12:23:57 in /builds/slave/test 12:23:57 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 12:23:57 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:23:57 INFO - {'append_to_log': False, 12:23:57 INFO - 'base_work_dir': '/builds/slave/test', 12:23:57 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 12:23:57 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:23:57 INFO - 'branch': 'Mozilla-Aurora', 12:23:57 INFO - 'buildbot_json_path': 'buildprops.json', 12:23:57 INFO - 'config_files': ('talos/mac_config.py',), 12:23:57 INFO - 'default_actions': ('clobber', 12:23:57 INFO - 'read-buildbot-config', 12:23:57 INFO - 'download-and-extract', 12:23:57 INFO - 'populate-webroot', 12:23:57 INFO - 'create-virtualenv', 12:23:57 INFO - 'install', 12:23:57 INFO - 'run-tests'), 12:23:57 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:23:57 INFO - 'download_minidump_stackwalk': True, 12:23:57 INFO - 'download_symbols': 'ondemand', 12:23:57 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:23:57 INFO - 'tooltool.py': '/tools/tooltool.py', 12:23:57 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:23:57 INFO - '/tools/misc-python/virtualenv.py')}, 12:23:57 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:23:57 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:23:57 INFO - 'installer_path': 'installer.exe', 12:23:57 INFO - 'log_level': 'info', 12:23:57 INFO - 'log_name': 'talos', 12:23:57 INFO - 'log_to_console': True, 12:23:57 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 12:23:57 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 12:23:57 INFO - 'opt_config_files': (), 12:23:57 INFO - 'pip_index': False, 12:23:57 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 12:23:57 INFO - 'cmd': ('bash', 12:23:57 INFO - '-c', 12:23:57 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 12:23:57 INFO - 'enabled': True, 12:23:57 INFO - 'halt_on_failure': False, 12:23:57 INFO - 'name': 'check_screen_resolution'},), 12:23:57 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 12:23:57 INFO - 'cmd': ('bash', 12:23:57 INFO - '-c', 12:23:57 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 12:23:57 INFO - 'enabled': True, 12:23:57 INFO - 'halt_on_failure': False, 12:23:57 INFO - 'name': 'check_screen_resolution'},), 12:23:57 INFO - 'run_cmd_checks_enabled': True, 12:23:57 INFO - 'sps_profile': False, 12:23:57 INFO - 'sps_profile_interval': 0, 12:23:57 INFO - 'suite': 'dromaeojs', 12:23:57 INFO - 'system_bits': '32', 12:23:57 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:23:57 INFO - 'title': 't-yosemite-r7-0144', 12:23:57 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:23:57 INFO - 'use_talos_json': True, 12:23:57 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:23:57 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:23:57 INFO - 'work_dir': 'build'} 12:23:57 INFO - [mozharness: 2016-10-28 19:23:57.216323Z] Running clobber step. 12:23:57 INFO - Running pre-action listener: _resource_record_pre_action 12:23:57 INFO - Running main action method: clobber 12:23:57 INFO - rmtree: /builds/slave/test/build 12:23:57 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:23:59 INFO - Running post-action listener: _resource_record_post_action 12:23:59 INFO - [mozharness: 2016-10-28 19:23:59.553781Z] Finished clobber step (success) 12:23:59 INFO - [mozharness: 2016-10-28 19:23:59.553942Z] Running read-buildbot-config step. 12:23:59 INFO - Running pre-action listener: _resource_record_pre_action 12:23:59 INFO - Running main action method: read_buildbot_config 12:23:59 INFO - Using buildbot properties: 12:23:59 INFO - { 12:23:59 INFO - "project": "", 12:23:59 INFO - "product": "firefox", 12:23:59 INFO - "script_repo_revision": "production", 12:23:59 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 12:23:59 INFO - "repository": "", 12:23:59 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 12:23:59 INFO - "buildid": "20161028103259", 12:23:59 INFO - "pgo_build": "False", 12:23:59 INFO - "basedir": "/builds/slave/test", 12:23:59 INFO - "buildnumber": 7, 12:23:59 INFO - "slavename": "t-yosemite-r7-0144", 12:23:59 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 12:23:59 INFO - "platform": "yosemite_r7", 12:23:59 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 12:23:59 INFO - "branch": "mozilla-aurora", 12:23:59 INFO - "repo_path": "releases/mozilla-aurora", 12:23:59 INFO - "revision": "b673d9fc515be72448527c0e3efcf25f2521f5e5", 12:23:59 INFO - "stage_platform": "macosx64", 12:23:59 INFO - "builduid": "26ce6d95346741df844faa72defe1911", 12:23:59 INFO - "slavebuilddir": "test" 12:23:59 INFO - } 12:23:59 INFO - Found installer url https://queue.taskcluster.net/v1/task/Gtaq9pZHS7mF9yPCky-F0A/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg. 12:23:59 INFO - Running post-action listener: _resource_record_post_action 12:23:59 INFO - [mozharness: 2016-10-28 19:23:59.557275Z] Finished read-buildbot-config step (success) 12:23:59 INFO - [mozharness: 2016-10-28 19:23:59.557378Z] Running download-and-extract step. 12:23:59 INFO - Running pre-action listener: _resource_record_pre_action 12:23:59 INFO - Running main action method: download_and_extract 12:23:59 INFO - mkdir: /builds/slave/test/build/tests 12:23: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')]} 12:23:59 INFO - trying https://queue.taskcluster.net/v1/task/Gtaq9pZHS7mF9yPCky-F0A/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json 12:23:59 INFO - Downloading https://queue.taskcluster.net/v1/task/Gtaq9pZHS7mF9yPCky-F0A/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 12:23:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Gtaq9pZHS7mF9yPCky-F0A/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 12:24:00 INFO - Downloaded 1199 bytes. 12:24:00 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 12:24:00 INFO - Using the following test package requirements: 12:24:00 INFO - {u'common': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 12:24:00 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 12:24:00 INFO - u'firefox-51.0a2.en-US.mac.cppunittest.tests.zip'], 12:24:00 INFO - u'gtest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 12:24:00 INFO - u'firefox-51.0a2.en-US.mac.gtest.tests.zip'], 12:24:00 INFO - u'jittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 12:24:00 INFO - u'jsshell-mac.zip'], 12:24:00 INFO - u'mochitest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 12:24:00 INFO - u'firefox-51.0a2.en-US.mac.mochitest.tests.zip'], 12:24:00 INFO - u'mozbase': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 12:24:00 INFO - u'reftest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 12:24:00 INFO - u'firefox-51.0a2.en-US.mac.reftest.tests.zip'], 12:24:00 INFO - u'talos': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 12:24:00 INFO - u'firefox-51.0a2.en-US.mac.talos.tests.zip'], 12:24:00 INFO - u'web-platform': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 12:24:00 INFO - u'firefox-51.0a2.en-US.mac.web-platform.tests.zip'], 12:24:00 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 12:24:00 INFO - u'firefox-51.0a2.en-US.mac.xpcshell.tests.zip']} 12:24:00 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip'] for test suite category: common 12:24:00 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Gtaq9pZHS7mF9yPCky-F0A/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 12:24:00 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Gtaq9pZHS7mF9yPCky-F0A/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 12:24:00 INFO - Fetch https://queue.taskcluster.net/v1/task/Gtaq9pZHS7mF9yPCky-F0A/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 12:24:01 INFO - Expected file size: 16420927 12:24:08 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 12:24:08 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Gtaq9pZHS7mF9yPCky-F0A/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 12:24:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Gtaq9pZHS7mF9yPCky-F0A/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 12:24:08 INFO - Fetch https://queue.taskcluster.net/v1/task/Gtaq9pZHS7mF9yPCky-F0A/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 12:24:09 INFO - Expected file size: 16420927 12:24:15 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Gtaq9pZHS7mF9yPCky-F0A/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip 12:24:15 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Gtaq9pZHS7mF9yPCky-F0A/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip'}, attempt #1 12:24:15 INFO - Fetch https://queue.taskcluster.net/v1/task/Gtaq9pZHS7mF9yPCky-F0A/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip into memory 12:24:16 INFO - Expected file size: 14414081 12:24:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:24:17 INFO - trying https://queue.taskcluster.net/v1/task/Gtaq9pZHS7mF9yPCky-F0A/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 12:24:17 INFO - Downloading https://queue.taskcluster.net/v1/task/Gtaq9pZHS7mF9yPCky-F0A/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg 12:24:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Gtaq9pZHS7mF9yPCky-F0A/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 12:24:20 INFO - Downloaded 115425889 bytes. 12:24:20 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Gtaq9pZHS7mF9yPCky-F0A/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 12:24:20 INFO - mkdir: /builds/slave/test/properties 12:24:20 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:24:20 INFO - Writing to file /builds/slave/test/properties/build_url 12:24:20 INFO - Contents: 12:24:20 INFO - build_url:https://queue.taskcluster.net/v1/task/Gtaq9pZHS7mF9yPCky-F0A/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 12:24:21 INFO - Running post-action listener: _resource_record_post_action 12:24:21 INFO - Running post-action listener: set_extra_try_arguments 12:24:21 INFO - [mozharness: 2016-10-28 19:24:21.523198Z] Finished download-and-extract step (success) 12:24:21 INFO - [mozharness: 2016-10-28 19:24:21.523339Z] Running populate-webroot step. 12:24:21 INFO - Running pre-action listener: _resource_record_pre_action 12:24:21 INFO - Running main action method: populate_webroot 12:24:21 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:24:21 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:24:21 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:24:21 INFO - '--tppagecycles', 12:24:21 INFO - '7'], 12:24:21 INFO - 'tests': ['tsvgm']}}, 12:24:21 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:24:21 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:24:21 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:24:21 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:24:21 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:24:21 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:24:21 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:24:21 INFO - 'talos_options': ['--disable-e10s'], 12:24:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:24:21 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:24:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:24:21 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:24:21 INFO - 'talos_options': ['--disable-e10s'], 12:24:21 INFO - 'tests': ['damp', 'tps']}, 12:24:21 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:24:21 INFO - 'tests': ['damp', 'tps']}, 12:24:21 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:24:21 INFO - 'tests': ['dromaeo_dom']}, 12:24:21 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:24:21 INFO - 'g4': {'talos_options': ['--disable-e10s'], 12:24:21 INFO - 'tests': ['basic_compositor_video']}, 12:24:21 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 12:24:21 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:24:21 INFO - 'tests': ['a11yr', 12:24:21 INFO - 'ts_paint', 12:24:21 INFO - 'tpaint', 12:24:21 INFO - 'sessionrestore', 12:24:21 INFO - 'sessionrestore_no_auto_restore', 12:24:21 INFO - 'tabpaint']}, 12:24:21 INFO - 'other-e10s': {'tests': ['a11yr', 12:24:21 INFO - 'ts_paint', 12:24:21 INFO - 'tpaint', 12:24:21 INFO - 'sessionrestore', 12:24:21 INFO - 'sessionrestore_no_auto_restore', 12:24:21 INFO - 'tabpaint']}, 12:24:21 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:24:21 INFO - 'ts_paint', 12:24:21 INFO - 'tpaint', 12:24:21 INFO - 'sessionrestore', 12:24:21 INFO - 'sessionrestore_no_auto_restore', 12:24:21 INFO - 'tabpaint']}, 12:24:21 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:24:21 INFO - 'ts_paint', 12:24:21 INFO - 'tpaint', 12:24:21 INFO - 'sessionrestore', 12:24:21 INFO - 'sessionrestore_no_auto_restore', 12:24:21 INFO - 'tabpaint']}, 12:24:21 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:24:21 INFO - 'tests': ['a11yr', 12:24:21 INFO - 'ts_paint', 12:24:21 INFO - 'tpaint', 12:24:21 INFO - 'sessionrestore', 12:24:21 INFO - 'sessionrestore_no_auto_restore', 12:24:21 INFO - 'tabpaint']}, 12:24:21 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:24:21 INFO - 'tests': ['a11yr', 12:24:21 INFO - 'ts_paint', 12:24:21 INFO - 'tpaint', 12:24:21 INFO - 'sessionrestore', 12:24:21 INFO - 'sessionrestore_no_auto_restore', 12:24:21 INFO - 'tabpaint']}, 12:24:21 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:24:21 INFO - 'tests': ['tsvgx', 12:24:21 INFO - 'tsvgr_opacity', 12:24:21 INFO - 'tart', 12:24:21 INFO - 'tscrollx', 12:24:21 INFO - 'cart']}, 12:24:21 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:24:21 INFO - 'tsvgr_opacity', 12:24:21 INFO - 'tart', 12:24:21 INFO - 'tscrollx', 12:24:21 INFO - 'cart']}, 12:24:21 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:24:21 INFO - 'talos_options': ['--disable-e10s'], 12:24:21 INFO - 'tests': ['tp5o']}, 12:24:21 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:24:21 INFO - 'tests': ['tp5o']}, 12:24:21 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:24:21 INFO - 'talos_options': ['--disable-e10s', 12:24:21 INFO - '--xperf_path', 12:24:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:24:21 INFO - 'tests': ['tp5n']}, 12:24:21 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:24:21 INFO - 'talos_options': ['--xperf_path', 12:24:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:24:21 INFO - 'tests': ['tp5n']}}, 12:24:21 INFO - 'talos.zip': {'path': '', 12:24:21 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:24:21 INFO - Running post-action listener: _resource_record_post_action 12:24:21 INFO - [mozharness: 2016-10-28 19:24:21.542056Z] Finished populate-webroot step (success) 12:24:21 INFO - [mozharness: 2016-10-28 19:24:21.542183Z] Running create-virtualenv step. 12:24:21 INFO - Running pre-action listener: _resource_record_pre_action 12:24:21 INFO - Running main action method: create_virtualenv 12:24:21 INFO - Creating virtualenv /builds/slave/test/build/venv 12:24:21 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 12:24:21 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:24:21 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:24:21 INFO - Using real prefix '/tools/python27' 12:24:21 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:24:22 INFO - Installing distribute.............................................................................................................................................................................................done. 12:24:25 INFO - Installing pip.................done. 12:24:25 INFO - Return code: 0 12:24:25 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:24:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:24:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:24:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:24:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:24:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:24:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:24:25 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 0x10c58b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c501570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fec18cb94a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c39fd30>, '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 0x10c205db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c397b20>, '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.h2xpHfkexU/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.6PPgRjFIzN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/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 12:24:25 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 12:24:25 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 12:24:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.h2xpHfkexU/Render', 12:24:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:24:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:24:25 INFO - 'HOME': '/Users/cltbld', 12:24:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:24:25 INFO - 'LOGNAME': 'cltbld', 12:24:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:24:25 INFO - 'MOZ_NO_REMOTE': '1', 12:24:25 INFO - 'NO_EM_RESTART': '1', 12:24:25 INFO - 'PAGER': '/bin/cat', 12:24:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:24:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:24:25 INFO - 'PWD': '/builds/slave/test', 12:24:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:24:25 INFO - 'SHELL': '/bin/bash', 12:24:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6PPgRjFIzN/Listeners', 12:24:25 INFO - 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/', 12:24:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:24:25 INFO - 'USER': 'cltbld', 12:24:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:24:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:24:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:24:25 INFO - 'XPC_FLAGS': '0x0', 12:24:25 INFO - 'XPC_SERVICE_NAME': '0', 12:24:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:24:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:24:25 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 12:24:25 INFO - Cleaning up... 12:24:25 INFO - Return code: 0 12:24:25 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:24:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:24:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:24:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:24:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:24:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:24:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:24:25 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 0x10c58b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c501570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fec18cb94a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c39fd30>, '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 0x10c205db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c397b20>, '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.h2xpHfkexU/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.6PPgRjFIzN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/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 12:24:25 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 12:24:25 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 12:24:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.h2xpHfkexU/Render', 12:24:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:24:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:24:25 INFO - 'HOME': '/Users/cltbld', 12:24:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:24:25 INFO - 'LOGNAME': 'cltbld', 12:24:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:24:25 INFO - 'MOZ_NO_REMOTE': '1', 12:24:25 INFO - 'NO_EM_RESTART': '1', 12:24:25 INFO - 'PAGER': '/bin/cat', 12:24:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:24:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:24:25 INFO - 'PWD': '/builds/slave/test', 12:24:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:24:25 INFO - 'SHELL': '/bin/bash', 12:24:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6PPgRjFIzN/Listeners', 12:24:25 INFO - 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/', 12:24:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:24:25 INFO - 'USER': 'cltbld', 12:24:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:24:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:24:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:24:25 INFO - 'XPC_FLAGS': '0x0', 12:24:25 INFO - 'XPC_SERVICE_NAME': '0', 12:24:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:24:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:24:25 INFO - Downloading/unpacking psutil>=3.1.1 12:24:25 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 12:24:25 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 12:24:25 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 12:24:25 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 12:24:25 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 12:24:25 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 12:24:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:24:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:24:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:24:28 INFO - Installing collected packages: psutil 12:24:28 INFO - Running setup.py install for psutil 12:24:28 INFO - building 'psutil._psutil_osx' extension 12:24:28 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 12:24:29 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 12:24:29 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 12:24:29 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 12:24:29 INFO - building 'psutil._psutil_posix' extension 12:24:29 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 12:24:29 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 12:24:29 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 12:24:29 INFO - ^ 12:24:29 INFO - 1 warning generated. 12:24:29 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 12:24:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:24:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:24:29 INFO - Successfully installed psutil 12:24:29 INFO - Cleaning up... 12:24:30 INFO - Return code: 0 12:24:30 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:24:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:24:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:24:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:24:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:24:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:24:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:24:30 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 0x10c58b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c501570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fec18cb94a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c39fd30>, '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 0x10c205db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c397b20>, '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.h2xpHfkexU/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.6PPgRjFIzN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/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 12:24:30 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 12:24:30 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 12:24:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.h2xpHfkexU/Render', 12:24:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:24:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:24:30 INFO - 'HOME': '/Users/cltbld', 12:24:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:24:30 INFO - 'LOGNAME': 'cltbld', 12:24:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:24:30 INFO - 'MOZ_NO_REMOTE': '1', 12:24:30 INFO - 'NO_EM_RESTART': '1', 12:24:30 INFO - 'PAGER': '/bin/cat', 12:24:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:24:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:24:30 INFO - 'PWD': '/builds/slave/test', 12:24:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:24:30 INFO - 'SHELL': '/bin/bash', 12:24:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6PPgRjFIzN/Listeners', 12:24:30 INFO - 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/', 12:24:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:24:30 INFO - 'USER': 'cltbld', 12:24:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:24:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:24:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:24:30 INFO - 'XPC_FLAGS': '0x0', 12:24:30 INFO - 'XPC_SERVICE_NAME': '0', 12:24:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:24:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:24:30 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:24:30 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 12:24:30 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 12:24:30 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 12:24:30 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 12:24:30 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 12:24:30 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 12:24:32 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:24:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:24:32 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:24:32 INFO - Installing collected packages: mozsystemmonitor 12:24:32 INFO - Running setup.py install for mozsystemmonitor 12:24:33 INFO - Successfully installed mozsystemmonitor 12:24:33 INFO - Cleaning up... 12:24:33 INFO - Return code: 0 12:24:33 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:24:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:24:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:24:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:24:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:24:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:24:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:24:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10c58b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c501570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fec18cb94a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c39fd30>, '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 0x10c205db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c397b20>, '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.h2xpHfkexU/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.6PPgRjFIzN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/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 12:24:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 12:24:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 12:24:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.h2xpHfkexU/Render', 12:24:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:24:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:24:33 INFO - 'HOME': '/Users/cltbld', 12:24:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:24:33 INFO - 'LOGNAME': 'cltbld', 12:24:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:24:33 INFO - 'MOZ_NO_REMOTE': '1', 12:24:33 INFO - 'NO_EM_RESTART': '1', 12:24:33 INFO - 'PAGER': '/bin/cat', 12:24:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:24:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:24:33 INFO - 'PWD': '/builds/slave/test', 12:24:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:24:33 INFO - 'SHELL': '/bin/bash', 12:24:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6PPgRjFIzN/Listeners', 12:24:33 INFO - 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/', 12:24:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:24:33 INFO - 'USER': 'cltbld', 12:24:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:24:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:24:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:24:33 INFO - 'XPC_FLAGS': '0x0', 12:24:33 INFO - 'XPC_SERVICE_NAME': '0', 12:24:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:24:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:24:33 INFO - Downloading/unpacking jsonschema==2.5.1 12:24:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:24:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:24:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:24:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:24:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:24:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:24:35 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:24:35 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:24:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:24:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:24:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:24:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:24:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:24:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:24:36 INFO - Downloading functools32-3.2.3-2.tar.gz 12:24:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:24:36 INFO - warning: no files found matching '*.txt' 12:24:36 INFO - no previously-included directories found matching 'build' 12:24:36 INFO - no previously-included directories found matching 'dist' 12:24:36 INFO - no previously-included directories found matching '.git*' 12:24:36 INFO - Installing collected packages: jsonschema, functools32 12:24:36 INFO - Running setup.py install for functools32 12:24:36 INFO - warning: no files found matching '*.txt' 12:24:36 INFO - no previously-included directories found matching 'build' 12:24:36 INFO - no previously-included directories found matching 'dist' 12:24:36 INFO - no previously-included directories found matching '.git*' 12:24:36 INFO - Successfully installed jsonschema functools32 12:24:36 INFO - Cleaning up... 12:24:36 INFO - Return code: 0 12:24:36 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 12:24:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:24:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:24:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:24:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:24:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:24:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:24:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10c58b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c501570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fec18cb94a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c39fd30>, '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 0x10c205db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c397b20>, '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.h2xpHfkexU/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.6PPgRjFIzN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/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 12:24:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 12:24:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 12:24:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.h2xpHfkexU/Render', 12:24:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:24:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:24:36 INFO - 'HOME': '/Users/cltbld', 12:24:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:24:36 INFO - 'LOGNAME': 'cltbld', 12:24:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:24:36 INFO - 'MOZ_NO_REMOTE': '1', 12:24:36 INFO - 'NO_EM_RESTART': '1', 12:24:36 INFO - 'PAGER': '/bin/cat', 12:24:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:24:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:24:36 INFO - 'PWD': '/builds/slave/test', 12:24:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:24:36 INFO - 'SHELL': '/bin/bash', 12:24:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6PPgRjFIzN/Listeners', 12:24:36 INFO - 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/', 12:24:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:24:36 INFO - 'USER': 'cltbld', 12:24:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:24:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:24:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:24:36 INFO - 'XPC_FLAGS': '0x0', 12:24:36 INFO - 'XPC_SERVICE_NAME': '0', 12:24:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:24:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:24:37 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 12:24:37 INFO - Cleaning up... 12:24:37 INFO - Return code: 0 12:24:37 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:24:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:24:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:24:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:24:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:24:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:24:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:24:37 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 0x10c58b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c501570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fec18cb94a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c39fd30>, '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 0x10c205db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c397b20>, '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.h2xpHfkexU/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.6PPgRjFIzN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/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 12:24:37 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 12:24:37 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 12:24:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.h2xpHfkexU/Render', 12:24:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:24:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:24:37 INFO - 'HOME': '/Users/cltbld', 12:24:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:24:37 INFO - 'LOGNAME': 'cltbld', 12:24:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:24:37 INFO - 'MOZ_NO_REMOTE': '1', 12:24:37 INFO - 'NO_EM_RESTART': '1', 12:24:37 INFO - 'PAGER': '/bin/cat', 12:24:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:24:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:24:37 INFO - 'PWD': '/builds/slave/test', 12:24:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:24:37 INFO - 'SHELL': '/bin/bash', 12:24:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6PPgRjFIzN/Listeners', 12:24:37 INFO - 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/', 12:24:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:24:37 INFO - 'USER': 'cltbld', 12:24:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:24:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:24:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:24:37 INFO - 'XPC_FLAGS': '0x0', 12:24:37 INFO - 'XPC_SERVICE_NAME': '0', 12:24:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:24:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:24:37 INFO - Downloading/unpacking blobuploader==1.2.4 12:24:37 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 12:24:37 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 12:24:37 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 12:24:37 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 12:24:37 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 12:24:37 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 12:24:39 INFO - Downloading blobuploader-1.2.4.tar.gz 12:24:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:24:39 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:24:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:24:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:24:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:24:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:24:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:24:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:24:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:24:40 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:24:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:24:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:24:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:24:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:24:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:24:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:24:40 INFO - Downloading docopt-0.6.1.tar.gz 12:24:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:24:41 INFO - Installing collected packages: blobuploader, requests, docopt 12:24:41 INFO - Running setup.py install for blobuploader 12:24:41 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:24:41 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:24:41 INFO - Running setup.py install for requests 12:24:41 INFO - Running setup.py install for docopt 12:24:41 INFO - Successfully installed blobuploader requests docopt 12:24:41 INFO - Cleaning up... 12:24:41 INFO - Return code: 0 12:24:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:24: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')]} 12:24:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:24:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:24: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')]} 12:24:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:24:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:24:41 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 0x10c58b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c501570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fec18cb94a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c39fd30>, '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 0x10c205db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c397b20>, '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.h2xpHfkexU/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.6PPgRjFIzN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/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 12:24:41 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 12:24:41 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 12:24:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.h2xpHfkexU/Render', 12:24:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:24:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:24:41 INFO - 'HOME': '/Users/cltbld', 12:24:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:24:41 INFO - 'LOGNAME': 'cltbld', 12:24:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:24:41 INFO - 'MOZ_NO_REMOTE': '1', 12:24:41 INFO - 'NO_EM_RESTART': '1', 12:24:41 INFO - 'PAGER': '/bin/cat', 12:24:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:24:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:24:41 INFO - 'PWD': '/builds/slave/test', 12:24:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:24:41 INFO - 'SHELL': '/bin/bash', 12:24:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6PPgRjFIzN/Listeners', 12:24:41 INFO - 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/', 12:24:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:24:41 INFO - 'USER': 'cltbld', 12:24:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:24:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:24:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:24:41 INFO - 'XPC_FLAGS': '0x0', 12:24:41 INFO - 'XPC_SERVICE_NAME': '0', 12:24:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:24:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:24:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:24:42 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-8rhZnf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:24:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:24:42 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-zvMAIm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:24:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:24:42 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-1iTpjZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:24:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:24:42 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-sqzAAs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:24:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:24:42 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-OX2h0D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:24:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:24:42 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-zLsc1R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:24:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:24:42 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-JHKmeZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:24:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:24:42 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-2E5I6M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:24:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:24:43 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-v0voKh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:24:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:24:43 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-UmhJTE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:24:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:24:43 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-lKggOP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:24:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:24:43 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-McZTrk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:24:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:24:43 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-GLymiC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:24:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:24:43 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-Hq0Urs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:24:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:24:43 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-l2NvoD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:24:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:24:43 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-93Dvot-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:24:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:24:43 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-zff17a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:24:43 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:24:43 INFO - Running setup.py install for manifestparser 12:24:44 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:24:44 INFO - Running setup.py install for mozcrash 12:24:44 INFO - Running setup.py install for mozdebug 12:24:44 INFO - Running setup.py install for mozdevice 12:24:44 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:24:44 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:24:44 INFO - Running setup.py install for mozfile 12:24:44 INFO - Running setup.py install for mozhttpd 12:24:44 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:24:44 INFO - Running setup.py install for mozinfo 12:24:45 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:24:45 INFO - Running setup.py install for mozInstall 12:24:45 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:24:45 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:24:45 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:24:45 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:24:45 INFO - Running setup.py install for mozleak 12:24:45 INFO - Running setup.py install for mozlog 12:24:45 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:24:45 INFO - Running setup.py install for moznetwork 12:24:45 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:24:45 INFO - Running setup.py install for mozprocess 12:24:45 INFO - Running setup.py install for mozprofile 12:24:45 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:24:45 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:24:45 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:24:45 INFO - Running setup.py install for mozrunner 12:24:46 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:24:46 INFO - Running setup.py install for mozscreenshot 12:24:46 INFO - Running setup.py install for moztest 12:24:46 INFO - Running setup.py install for mozversion 12:24:46 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:24:46 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:24:46 INFO - Cleaning up... 12:24:46 INFO - Return code: 0 12:24:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:24:46 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')]} 12:24:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:24:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:24:46 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')]} 12:24:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:24:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:24:46 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 0x10c58b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c501570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fec18cb94a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c39fd30>, '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 0x10c205db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c397b20>, '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.h2xpHfkexU/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.6PPgRjFIzN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/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 12:24:46 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 12:24:46 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 12:24:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.h2xpHfkexU/Render', 12:24:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:24:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:24:46 INFO - 'HOME': '/Users/cltbld', 12:24:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:24:46 INFO - 'LOGNAME': 'cltbld', 12:24:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:24:46 INFO - 'MOZ_NO_REMOTE': '1', 12:24:46 INFO - 'NO_EM_RESTART': '1', 12:24:46 INFO - 'PAGER': '/bin/cat', 12:24:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:24:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:24:46 INFO - 'PWD': '/builds/slave/test', 12:24:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:24:46 INFO - 'SHELL': '/bin/bash', 12:24:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6PPgRjFIzN/Listeners', 12:24:46 INFO - 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/', 12:24:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:24:46 INFO - 'USER': 'cltbld', 12:24:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:24:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:24:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:24:46 INFO - 'XPC_FLAGS': '0x0', 12:24:46 INFO - 'XPC_SERVICE_NAME': '0', 12:24:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:24:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:24:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:24:46 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-68FQ4j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:24:46 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)) 12:24:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:24:46 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-IlAOvm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:24:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 12:24:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:24:47 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-GWOAi7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:24:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 12:24:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:24:47 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-KMjsDz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:24:47 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)) 12:24:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:24:47 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-z0kFwc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:24:47 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)) 12:24:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:24:47 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-G6tY95-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:24:47 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)) 12:24:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:24:47 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-AxyFsh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:24:47 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)) 12:24:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:24:47 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-M9FYza-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:24:47 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)) 12:24:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:24:47 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-62QRlR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:24:47 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)) 12:24:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:24:47 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-i4ZuBg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:24:47 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)) 12:24:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:24:47 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-i52Wjd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:24:48 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 12:24:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:24:48 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-TU0dxD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:24:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 12:24:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:24:48 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-pALgj_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:24:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 12:24:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:24:48 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-o71ks3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:24:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 12:24:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:24:48 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-VpqQZd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:24:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 12:24:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:24:48 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-oAuQGU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:24:48 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 12:24:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:24:48 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-iRrhWF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:24:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 12:24:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 12:24:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 12:24:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 12:24:48 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:24:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:24:48 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:24:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:24:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:24:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:24:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:24:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:24:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:24:51 INFO - Downloading blessings-1.6.tar.gz 12:24:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:24:51 INFO - Installing collected packages: blessings 12:24:51 INFO - Running setup.py install for blessings 12:24:51 INFO - Successfully installed blessings 12:24:51 INFO - Cleaning up... 12:24:51 INFO - Return code: 0 12:24:51 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:24:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:24:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:24:51 INFO - Reading from file tmpfile_stdout 12:24:51 INFO - Current package versions: 12:24:51 INFO - blessings == 1.6 12:24:51 INFO - blobuploader == 1.2.4 12:24:51 INFO - docopt == 0.6.1 12:24:51 INFO - functools32 == 3.2.3-2 12:24:51 INFO - jsonschema == 2.5.1 12:24:51 INFO - manifestparser == 1.1 12:24:51 INFO - mozInstall == 1.12 12:24:51 INFO - mozcrash == 0.17 12:24:51 INFO - mozdebug == 0.1 12:24:51 INFO - mozdevice == 0.48 12:24:51 INFO - mozfile == 1.2 12:24:51 INFO - mozhttpd == 0.7 12:24:51 INFO - mozinfo == 0.9 12:24:51 INFO - mozleak == 0.1 12:24:51 INFO - mozlog == 3.4 12:24:51 INFO - moznetwork == 0.27 12:24:51 INFO - mozprocess == 0.23 12:24:51 INFO - mozprofile == 0.28 12:24:51 INFO - mozrunner == 6.12 12:24:51 INFO - mozscreenshot == 0.1 12:24:51 INFO - mozsystemmonitor == 0.3 12:24:51 INFO - moztest == 0.7 12:24:51 INFO - mozversion == 1.4 12:24:51 INFO - psutil == 3.1.1 12:24:51 INFO - requests == 1.2.3 12:24:51 INFO - wsgiref == 0.1.2 12:24:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:24:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:24:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:24:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:24:52 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')]} 12:24:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:24:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:24:52 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 0x10c58b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c501570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fec18cb94a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c39fd30>, '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 0x10c205db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c397b20>, '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.h2xpHfkexU/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.6PPgRjFIzN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/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 12:24:52 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 12:24:52 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 12:24:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.h2xpHfkexU/Render', 12:24:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:24:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:24:52 INFO - 'HOME': '/Users/cltbld', 12:24:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:24:52 INFO - 'LOGNAME': 'cltbld', 12:24:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:24:52 INFO - 'MOZ_NO_REMOTE': '1', 12:24:52 INFO - 'NO_EM_RESTART': '1', 12:24:52 INFO - 'PAGER': '/bin/cat', 12:24:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:24:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:24:52 INFO - 'PWD': '/builds/slave/test', 12:24:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:24:52 INFO - 'SHELL': '/bin/bash', 12:24:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6PPgRjFIzN/Listeners', 12:24:52 INFO - 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/', 12:24:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:24:52 INFO - 'USER': 'cltbld', 12:24:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:24:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:24:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:24:52 INFO - 'XPC_FLAGS': '0x0', 12:24:52 INFO - 'XPC_SERVICE_NAME': '0', 12:24:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:24:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:24:52 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)) 12:24:52 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)) 12:24:52 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)) 12:24:52 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)) 12:24:52 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)) 12:24:52 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)) 12:24:52 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)) 12:24:52 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)) 12:24:52 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)) 12:24:52 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)) 12:24:52 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)) 12:24:52 INFO - Cleaning up... 12:24:52 INFO - Return code: 0 12:24:52 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:24:52 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')]} 12:24:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:24:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:24:52 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')]} 12:24:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:24:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:24:52 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 0x10c58b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c501570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fec18cb94a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c39fd30>, '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 0x10c205db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c397b20>, '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.h2xpHfkexU/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.6PPgRjFIzN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/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 12:24:52 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 12:24:52 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 12:24:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.h2xpHfkexU/Render', 12:24:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:24:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:24:52 INFO - 'HOME': '/Users/cltbld', 12:24:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:24:52 INFO - 'LOGNAME': 'cltbld', 12:24:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:24:52 INFO - 'MOZ_NO_REMOTE': '1', 12:24:52 INFO - 'NO_EM_RESTART': '1', 12:24:52 INFO - 'PAGER': '/bin/cat', 12:24:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:24:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:24:52 INFO - 'PWD': '/builds/slave/test', 12:24:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:24:52 INFO - 'SHELL': '/bin/bash', 12:24:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6PPgRjFIzN/Listeners', 12:24:52 INFO - 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/', 12:24:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:24:52 INFO - 'USER': 'cltbld', 12:24:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:24:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:24:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:24:52 INFO - 'XPC_FLAGS': '0x0', 12:24:52 INFO - 'XPC_SERVICE_NAME': '0', 12:24:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:24:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:24:52 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:24:52 INFO - Cleaning up... 12:24:52 INFO - Return code: 0 12:24:52 INFO - Running post-action listener: _resource_record_post_action 12:24:52 INFO - Running post-action listener: _start_resource_monitoring 12:24:52 INFO - Starting resource monitoring. 12:24:52 INFO - [mozharness: 2016-10-28 19:24:52.914506Z] Finished create-virtualenv step (success) 12:24:52 INFO - [mozharness: 2016-10-28 19:24:52.915532Z] Running install step. 12:24:52 INFO - Running pre-action listener: _resource_record_pre_action 12:24:52 INFO - Running main action method: install 12:24:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:24:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:24:53 INFO - Reading from file tmpfile_stdout 12:24:53 INFO - Detecting whether we're running mozinstall >=1.0... 12:24:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:24:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:24:53 INFO - Reading from file tmpfile_stdout 12:24:53 INFO - Output received: 12:24:53 INFO - Usage: mozinstall [options] installer 12:24:53 INFO - Options: 12:24:53 INFO - -h, --help show this help message and exit 12:24:53 INFO - -d DEST, --destination=DEST 12:24:53 INFO - Directory to install application into. [default: 12:24:53 INFO - "/builds/slave/test"] 12:24:53 INFO - --app=APP Application being installed. [default: firefox] 12:24:53 INFO - mkdir: /builds/slave/test/build/application 12:24:53 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'] 12:24:53 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 12:25:25 INFO - Reading from file tmpfile_stdout 12:25:25 INFO - Output received: 12:25:25 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 12:25:25 INFO - Running post-action listener: _resource_record_post_action 12:25:25 INFO - [mozharness: 2016-10-28 19:25:25.283819Z] Finished install step (success) 12:25:25 INFO - [mozharness: 2016-10-28 19:25:25.283964Z] Running run-tests step. 12:25:25 INFO - Running pre-action listener: _resource_record_pre_action 12:25:25 INFO - Running main action method: run_tests 12:25:25 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:25:25 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:25:25 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:25:25 INFO - 2016-10-28 12:25:25.298 screenresolution[1642:7643] starting screenresolution argv=screenresolution get 12:25:25 INFO - 2016-10-28 12:25:25.300 screenresolution[1642:7643] Display 0: 1600x1200x32@60 12:25:25 INFO - 2016-10-28 12:25:25.306 screenresolution[1643:7645] starting screenresolution argv=screenresolution list 12:25:25 INFO - Available Modes on Display 0 12:25:25 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:25:25 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:25:25 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:25:25 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:25:25 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:25:25 INFO - Intel Iris: 12:25:25 INFO - Chipset Model: Intel Iris 12:25:25 INFO - Type: GPU 12:25:25 INFO - Bus: Built-In 12:25:25 INFO - VRAM (Dynamic, Max): 1536 MB 12:25:25 INFO - Vendor: Intel (0x8086) 12:25:25 INFO - Device ID: 0x0a2e 12:25:25 INFO - Revision ID: 0x0009 12:25:25 INFO - Displays: 12:25:25 INFO - Display: 12:25:25 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:25:25 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:25:25 INFO - Display Serial Number: 1600x1200 60 12:25:25 INFO - Main Display: Yes 12:25:25 INFO - Mirror: Off 12:25:25 INFO - Online: Yes 12:25:25 INFO - Rotation: Supported 12:25:25 INFO - Return code: 0 12:25:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:25:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:25:25 INFO - Python 2.7.3 12:25:25 INFO - Return code: 0 12:25:25 INFO - grabbing minidump binary from tooltool 12:25:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:25:25 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 0x10c39fd30>, '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 0x10c205db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c397b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:25:25 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 12:25:25 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 12:25:25 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 12:25:25 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:25:25 INFO - Return code: 0 12:25:25 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 12:25:25 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:25:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:25:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 12:25:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:25:25 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/Gtaq9pZHS7mF9yPCky-F0A/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0144', '--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 12:25:25 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/Gtaq9pZHS7mF9yPCky-F0A/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0144 --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 12:25:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.h2xpHfkexU/Render', 12:25:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:25:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:25:25 INFO - 'HOME': '/Users/cltbld', 12:25:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:25:25 INFO - 'LOGNAME': 'cltbld', 12:25:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:25:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 12:25:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:25:25 INFO - 'MOZ_NO_REMOTE': '1', 12:25:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:25:25 INFO - 'NO_EM_RESTART': '1', 12:25:25 INFO - 'PAGER': '/bin/cat', 12:25:25 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:25:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:25:25 INFO - 'PWD': '/builds/slave/test', 12:25:25 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:25:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:25:25 INFO - 'SHELL': '/bin/bash', 12:25:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6PPgRjFIzN/Listeners', 12:25:25 INFO - 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/', 12:25:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:25:25 INFO - 'USER': 'cltbld', 12:25:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:25:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:25:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:25:25 INFO - 'XPC_FLAGS': '0x0', 12:25:25 INFO - 'XPC_SERVICE_NAME': '0', 12:25:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:25:25 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/Gtaq9pZHS7mF9yPCky-F0A/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0144', '--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 12:25:25 INFO - mozversion application_buildid: 20161028103259 12:25:25 INFO - mozversion application_changeset: b673d9fc515be72448527c0e3efcf25f2521f5e5 12:25:25 INFO - mozversion application_display_name: FirefoxDeveloperEdition 12:25:25 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:25:25 INFO - mozversion application_name: Firefox 12:25:25 INFO - mozversion application_remotingname: firefox-dev 12:25:25 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 12:25:25 INFO - mozversion application_vendor: Mozilla 12:25:25 INFO - mozversion application_version: 51.0a2 12:25:25 INFO - mozversion platform_buildid: 20161028103259 12:25:25 INFO - mozversion platform_changeset: b673d9fc515be72448527c0e3efcf25f2521f5e5 12:25:25 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 12:25:25 INFO - mozversion platform_version: 51.0a2 12:25:25 INFO - using testdate: 1477682725 12:25:25 INFO - actual date: 1477682725 12:25:25 INFO - starting webserver on 'localhost:49274' 12:25:25 INFO - SUITE-START | Running 2 tests 12:25:25 INFO - TEST-START | dromaeo_css 12:25:25 INFO - operating with platform_type : mac_ 12:25:25 INFO - Initialising browser for dromaeo_css test... 12:25:25 INFO - TEST-INFO | started process 1653 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/tmpgDi8KL/profile http://localhost:49274/getInfo.html) 12:25:28 INFO - PROCESS | 1653 | __metrics Screen width/height:1600/1200 12:25:28 INFO - PROCESS | 1653 | colorDepth:24 12:25:28 INFO - PROCESS | 1653 | Browser inner width/height: 1024/689 12:25:28 INFO - PROCESS | 1653 | __metrics 12:25:28 INFO - PROCESS | 1653 | 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" 12:25:28 INFO - PROCESS | 1653 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:25:28 INFO - TEST-INFO | 1653: exit 0 12:25:28 INFO - Browser initialized. 12:25:28 INFO - Running cycle 1/1 for dromaeo_css test... 12:25:28 INFO - TEST-INFO | started process 1655 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/tmpgDi8KL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:25:41 INFO - PROCESS | 1655 | RSS: Main: 219639808 12:25:41 INFO - PROCESS | 1655 | 12:26:37 INFO - PROCESS | 1655 | 1477682797529 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] 12:28:44 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49274/tests/dromaeo/cssquery-ext.html) 12:28:46 INFO - PROCESS | 1655 | RSS: Main: 406114304 12:28:46 INFO - PROCESS | 1655 | 12:31:49 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-ext.html (next: http://localhost:49274/tests/dromaeo/cssquery-jquery.html) 12:31:49 INFO - PROCESS | 1655 | RSS: Main: 364761088 12:31:49 INFO - PROCESS | 1655 | 12:34:52 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49274/tests/dromaeo/cssquery-mootools.html) 12:34:52 INFO - PROCESS | 1655 | RSS: Main: 324591616 12:34:52 INFO - PROCESS | 1655 | 12:37:55 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49274/tests/dromaeo/cssquery-prototype.html) 12:37:55 INFO - PROCESS | 1655 | RSS: Main: 323575808 12:37:55 INFO - PROCESS | 1655 | 12:40:59 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49274/tests/dromaeo/cssquery-yui.html) 12:40:59 INFO - PROCESS | 1655 | RSS: Main: 316198912 12:40:59 INFO - PROCESS | 1655 | 12:44:02 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-yui.html (next: http://localhost:49274/tests/dromaeo/cssquery-dojo.html) 12:44:03 INFO - PROCESS | 1655 | RSS: Main: 370593792 12:44:03 INFO - PROCESS | 1655 | 12:44:03 INFO - PROCESS | 1655 | __start_tp_report 12:44:03 INFO - PROCESS | 1655 | _x_x_mozilla_page_load 12:44:03 INFO - PROCESS | 1655 | _x_x_mozilla_page_load_details 12:44:03 INFO - PROCESS | 1655 | |i|pagename|runs| 12:44:03 INFO - PROCESS | 1655 | |0;dojo.html;2924.8976285829995;3322.734181265498;3382.2389962258494;3404.6935775780207;3419.264858055519;5655.660660360381;5709.914351284734;5732.541396688265;5737.770489180428;5752.223449834271;5625.887482250352;5630.071038278679;5700.6579605223615;5722.256106706122;5723.5135013523795;5207.973960130194;5216.60875434344;5217.47825217479;5232.058229518695;5288.867778305554;5183.637145399824;5193.298904647862;5202.375714914216;5296.179092240709;5321.281626980347;5298.258243845865;5307.814226502073;5318.734063296839;5321.308229930123;5326;5293.04725149473;5296.682199068049;5322.760475778599;5341;5362.276092727471;5173.689578625294;5242.60680448964;5248.947510524884;5289.338832645919;5350.812721554766;5848.41515848416;5902.468777809975;5909.320428150775;5923.911141332884;5930.0808374701555;6101.938980610182;6132.877342453171;6292.276388215368;6326;6337.87324253517;6039.486643635296;6108.2813625860135;6252.093446450284;6270.46701030413;6344.1435406220035;5784.754254811526;5830.912536312001;5845.853853653608;5849.970750146222;5863.736131874076;6282.780102696383;6331;6336.714847831859;6354.618722876642;6356.523260755462;6017.669028203491;6096.72564734588;6114.816555503342;6133.059244993061;6163.768144879478;6269.185005949197;6326.145970293951;6326.49388048955;6342.365763423621;6343.111964324999;6057.303410107894;6226.5641405101205;6258.092576576462;6259.1550140730415;6260.342664020303;6058.273007239071;6128.80869161996;6181.072839074175;6183.072539119168;6216.347283535254;4931.654784165145;4937.925931111036;4952.455229924705;4956.281339205795;4970.701757894538;4442.244818380883;4443.222436073739;4449.421575195204;4452.243118669834;4484;5627.071533196977;5640.153976903415;5685.545156387479;5739.569532285095;5743.9425605744245;6239.532035097386;6335.524835637346;6356.777512787123;6372.299047104815;6377.043443483514;5788.160716696139;5803.88392232153;5813.447722466359;5828.154917536934;5862.560307976919;5261.631685781958;5286.788528458896;5336.493033161921;5389.083855744533;5414.593905457106;6249.843753906189;6346.048092785934;6358.650274234961;6362.9045564316575;6376.075469056868;6286.811395658137;6305.117283580211;6353.332900045429;6380;6393.584417012879;4846.731349612095;6353.078803573363;6356;6366.172397588284;6386.201724784402;6056.394360563909;6231.501479881689;6243.562950593415;6244.5316601256;6287.2140982377205;5277.920831187458;6123.6631985239455;6127.922628246779;6191.690415479118;6201.069839524108;4987.852793857361;6103.389661033861;6187.195664563578;6194.38056194377;6215.751369945152;6008.759649613967;6126.663033533198;6147.723352449061;6173.259208894961;6184.288806787277;5769.91345129815;5826.41735826414;5850.64896106235;5972.850678733066;5997.160397544434;5969.820905372846;6074.939250607437;6092.939070609415;6120;6127.724252408741;5914.645121292736;5925.792597259076;5935.703214839327;5943.4948029416255;5982.7307771149535 12:44:03 INFO - PROCESS | 1655 | |1;ext.html;478.40916468161794;522.8405336372406;533.0671325180933;534.4655344655345;541.591098720466;30130.246743831416;40051;40990.38514422278;41259.99999999996;41327.17345653085;42261.57738422615;42714.786426067825;42718;42841.571584284146;42919.14161716772;9733.221342292618;9934.65228716995;9935;9936.95661955495;9969.850452243221;8885.911140888573;9121.863172052424;9121.908780912205;9123.452592844418;9131.406458580204;11940.104492163078;12197.63407097784;12219.694507637292;12411.937940310287;12435.564755233569;12096.33470159141;12184.208026478294;12188.390580470941;12194.024478041823;12204.511819527208;8701.260392866614;8916.331275154389;11950.641480755592;12068;12068.577599783965;31942.88199913015;32223.677763222302;32389.6761032389;39576.80211598952;39639.60360396388;3342.1143396999814;3402.5576675032335;3678.319510890494;3689.1330537323706;3945.6646185074305;29637;30007.249818754488;30202.697973020207;30878.22804429885;31960.20099497508;3177.4916013437737;3258.266889949766;3259.348130373911;3267.1178781729036;3344.1973926257765;517973;526139;528702.356488219;529567;529678;53563.6609084776;54857;62163.689181554706;62579;63246.051309230395;62850.37149628445;65233;65949.34050659528;65999.67000165065;66133.33866661368;16934.915325423295;17071.487855364358;17107.401240956508;17145.657086858442;17224.483265502055;13130.146540474838;13229.669258268428;13241.3379331035;13260.138091024053;13274.601761947157;16357.509274721777;16683.33266669344;16706.164691765363;19062.523436914187;19152.712709309373;7501.549907005598;7648.158702542716;7697.884531732028;7744.961275193588;7787.415943804237;889.7063968890251;927.1331305229631;955.9904400956041;977.3549457358109;1004.4224570871778;29687;29836.9557065506;30185;30186.396272074435;30197.69802301993;1044.3107549017611;1051.984220236697;1069.545443186658;1086.652271273185;1116.553378648531;15056;15424.537263881877;15474.071555706694;15814.892957492864;15846.524604261891;725472;730975;732598;733617;735543;49111;50086.49913500891;55944.44055559474;57075;57363.71318143383;1127.7293449572044;1352.3914238592477;1394.755917714396;1395.483671041721;1397.9161250325012;29279;29687.40625187441;30664.84667576737;30679.539806902467;30707.539386908767;49965.75017124891;50413.73965650888;50431;50460.747696261285;50633;555638;624515;625178;627332;627500;26188.476230474902;26621.866890665424;26664.333391665365;26669.466610668067;26678;46696;46821.765891171686;47143;47855;48398;38196.236075278895;38290.6170938287;38904.80547597244;38929;40359;38008.80995595004;38351.616483834805;38420.6157938417;38493.615063849;38720.2255954885;37403.43894841525;38221.853344399715;38605.03487412725;38706.4194037084;39116.804415977735;30809.537856931714;33297.50053749147;34362.969110926715;34785.47821782625;34809.82595087009;25117.49765004653;25492.617610736226;25597.488050238517;25929.6110558338;25973.350666233495 12:44:03 INFO - PROCESS | 1655 | |2;jquery.html;326.2642740619902;347.8712876235793;370.955485341759;374.59169505239294;400.0598593305732;14331.355089020994;15437.996530225542;16165.191740412976;17732.37936672217;20931.581368372623;20156.8992155039;20644.79355206451;21425.250116245934;21498.355049348505;21769.020394082265;5719.828405147852;5885.8822823543505;6161.229846269216;6169.383061693839;6172.7530898764;5541.362743284513;5771.336296325913;6059.030555111183;6100.603460775058;6109.602875813081;5764.913526297109;6042.818715438544;6048.2137322148055;6056.091586262052;6059.515238780887;5917.289925208981;5990.430909063632;5998.220231369894;6003.549733769984;6004.369541198199;5218.843434696965;5225.589090945461;5230.607704422184;5448.809291674773;5515.917261241085;12793.232406055666;12862.614121576367;12911.870881291161;13027.86972130276;13054.477820887154;1919.9904000480049;2243.4952135769486;2337.2871274261342;2367.171489978511;2408.4821763320797;9463.195628371597;9492.477913714743;9884;10041.497925103715;10207.693769186937;1590.6956295837417;1751.4920673004813;1755.4119370010933;1795.3267524678245;1894.7536820213422;120795.39602301932;121863;123207;124612;124883;11118.666440006813;11180.440977951233;11214.327140371604;11275.54897804095;11568.305901645928;14153.363098660586;14154.433822647185;14157.009009369245;14161.78757318641;14189.219592922282;6852.828679283058;8542.444741091933;8584;8691.565421728888;8707.956460217658;6969.4424446044195;6986.371226589631;7078.398336141383;8572.871406928902;8745.737627871174;4347.413099231627;4383.868483945486;4397.670174736843;4408.294672852328;4458.286674132188;1739.3129713762992;1829.4785985993929;1877.7840548336842;1878.8966606836482;1893.583411649435;872.1060912564545;885.7785553611598;920.663957655451;923.9676611318572;953.8855337359422;21413.80323932233;21936.780632193473;21981.41486810545;22027.449313767283;22105.778942210694;926.9397489163183;928.8281667891326;940.8541676040225;948.786523032326;990.8513722941616;10447.84328235077;11209.775804484028;11269.380184089954;11304.03915667161;11319.773604528027;590955;592251;598868;603725;608308;90145.64781528282;123504;127378;133855;134441.3277933604;803.8593246182012;954.3271993244746;972.9270304727174;989.5151375825938;994.0705440413092;18876.716849247547;20110.89944550268;20284.695729563773;20312;20330.491737706674;57030.57423564444;59585.702071489366;59990.400095998484;60004;60189;75639.62180189064;82406;83371.16628833876;84493.15506844853;85636.14363856282;6771.52599318043;7973.521588704696;8081.878771818545;8223.301019413178;8259.752207433787;11270.774584508428;12864.356782161041;12913.870861291643;13143.474261029452;13423.865761342262;11160.218784684994;11402.486888090221;11483.966443020168;11548.364839933884;11649.825252621387;10862.619808306672;11142.387168705474;11144.387058711525;11258.38078905668;11535.76928461443;10150.644727434505;11189.328640281608;11215.439228038402;11322.660320190407;11427.142964277546;8194.467359621605;11842.82235766447;11893.405329733305;11947.342896140795;12437.440315185657;11412.771744564896;11703.590374336858;12153.210041347638;12201.267923924594;12249.877501224873 12:44:03 INFO - PROCESS | 1655 | |3;mootools.html;1479.778033295006;1508.3514088941754;1687.6877777611135;1842.4104286628285;1880.971785423219;7790.065192176932;8109.95945020274;8299.958500207498;8981.461112333265;8989.550522473883;7893.723719669798;8147;8196.426250162476;8226.753197404087;8599.699010534632;2364.1725396111397;2374.833761636686;2400.219928523237;2400.255920664591;2402.423418379594;1724.801647810499;2155.7736437674052;2237.8139586019356;2340.9648855267183;2366.7278262999716;2090.216168936649;2111.3032699209225;2297.689811875392;2359.7994170495526;2359.8230132740027;2356.15178535727;2370.0638247892157;2371.264907878563;2372.857628542284;2378.1319818266206;2320.7679232076825;2354.764523547649;2365.207655435431;2369.8104151667826;2372.3357459911253;8765.561721913942;8829.161229683234;8895;8945.373823832335;8967.237784788302;5104.693718376872;5302.867428314285;5333.173358129496;5334.333208348957;5366.70483123428;3429.7084747796466;3473.89578312651;3615.2407994321225;3640.4721315409383;3650.5254316938895;1100.5047728522197;1100.5377741348652;1101.4712937789907;1108.2187058124002;1124.7975364434399;11060.281081729661;11252.38111903845;11508.884911150864;11517.136214783925;11544.88455115455;4511.030128522383;4532.410786597721;4661.836835710734;4720.811167553328;4820.204666230033;9830.361026533252;9851.802963940681;9855.90144098564;9921.603135874628;9942.652007179713;4538.591526762607;5331.226972089103;5332.33345831771;5345.198220266913;5371.435999220103;4716.504766999485;4728.787204575733;4740.099381117577;4768.713877167381;4833.540813622771;3533.222691007974;3783.5811570661003;3887.028242939265;3945.2898478273614;4059.4316795648633;1265.329375431023;1269.149669721289;1273.8216649669055;1291.6577107066635;1292.8965682745359;627.6547898655721;790.4862188908177;890.4835195586544;928.4707716601607;948.2556193388295;5854.121881717691;5881.882362352729;5910.290765108214;6022.909656355158;6048.6673232971725;894.088030209196;903.4037535226719;933.8879334479906;946.7443790176613;966.7148191283588;3842.3852183651043;4014.498187726534;4025.5169379674626;4114.321137012359;4141.254574176617;8493.447925884797;10697;10968.561257549609;10978.505967231495;11049.33703977764;10690.305130166515;10710.678679639623;10802.135829133651;10915.017648411682;10942.507587158438;8184.345252379914;8298.502089874626;8335.583220838933;8348;8399.328053755686;5274.7098909560345;5299.284596579567;5667.008273552195;5689.444934619346;5797.188393624811;9899.950500247453;9959.452230127412;9976.950115249378;10209.54057067419;10239.897601023895;10031;10175.236857235885;10193.949030254802;10214;10280.897191028293;7093.609851458219;7295.963520182578;7336.926630733625;7360.411167106726;7464.738734144279;8015.959920200362;8171.387145964195;8174.346052315682;8201.83596328082;8281.54451505173;7588.8482230356185;7589.3549048329305;7631.847363052819;7632.236776322324;7747.57388343624;6171.876562468815;7433.8884916727375;7611.771646850603;7664.3485303747575;7699.153093159636;6692.196936367667;6847.589144651138;7009.12385951756;7016.158061032709;7019.122609673791;4741.454732705645;4776.331313616027;4786.114568804782;4952.587969010163;5007.47421520735;4844.491328410607;5019.799208031638;5083.1358669027095;5127.666701664529;5254.710990895537 12:44:03 INFO - PROCESS | 1655 | |4;prototype.html;298.63566448932295;302.6897430134113;312.2194513715711;313.9497680371141;317.32726619566523;4805.975970120153;5438.83683489495;5492.697901615409;5547.140193270039;5595.49640532353;5153.587712982961;5240.528352448279;5374.543163831079;5397.355295905008;5554.611177217596;3465.2549701814105;4121.855735049274;4121.876343709693;4131.690123240754;4136.8965775855695;3534.4521599152044;3823.541175058983;4131.326812640886;4178.665706743468;4196.559361267069;3939.3303138466385;4097.364908439182;4101.856435024774;4186.434831297766;4195.664346852244;3735.3836616958306;4192.937105943413;4198.9370159447635;4212.726172798758;4274.636655884223;2810.9859450702616;3431.279431319426;3666.7799932004164;3678.1540245743363;3687.115092377837;4428.800703968329;4626.514216007338;4701.623870090384;5419.620626556142;5431.293931788842;4353.782310884443;4675.532446755331;4717.599004084657;4776.49846766088;4824.734639594821;4765.0231702500905;4818.951810481885;5685.886282274331;5754.510866576346;5803.883922321572;3363.6131844837914;3922.411638254256;3977.732692365324;3993.381025940984;4034.9394759078637;5027.773750181214;5474.507294343528;5512.629569285205;6030.819075427744;6075.301340345873;4075.8573449929704;4087.61167689075;4090.979545102315;4109.753414795062;4128.814203360856;3487.3897068013;3848.9230215396096;4144.896377590524;4189.491782958133;4205.537390887;4115.7324773890205;4225.852095176654;4575.725456472623;4800.759962001886;4816.036792641486;5231.227449451797;5466.671999680032;5759.280089988752;5796.058320462608;5799.9130013049835;1193.3317342288346;1211.3398197982121;1409.189715913354;1420.9502667406591;1428.4001917852072;766.5477368352699;803.8512875118005;821.9766390843438;913.4427998920653;935.462109287149;4070.2673518766906;4489.281714925596;4500.257457519538;4513.81944722214;4603.976980115078;4763.737994410271;4816.325714399987;4956.727379994135;4975.751212439363;5036.471170527115;4170.4995400552125;4326.502452217972;4524.8416305429155;4800.639952003614;5476.507114359727;2753.485582929381;3075.646300675451;3116.532520122;3121.859516321771;3129.5775070365667;5811.535077193815;5958.940410595838;6143.928035982009;6203.96898015507;6316.873662526724;4942.308076869242;5107.974460127675;5653.575981801381;6003.787973434191;6053.697315134225;4918.5327393896805;5815.5929084963645;6131.540134489931;6166.383361663888;6210;4963.478834722447;5139.92290115656;5907.49786268172;5944;5972.492338151305;5055.6713813602;5496.615236933536;5781.566382521243;5835.270591176103;5848.795292164754;5387.353517577916;5955.622274223441;6106.786262480792;6197.349278325892;6218.533609979179;3445.517627532198;3806.4290356446754;3908.843646254118;3919.9620294272167;3919.980400097981;5529.225908372911;5817.883642327214;5851;5863.394012682255;5915.822525324247;4950.8762280943265;5412.3196226566315;5791.102379131242;5798.76804927815;5813.215215945793;5090.796368145381;5187.377514698261;5521.309836270466;5655.293088363955;5694;4629.814807407666;5024.924626130684;5134.793323568883;5561.6663000220115;5570.607348162959;4834;5291.809342897817;5555.333359996826;5629.211910332639;5713.971430142823;5625.718714064362;5630.296212973379;5634.464725851038;5634.74643641029;5636.210930469655 12:44:03 INFO - PROCESS | 1655 | |5;yui.html;603.5828439753215;697.9948873621984;787.7636708987307;792.8017995501125;818.9344852411807;15140.697186056272;15403.768943465857;16106;16120.838791612081;16589.585260368498;14577.781333280009;14922.552323430287;14923.328450219738;14949.177795221258;14962.17708026058;825.7729124490753;837.204655577201;837.4347315561971;840.4537050916891;840.9075001749802;677.4648028057828;700.0549258501034;702.6170736948376;824.6701319472199;841.7474757572734;885.3669626217253;889.2530274569393;889.8264838356523;892.2460520859895;893.4326702543866;888.7111688701198;889.7241855024898;889.7286327670058;889.7553172877479;890.7283278600024;519.8908229271857;537.1084000559092;646.214848958513;660.191265699519;661.4708233413251;15034.473793417288;15094.698106037928;15103.244837758179;15110.320035598425;15147;13592;13831.446742130303;13908.791368129487;13992.440302387893;14146.85853141476;10236.43699596522;12341.259524428473;12587.055970802227;12713.491460341575;12912.806307905388;4413.227685155117;4563.155816174019;4621.3299071634765;4650.581447669692;4743.430788305391;120892.39553802263;123876;125149.37425312815;126614;128408;10515.789684206273;10871.728206794734;11011.174161937886;11181.664550063511;11233.10135189183;19494.415167544998;20091.69862452035;21016.159353625684;21269.78730212709;22297.331080067623;7887.526748395115;7922.405819563556;8009.199080091944;8168.469049511763;8220.671173153007;3869.806509674505;4175.728577642443;4176.749395036247;4184.686148538872;4220.767857767853;3566.5720113586017;3693.3351996640326;3723.1809002019513;3734.5891951885815;3747.5315585551807;598.0520874414016;615.4122812713847;616.2820314333751;625.7528276330823;672.5426709837358;557.5567423898011;562.7439515020737;612.295859761278;620.271181361898;621;8886;9316.301277404222;9389.62441502346;9443.480608566595;9467.632494046567;577.4773829684143;640.775728495023;652.9771457998947;661.8411581220472;677.4241894389729;4230.407742915994;4519.683622146418;4522.186006518792;4579.22153233951;4656.906861862743;105382;108505;135701;141339;147989;111618.44190779157;112263;113568;124338.37830810789;125285;98059;104285;104483;109436.452817737;112209.31686024716;9536.189423898768;9735.659251926148;9804.65683701067;9851.359661621971;9920.751981200528;62676.68661656663;62810;64090.99999999814;64858.02712959404;66119;78994.21005790099;95250;96279.037209627;100495;102571.48714256381;12097.516099355928;12358.196717213352;12673.366331683563;12701.93649031749;13134.277614731282;13717.588472345846;13794.991785731985;14634.341454634354;14814.851851481348;15139.697206055596;13050.412731426919;13223.933880330536;13740.312984350943;13747.106438081493;13820.239886806323;11458.885411146115;11460.713482163013;12904.290264035568;13108.606741797761;14112.435502579781;13033.413496392495;13128.868711313147;13130.146540474838;14357;14372.065815721944;9499.952500237454;10812.459377031275;10901.781964360827;11074.778504430027;11300.982911537672;9848.310618256653;10806.597480725728;11010.559577617127;11083.279586826831;11270.463270542927 12:44:03 INFO - PROCESS | 1655 | __end_tp_report 12:44:03 INFO - PROCESS | 1655 | __start_cc_report 12:44:03 INFO - PROCESS | 1655 | _x_x_mozilla_cycle_collect,1809 12:44:03 INFO - PROCESS | 1655 | __end_cc_report 12:44:03 INFO - PROCESS | 1655 | __startTimestamp1477683843128__endTimestamp 12:44:03 INFO - PROCESS | 1655 | 12:44:03 INFO - PROCESS | 1655 | ------- Summary: start ------- 12:44:03 INFO - PROCESS | 1655 | Number of tests: 6 12:44:03 INFO - PROCESS | 1655 | 12:44:03 INFO - PROCESS | 1655 | [#0] dojo.html Cycles:165 Average:5753.20 Median:5930.08 stddev:651.49 (11.0%) stddev-sans-first:614.55 12:44:03 INFO - PROCESS | 1655 | Values: 2924.9 3322.7 3382.2 3404.7 3419.3 5655.7 5709.9 5732.5 5737.8 5752.2 5625.9 5630.1 5700.7 5722.3 5723.5 5208.0 5216.6 5217.5 5232.1 5288.9 5183.6 5193.3 5202.4 5296.2 5321.3 5298.3 5307.8 5318.7 5321.3 5326.0 5293.0 5296.7 5322.8 5341.0 5362.3 5173.7 5242.6 5248.9 5289.3 5350.8 5848.4 5902.5 5909.3 5923.9 5930.1 6101.9 6132.9 6292.3 6326.0 6337.9 6039.5 6108.3 6252.1 6270.5 6344.1 5784.8 5830.9 5845.9 5850.0 5863.7 6282.8 6331.0 6336.7 6354.6 6356.5 6017.7 6096.7 6114.8 6133.1 6163.8 6269.2 6326.1 6326.5 6342.4 6343.1 6057.3 6226.6 6258.1 6259.2 6260.3 6058.3 6128.8 6181.1 6183.1 6216.3 4931.7 4937.9 4952.5 4956.3 4970.7 4442.2 4443.2 4449.4 4452.2 4484.0 5627.1 5640.2 5685.5 5739.6 5743.9 6239.5 6335.5 6356.8 6372.3 6377.0 5788.2 5803.9 5813.4 5828.2 5862.6 5261.6 5286.8 5336.5 5389.1 5414.6 6249.8 6346.0 6358.7 6362.9 6376.1 6286.8 6305.1 6353.3 6380.0 6393.6 4846.7 6353.1 6356.0 6366.2 6386.2 6056.4 6231.5 6243.6 6244.5 6287.2 5277.9 6123.7 6127.9 6191.7 6201.1 4987.9 6103.4 6187.2 6194.4 6215.8 6008.8 6126.7 6147.7 6173.3 6184.3 5769.9 5826.4 5850.6 5972.9 5997.2 5969.8 6074.9 6092.9 6120.0 6127.7 5914.6 5925.8 5935.7 5943.5 5982.7 12:44:03 INFO - PROCESS | 1655 | 12:44:03 INFO - PROCESS | 1655 | [#1] ext.html Cycles:180 Average:74755.15 Median:38256.24 stddev:168640.19 (440.8%) stddev-sans-first:169021.06 12:44:03 INFO - PROCESS | 1655 | Values: 478.4 522.8 533.1 534.5 541.6 30130.2 40051.0 40990.4 41260.0 41327.2 42261.6 42714.8 42718.0 42841.6 42919.1 9733.2 9934.7 9935.0 9937.0 9969.9 8885.9 9121.9 9121.9 9123.5 9131.4 11940.1 12197.6 12219.7 12411.9 12435.6 12096.3 12184.2 12188.4 12194.0 12204.5 8701.3 8916.3 11950.6 12068.0 12068.6 31942.9 32223.7 32389.7 39576.8 39639.6 3342.1 3402.6 3678.3 3689.1 3945.7 29637.0 30007.2 30202.7 30878.2 31960.2 3177.5 3258.3 3259.3 3267.1 3344.2 517973.0 526139.0 528702.4 529567.0 529678.0 53563.7 54857.0 62163.7 62579.0 63246.1 62850.4 65233.0 65949.3 65999.7 66133.3 16934.9 17071.5 17107.4 17145.7 17224.5 13130.1 13229.7 13241.3 13260.1 13274.6 16357.5 16683.3 16706.2 19062.5 19152.7 7501.5 7648.2 7697.9 7745.0 7787.4 889.7 927.1 956.0 977.4 1004.4 29687.0 29837.0 30185.0 30186.4 30197.7 1044.3 1052.0 1069.5 1086.7 1116.6 15056.0 15424.5 15474.1 15814.9 15846.5 725472.0 730975.0 732598.0 733617.0 735543.0 49111.0 50086.5 55944.4 57075.0 57363.7 1127.7 1352.4 1394.8 1395.5 1397.9 29279.0 29687.4 30664.8 30679.5 30707.5 49965.8 50413.7 50431.0 50460.7 50633.0 555638.0 624515.0 625178.0 627332.0 627500.0 26188.5 26621.9 26664.3 26669.5 26678.0 46696.0 46821.8 47143.0 47855.0 48398.0 38196.2 38290.6 38904.8 38929.0 40359.0 38008.8 38351.6 38420.6 38493.6 38720.2 37403.4 38221.9 38605.0 38706.4 39116.8 30809.5 33297.5 34363.0 34785.5 34809.8 25117.5 25492.6 25597.5 25929.6 25973.4 12:44:03 INFO - PROCESS | 1655 | 12:44:03 INFO - PROCESS | 1655 | [#2] jquery.html Cycles:180 Average:35019.90 Median:12174.64 stddev:100083.96 (822.1%) stddev-sans-first:100330.82 12:44:03 INFO - PROCESS | 1655 | Values: 326.3 347.9 371.0 374.6 400.1 14331.4 15438.0 16165.2 17732.4 20931.6 20156.9 20644.8 21425.3 21498.4 21769.0 5719.8 5885.9 6161.2 6169.4 6172.8 5541.4 5771.3 6059.0 6100.6 6109.6 5764.9 6042.8 6048.2 6056.1 6059.5 5917.3 5990.4 5998.2 6003.5 6004.4 5218.8 5225.6 5230.6 5448.8 5515.9 12793.2 12862.6 12911.9 13027.9 13054.5 1920.0 2243.5 2337.3 2367.2 2408.5 9463.2 9492.5 9884.0 10041.5 10207.7 1590.7 1751.5 1755.4 1795.3 1894.8 120795.4 121863.0 123207.0 124612.0 124883.0 11118.7 11180.4 11214.3 11275.5 11568.3 14153.4 14154.4 14157.0 14161.8 14189.2 6852.8 8542.4 8584.0 8691.6 8708.0 6969.4 6986.4 7078.4 8572.9 8745.7 4347.4 4383.9 4397.7 4408.3 4458.3 1739.3 1829.5 1877.8 1878.9 1893.6 872.1 885.8 920.7 924.0 953.9 21413.8 21936.8 21981.4 22027.4 22105.8 926.9 928.8 940.9 948.8 990.9 10447.8 11209.8 11269.4 11304.0 11319.8 590955.0 592251.0 598868.0 603725.0 608308.0 90145.6 123504.0 127378.0 133855.0 134441.3 803.9 954.3 972.9 989.5 994.1 18876.7 20110.9 20284.7 20312.0 20330.5 57030.6 59585.7 59990.4 60004.0 60189.0 75639.6 82406.0 83371.2 84493.2 85636.1 6771.5 7973.5 8081.9 8223.3 8259.8 11270.8 12864.4 12913.9 13143.5 13423.9 11160.2 11402.5 11484.0 11548.4 11649.8 10862.6 11142.4 11144.4 11258.4 11535.8 10150.6 11189.3 11215.4 11322.7 11427.1 8194.5 11842.8 11893.4 11947.3 12437.4 11412.8 11703.6 12153.2 12201.3 12249.9 12:44:03 INFO - PROCESS | 1655 | 12:44:03 INFO - PROCESS | 1655 | [#3] mootools.html Cycles:180 Average:5666.86 Median:4898.54 stddev:3179.80 (64.9%) stddev-sans-first:3173.15 12:44:03 INFO - PROCESS | 1655 | Values: 1479.8 1508.4 1687.7 1842.4 1881.0 7790.1 8110.0 8300.0 8981.5 8989.6 7893.7 8147.0 8196.4 8226.8 8599.7 2364.2 2374.8 2400.2 2400.3 2402.4 1724.8 2155.8 2237.8 2341.0 2366.7 2090.2 2111.3 2297.7 2359.8 2359.8 2356.2 2370.1 2371.3 2372.9 2378.1 2320.8 2354.8 2365.2 2369.8 2372.3 8765.6 8829.2 8895.0 8945.4 8967.2 5104.7 5302.9 5333.2 5334.3 5366.7 3429.7 3473.9 3615.2 3640.5 3650.5 1100.5 1100.5 1101.5 1108.2 1124.8 11060.3 11252.4 11508.9 11517.1 11544.9 4511.0 4532.4 4661.8 4720.8 4820.2 9830.4 9851.8 9855.9 9921.6 9942.7 4538.6 5331.2 5332.3 5345.2 5371.4 4716.5 4728.8 4740.1 4768.7 4833.5 3533.2 3783.6 3887.0 3945.3 4059.4 1265.3 1269.1 1273.8 1291.7 1292.9 627.7 790.5 890.5 928.5 948.3 5854.1 5881.9 5910.3 6022.9 6048.7 894.1 903.4 933.9 946.7 966.7 3842.4 4014.5 4025.5 4114.3 4141.3 8493.4 10697.0 10968.6 10978.5 11049.3 10690.3 10710.7 10802.1 10915.0 10942.5 8184.3 8298.5 8335.6 8348.0 8399.3 5274.7 5299.3 5667.0 5689.4 5797.2 9900.0 9959.5 9977.0 10209.5 10239.9 10031.0 10175.2 10193.9 10214.0 10280.9 7093.6 7296.0 7336.9 7360.4 7464.7 8016.0 8171.4 8174.3 8201.8 8281.5 7588.8 7589.4 7631.8 7632.2 7747.6 6171.9 7433.9 7611.8 7664.3 7699.2 6692.2 6847.6 7009.1 7016.2 7019.1 4741.5 4776.3 4786.1 4952.6 5007.5 4844.5 5019.8 5083.1 5127.7 5254.7 12:44:03 INFO - PROCESS | 1655 | 12:44:03 INFO - PROCESS | 1655 | [#4] prototype.html Cycles:180 Average:4555.16 Median:4946.59 stddev:1402.63 (28.4%) stddev-sans-first:1369.69 12:44:03 INFO - PROCESS | 1655 | Values: 298.6 302.7 312.2 313.9 317.3 4806.0 5438.8 5492.7 5547.1 5595.5 5153.6 5240.5 5374.5 5397.4 5554.6 3465.3 4121.9 4121.9 4131.7 4136.9 3534.5 3823.5 4131.3 4178.7 4196.6 3939.3 4097.4 4101.9 4186.4 4195.7 3735.4 4192.9 4198.9 4212.7 4274.6 2811.0 3431.3 3666.8 3678.2 3687.1 4428.8 4626.5 4701.6 5419.6 5431.3 4353.8 4675.5 4717.6 4776.5 4824.7 4765.0 4819.0 5685.9 5754.5 5803.9 3363.6 3922.4 3977.7 3993.4 4034.9 5027.8 5474.5 5512.6 6030.8 6075.3 4075.9 4087.6 4091.0 4109.8 4128.8 3487.4 3848.9 4144.9 4189.5 4205.5 4115.7 4225.9 4575.7 4800.8 4816.0 5231.2 5466.7 5759.3 5796.1 5799.9 1193.3 1211.3 1409.2 1421.0 1428.4 766.5 803.9 822.0 913.4 935.5 4070.3 4489.3 4500.3 4513.8 4604.0 4763.7 4816.3 4956.7 4975.8 5036.5 4170.5 4326.5 4524.8 4800.6 5476.5 2753.5 3075.6 3116.5 3121.9 3129.6 5811.5 5958.9 6143.9 6204.0 6316.9 4942.3 5108.0 5653.6 6003.8 6053.7 4918.5 5815.6 6131.5 6166.4 6210.0 4963.5 5139.9 5907.5 5944.0 5972.5 5055.7 5496.6 5781.6 5835.3 5848.8 5387.4 5955.6 6106.8 6197.3 6218.5 3445.5 3806.4 3908.8 3920.0 3920.0 5529.2 5817.9 5851.0 5863.4 5915.8 4950.9 5412.3 5791.1 5798.8 5813.2 5090.8 5187.4 5521.3 5655.3 5694.0 4629.8 5024.9 5134.8 5561.7 5570.6 4834.0 5291.8 5555.3 5629.2 5714.0 5625.7 5630.3 5634.5 5634.7 5636.2 12:44:03 INFO - PROCESS | 1655 | 12:44:03 INFO - PROCESS | 1655 | [#5] yui.html Cycles:180 Average:24368.44 Median:3708.26 stddev:38150.38 (1028.8%) stddev-sans-first:38215.67 12:44:03 INFO - PROCESS | 1655 | Values: 603.6 698.0 787.8 792.8 818.9 15140.7 15403.8 16106.0 16120.8 16589.6 14577.8 14922.6 14923.3 14949.2 14962.2 825.8 837.2 837.4 840.5 840.9 677.5 700.1 702.6 824.7 841.7 885.4 889.3 889.8 892.2 893.4 888.7 889.7 889.7 889.8 890.7 519.9 537.1 646.2 660.2 661.5 15034.5 15094.7 15103.2 15110.3 15147.0 13592.0 13831.4 13908.8 13992.4 14146.9 10236.4 12341.3 12587.1 12713.5 12912.8 4413.2 4563.2 4621.3 4650.6 4743.4 120892.4 123876.0 125149.4 126614.0 128408.0 10515.8 10871.7 11011.2 11181.7 11233.1 19494.4 20091.7 21016.2 21269.8 22297.3 7887.5 7922.4 8009.2 8168.5 8220.7 3869.8 4175.7 4176.7 4184.7 4220.8 3566.6 3693.3 3723.2 3734.6 3747.5 598.1 615.4 616.3 625.8 672.5 557.6 562.7 612.3 620.3 621.0 8886.0 9316.3 9389.6 9443.5 9467.6 577.5 640.8 653.0 661.8 677.4 4230.4 4519.7 4522.2 4579.2 4656.9 105382.0 108505.0 135701.0 141339.0 147989.0 111618.4 112263.0 113568.0 124338.4 125285.0 98059.0 104285.0 104483.0 109436.5 112209.3 9536.2 9735.7 9804.7 9851.4 9920.8 62676.7 62810.0 64091.0 64858.0 66119.0 78994.2 95250.0 96279.0 100495.0 102571.5 12097.5 12358.2 12673.4 12701.9 13134.3 13717.6 13795.0 14634.3 14814.9 15139.7 13050.4 13223.9 13740.3 13747.1 13820.2 11458.9 11460.7 12904.3 13108.6 14112.4 13033.4 13128.9 13130.1 14357.0 14372.1 9500.0 10812.5 10901.8 11074.8 11301.0 9848.3 10806.6 11010.6 11083.3 11270.5 12:44:03 INFO - PROCESS | 1655 | -------- Summary: end -------- 12:44:03 INFO - PROCESS | 1655 | 12:44:03 INFO - TEST-INFO | 1655: exit 0 12:44:03 INFO - TEST-OK | dromaeo_css | took 1117838ms 12:44:03 INFO - TEST-START | kraken 12:44:03 INFO - operating with platform_type : mac_ 12:44:03 INFO - Initialising browser for kraken test... 12:44:03 INFO - TEST-INFO | started process 1665 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/tmpxHW6GI/profile http://localhost:49274/getInfo.html) 12:44:06 INFO - PROCESS | 1665 | __metrics Screen width/height:1600/1200 12:44:06 INFO - PROCESS | 1665 | colorDepth:24 12:44:06 INFO - PROCESS | 1665 | Browser inner width/height: 1024/689 12:44:06 INFO - PROCESS | 1665 | __metrics 12:44:06 INFO - PROCESS | 1665 | 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" 12:44:06 INFO - PROCESS | 1665 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:44:06 INFO - TEST-INFO | 1665: exit 0 12:44:06 INFO - Browser initialized. 12:44:06 INFO - Running cycle 1/1 for kraken test... 12:44:06 INFO - TEST-INFO | started process 1666 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/tmpxHW6GI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:44:19 INFO - PROCESS | 1666 | RSS: Main: 219865088 12:44:19 INFO - PROCESS | 1666 | 12:44:21 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-beat-detection) 12:44:22 INFO - PROCESS | 1666 | RSS: Main: 270430208 12:44:22 INFO - PROCESS | 1666 | 12:44:25 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-dft) 12:44:26 INFO - PROCESS | 1666 | RSS: Main: 281882624 12:44:26 INFO - PROCESS | 1666 | 12:44:29 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-fft) 12:44:29 INFO - PROCESS | 1666 | RSS: Main: 375816192 12:44:29 INFO - PROCESS | 1666 | 12:44:31 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-oscillator) 12:44:32 INFO - PROCESS | 1666 | RSS: Main: 280522752 12:44:32 INFO - PROCESS | 1666 | 12:44:34 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:44:34 INFO - PROCESS | 1666 | RSS: Main: 281194496 12:44:34 INFO - PROCESS | 1666 | 12:44:37 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-darkroom) 12:44:38 INFO - PROCESS | 1666 | RSS: Main: 318025728 12:44:38 INFO - PROCESS | 1666 | 12:44:41 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-desaturate) 12:44:41 INFO - PROCESS | 1666 | RSS: Main: 319725568 12:44:41 INFO - PROCESS | 1666 | 12:44:44 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49274/tests/kraken/driver.html?testName=json-parse-financial) 12:44:45 INFO - PROCESS | 1666 | RSS: Main: 317595648 12:44:45 INFO - PROCESS | 1666 | 12:44:46 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49274/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:44:47 INFO - PROCESS | 1666 | RSS: Main: 295448576 12:44:47 INFO - PROCESS | 1666 | 12:44:49 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:44:50 INFO - PROCESS | 1666 | RSS: Main: 299872256 12:44:50 INFO - PROCESS | 1666 | 12:44:52 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:44:52 INFO - PROCESS | 1666 | RSS: Main: 306122752 12:44:52 INFO - PROCESS | 1666 | 12:44:55 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:44:56 INFO - PROCESS | 1666 | RSS: Main: 311287808 12:44:56 INFO - PROCESS | 1666 | 12:44:59 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:44:59 INFO - PROCESS | 1666 | RSS: Main: 311169024 12:44:59 INFO - PROCESS | 1666 | 12:45:01 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49274/tests/kraken/driver.html?testName=ai-astar) 12:45:01 INFO - PROCESS | 1666 | RSS: Main: 355651584 12:45:01 INFO - PROCESS | 1666 | 12:45:01 INFO - PROCESS | 1666 | __start_tp_report 12:45:01 INFO - PROCESS | 1666 | _x_x_mozilla_page_load 12:45:01 INFO - PROCESS | 1666 | _x_x_mozilla_page_load_details 12:45:01 INFO - PROCESS | 1666 | |i|pagename|runs| 12:45:01 INFO - PROCESS | 1666 | |0;ai-astar;116;116;116;115;115;116;115;113;115;115 12:45:01 INFO - PROCESS | 1666 | |1;audio-beat-detection;144;109;108;142;118;139;115;108;141;107 12:45:01 INFO - PROCESS | 1666 | |2;audio-dft;183;182;183;182;182;185;183;184;183;186 12:45:01 INFO - PROCESS | 1666 | |3;audio-fft;81;59;59;89;61;60;58;58;82;58 12:45:01 INFO - PROCESS | 1666 | |4;audio-oscillator;87;72;96;69;68;70;93;67;68;90 12:45:01 INFO - PROCESS | 1666 | |5;imaging-gaussian-blur;85;83;86;83;89;124;86;83;85;83 12:45:01 INFO - PROCESS | 1666 | |6;imaging-darkroom;96;95;132;156;94;95;94;95;95;94 12:45:01 INFO - PROCESS | 1666 | |7;imaging-desaturate;84;86;85;86;83;84;86;82;84;83 12:45:01 INFO - PROCESS | 1666 | |8;json-parse-financial;55;54;56;75;88;88;87;57;56;55 12:45:01 INFO - PROCESS | 1666 | |9;json-stringify-tinderbox;71;67;67;74;71;69;69;69;70;70 12:45:01 INFO - PROCESS | 1666 | |10;stanford-crypto-aes;83;99;81;84;81;84;80;83;85;88 12:45:01 INFO - PROCESS | 1666 | |11;stanford-crypto-ccm;150;146;146;137;134;138;142;141;170;139 12:45:01 INFO - PROCESS | 1666 | |12;stanford-crypto-pbkdf2;166;164;165;165;166;167;164;164;165;165 12:45:01 INFO - PROCESS | 1666 | |13;stanford-crypto-sha256-iterative;67;67;67;66;66;66;67;66;66;67 12:45:01 INFO - PROCESS | 1666 | __end_tp_report 12:45:01 INFO - PROCESS | 1666 | __start_cc_report 12:45:01 INFO - PROCESS | 1666 | _x_x_mozilla_cycle_collect,1970 12:45:01 INFO - PROCESS | 1666 | __end_cc_report 12:45:01 INFO - PROCESS | 1666 | __startTimestamp1477683901844__endTimestamp 12:45:01 INFO - PROCESS | 1666 | 12:45:01 INFO - PROCESS | 1666 | ------- Summary: start ------- 12:45:01 INFO - PROCESS | 1666 | Number of tests: 14 12:45:01 INFO - PROCESS | 1666 | 12:45:01 INFO - PROCESS | 1666 | [#0] ai-astar Cycles:10 Average:115.20 Median:115.50 stddev:0.92 (0.8%) stddev-sans-first:0.93 12:45:01 INFO - PROCESS | 1666 | Values: 116.0 116.0 116.0 115.0 115.0 116.0 115.0 113.0 115.0 115.0 12:45:01 INFO - PROCESS | 1666 | 12:45:01 INFO - PROCESS | 1666 | [#1] audio-beat-detection Cycles:10 Average:123.10 Median:128.50 stddev:16.24 (12.6%) stddev-sans-first:15.36 12:45:01 INFO - PROCESS | 1666 | Values: 144.0 109.0 108.0 142.0 118.0 139.0 115.0 108.0 141.0 107.0 12:45:01 INFO - PROCESS | 1666 | 12:45:01 INFO - PROCESS | 1666 | [#2] audio-dft Cycles:10 Average:183.30 Median:183.00 stddev:1.34 (0.7%) stddev-sans-first:1.41 12:45:01 INFO - PROCESS | 1666 | Values: 183.0 182.0 183.0 182.0 182.0 185.0 183.0 184.0 183.0 186.0 12:45:01 INFO - PROCESS | 1666 | 12:45:01 INFO - PROCESS | 1666 | [#3] audio-fft Cycles:10 Average:66.50 Median:60.50 stddev:12.29 (20.3%) stddev-sans-first:11.86 12:45:01 INFO - PROCESS | 1666 | Values: 81.0 59.0 59.0 89.0 61.0 60.0 58.0 58.0 82.0 58.0 12:45:01 INFO - PROCESS | 1666 | 12:45:01 INFO - PROCESS | 1666 | [#4] audio-oscillator Cycles:10 Average:78.00 Median:79.50 stddev:11.91 (15.0%) stddev-sans-first:12.18 12:45:01 INFO - PROCESS | 1666 | Values: 87.0 72.0 96.0 69.0 68.0 70.0 93.0 67.0 68.0 90.0 12:45:01 INFO - PROCESS | 1666 | 12:45:01 INFO - PROCESS | 1666 | [#5] imaging-gaussian-blur Cycles:10 Average:88.70 Median:85.00 stddev:12.55 (14.8%) stddev-sans-first:13.24 12:45:01 INFO - PROCESS | 1666 | Values: 85.0 83.0 86.0 83.0 89.0 124.0 86.0 83.0 85.0 83.0 12:45:01 INFO - PROCESS | 1666 | 12:45:01 INFO - PROCESS | 1666 | [#6] imaging-darkroom Cycles:10 Average:104.60 Median:95.00 stddev:21.53 (22.7%) stddev-sans-first:22.61 12:45:01 INFO - PROCESS | 1666 | Values: 96.0 95.0 132.0 156.0 94.0 95.0 94.0 95.0 95.0 94.0 12:45:01 INFO - PROCESS | 1666 | 12:45:01 INFO - PROCESS | 1666 | [#7] imaging-desaturate Cycles:10 Average:84.30 Median:84.50 stddev:1.42 (1.7%) stddev-sans-first:1.50 12:45:01 INFO - PROCESS | 1666 | Values: 84.0 86.0 85.0 86.0 83.0 84.0 86.0 82.0 84.0 83.0 12:45:01 INFO - PROCESS | 1666 | 12:45:01 INFO - PROCESS | 1666 | [#8] json-parse-financial Cycles:10 Average:67.10 Median:66.00 stddev:15.44 (23.4%) stddev-sans-first:15.74 12:45:01 INFO - PROCESS | 1666 | Values: 55.0 54.0 56.0 75.0 88.0 88.0 87.0 57.0 56.0 55.0 12:45:01 INFO - PROCESS | 1666 | 12:45:01 INFO - PROCESS | 1666 | [#9] json-stringify-tinderbox Cycles:10 Average:69.70 Median:70.00 stddev:2.06 (2.9%) stddev-sans-first:2.13 12:45:01 INFO - PROCESS | 1666 | Values: 71.0 67.0 67.0 74.0 71.0 69.0 69.0 69.0 70.0 70.0 12:45:01 INFO - PROCESS | 1666 | 12:45:01 INFO - PROCESS | 1666 | [#10] stanford-crypto-aes Cycles:10 Average:84.80 Median:84.00 stddev:5.49 (6.5%) stddev-sans-first:5.79 12:45:01 INFO - PROCESS | 1666 | Values: 83.0 99.0 81.0 84.0 81.0 84.0 80.0 83.0 85.0 88.0 12:45:01 INFO - PROCESS | 1666 | 12:45:01 INFO - PROCESS | 1666 | [#11] stanford-crypto-ccm Cycles:10 Average:144.30 Median:144.00 stddev:10.23 (7.1%) stddev-sans-first:10.64 12:45:01 INFO - PROCESS | 1666 | Values: 150.0 146.0 146.0 137.0 134.0 138.0 142.0 141.0 170.0 139.0 12:45:01 INFO - PROCESS | 1666 | 12:45:01 INFO - PROCESS | 1666 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.10 Median:165.00 stddev:0.99 (0.6%) stddev-sans-first:1.00 12:45:01 INFO - PROCESS | 1666 | Values: 166.0 164.0 165.0 165.0 166.0 167.0 164.0 164.0 165.0 165.0 12:45:01 INFO - PROCESS | 1666 | 12:45:01 INFO - PROCESS | 1666 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.50 Median:67.00 stddev:0.53 (0.8%) stddev-sans-first:0.53 12:45:01 INFO - PROCESS | 1666 | Values: 67.0 67.0 67.0 66.0 66.0 66.0 67.0 66.0 66.0 67.0 12:45:01 INFO - PROCESS | 1666 | -------- Summary: end -------- 12:45:01 INFO - PROCESS | 1666 | 12:45:02 INFO - TEST-INFO | 1666: exit 0 12:45:02 INFO - TEST-OK | kraken | took 58993ms 12:45:02 INFO - SUITE-END | took 1176s 12:45:02 INFO - Completed test suite (00:19:37) 12:45:02 INFO - javascript benchmark 12:45:03 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2924.8976285829995, 3322.734181265498, 3382.2389962258494, 3404.6935775780207, 3419.264858055519, 5655.660660360381, 5709.914351284734, 5732.541396688265, 5737.770489180428, 5752.223449834271, 5625.887482250352, 5630.071038278679, 5700.6579605223615, 5722.256106706122, 5723.5135013523795, 5207.973960130194, 5216.60875434344, 5217.47825217479, 5232.058229518695, 5288.867778305554, 5183.637145399824, 5193.298904647862, 5202.375714914216, 5296.179092240709, 5321.281626980347, 5298.258243845865, 5307.814226502073, 5318.734063296839, 5321.308229930123, 5326.0, 5293.04725149473, 5296.682199068049, 5322.760475778599, 5341.0, 5362.276092727471, 5173.689578625294, 5242.60680448964, 5248.947510524884, 5289.338832645919, 5350.812721554766, 5848.41515848416, 5902.468777809975, 5909.320428150775, 5923.911141332884, 5930.0808374701555, 6101.938980610182, 6132.877342453171, 6292.276388215368, 6326.0, 6337.87324253517, 6039.486643635296, 6108.2813625860135, 6252.093446450284, 6270.46701030413, 6344.1435406220035, 5784.754254811526, 5830.912536312001, 5845.853853653608, 5849.970750146222, 5863.736131874076, 6282.780102696383, 6331.0, 6336.714847831859, 6354.618722876642, 6356.523260755462, 6017.669028203491, 6096.72564734588, 6114.816555503342, 6133.059244993061, 6163.768144879478, 6269.185005949197, 6326.145970293951, 6326.49388048955, 6342.365763423621, 6343.111964324999, 6057.303410107894, 6226.5641405101205, 6258.092576576462, 6259.1550140730415, 6260.342664020303, 6058.273007239071, 6128.80869161996, 6181.072839074175, 6183.072539119168, 6216.347283535254, 4931.654784165145, 4937.925931111036, 4952.455229924705, 4956.281339205795, 4970.701757894538, 4442.244818380883, 4443.222436073739, 4449.421575195204, 4452.243118669834, 4484.0, 5627.071533196977, 5640.153976903415, 5685.545156387479, 5739.569532285095, 5743.9425605744245, 6239.532035097386, 6335.524835637346, 6356.777512787123, 6372.299047104815, 6377.043443483514, 5788.160716696139, 5803.88392232153, 5813.447722466359, 5828.154917536934, 5862.560307976919, 5261.631685781958, 5286.788528458896, 5336.493033161921, 5389.083855744533, 5414.593905457106, 6249.843753906189, 6346.048092785934, 6358.650274234961, 6362.9045564316575, 6376.075469056868, 6286.811395658137, 6305.117283580211, 6353.332900045429, 6380.0, 6393.584417012879, 4846.731349612095, 6353.078803573363, 6356.0, 6366.172397588284, 6386.201724784402, 6056.394360563909, 6231.501479881689, 6243.562950593415, 6244.5316601256, 6287.2140982377205, 5277.920831187458, 6123.6631985239455, 6127.922628246779, 6191.690415479118, 6201.069839524108, 4987.852793857361, 6103.389661033861, 6187.195664563578, 6194.38056194377, 6215.751369945152, 6008.759649613967, 6126.663033533198, 6147.723352449061, 6173.259208894961, 6184.288806787277, 5769.91345129815, 5826.41735826414, 5850.64896106235, 5972.850678733066, 5997.160397544434, 5969.820905372846, 6074.939250607437, 6092.939070609415, 6120.0, 6127.724252408741, 5914.645121292736, 5925.792597259076, 5935.703214839327, 5943.4948029416255, 5982.7307771149535], "value": 5711.388969499969, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [478.40916468161794, 522.8405336372406, 533.0671325180933, 534.4655344655345, 541.591098720466, 30130.246743831416, 40051.0, 40990.38514422278, 41259.99999999996, 41327.17345653085, 42261.57738422615, 42714.786426067825, 42718.0, 42841.571584284146, 42919.14161716772, 9733.221342292618, 9934.65228716995, 9935.0, 9936.95661955495, 9969.850452243221, 8885.911140888573, 9121.863172052424, 9121.908780912205, 9123.452592844418, 9131.406458580204, 11940.104492163078, 12197.63407097784, 12219.694507637292, 12411.937940310287, 12435.564755233569, 12096.33470159141, 12184.208026478294, 12188.390580470941, 12194.024478041823, 12204.511819527208, 8701.260392866614, 8916.331275154389, 11950.641480755592, 12068.0, 12068.577599783965, 31942.88199913015, 32223.677763222302, 32389.6761032389, 39576.80211598952, 39639.60360396388, 3342.1143396999814, 3402.5576675032335, 3678.319510890494, 3689.1330537323706, 3945.6646185074305, 29637.0, 30007.249818754488, 30202.697973020207, 30878.22804429885, 31960.20099497508, 3177.4916013437737, 3258.266889949766, 3259.348130373911, 3267.1178781729036, 3344.1973926257765, 517973.0, 526139.0, 528702.356488219, 529567.0, 529678.0, 53563.6609084776, 54857.0, 62163.689181554706, 62579.0, 63246.051309230395, 62850.37149628445, 65233.0, 65949.34050659528, 65999.67000165065, 66133.33866661368, 16934.915325423295, 17071.487855364358, 17107.401240956508, 17145.657086858442, 17224.483265502055, 13130.146540474838, 13229.669258268428, 13241.3379331035, 13260.138091024053, 13274.601761947157, 16357.509274721777, 16683.33266669344, 16706.164691765363, 19062.523436914187, 19152.712709309373, 7501.549907005598, 7648.158702542716, 7697.884531732028, 7744.961275193588, 7787.415943804237, 889.7063968890251, 927.1331305229631, 955.9904400956041, 977.3549457358109, 1004.4224570871778, 29687.0, 29836.9557065506, 30185.0, 30186.396272074435, 30197.69802301993, 1044.3107549017611, 1051.984220236697, 1069.545443186658, 1086.652271273185, 1116.553378648531, 15056.0, 15424.537263881877, 15474.071555706694, 15814.892957492864, 15846.524604261891, 725472.0, 730975.0, 732598.0, 733617.0, 735543.0, 49111.0, 50086.49913500891, 55944.44055559474, 57075.0, 57363.71318143383, 1127.7293449572044, 1352.3914238592477, 1394.755917714396, 1395.483671041721, 1397.9161250325012, 29279.0, 29687.40625187441, 30664.84667576737, 30679.539806902467, 30707.539386908767, 49965.75017124891, 50413.73965650888, 50431.0, 50460.747696261285, 50633.0, 555638.0, 624515.0, 625178.0, 627332.0, 627500.0, 26188.476230474902, 26621.866890665424, 26664.333391665365, 26669.466610668067, 26678.0, 46696.0, 46821.765891171686, 47143.0, 47855.0, 48398.0, 38196.236075278895, 38290.6170938287, 38904.80547597244, 38929.0, 40359.0, 38008.80995595004, 38351.616483834805, 38420.6157938417, 38493.615063849, 38720.2255954885, 37403.43894841525, 38221.853344399715, 38605.03487412725, 38706.4194037084, 39116.804415977735, 30809.537856931714, 33297.50053749147, 34362.969110926715, 34785.47821782625, 34809.82595087009, 25117.49765004653, 25492.617610736226, 25597.488050238517, 25929.6110558338, 25973.350666233495], "value": 20409.008212784396, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [326.2642740619902, 347.8712876235793, 370.955485341759, 374.59169505239294, 400.0598593305732, 14331.355089020994, 15437.996530225542, 16165.191740412976, 17732.37936672217, 20931.581368372623, 20156.8992155039, 20644.79355206451, 21425.250116245934, 21498.355049348505, 21769.020394082265, 5719.828405147852, 5885.8822823543505, 6161.229846269216, 6169.383061693839, 6172.7530898764, 5541.362743284513, 5771.336296325913, 6059.030555111183, 6100.603460775058, 6109.602875813081, 5764.913526297109, 6042.818715438544, 6048.2137322148055, 6056.091586262052, 6059.515238780887, 5917.289925208981, 5990.430909063632, 5998.220231369894, 6003.549733769984, 6004.369541198199, 5218.843434696965, 5225.589090945461, 5230.607704422184, 5448.809291674773, 5515.917261241085, 12793.232406055666, 12862.614121576367, 12911.870881291161, 13027.86972130276, 13054.477820887154, 1919.9904000480049, 2243.4952135769486, 2337.2871274261342, 2367.171489978511, 2408.4821763320797, 9463.195628371597, 9492.477913714743, 9884.0, 10041.497925103715, 10207.693769186937, 1590.6956295837417, 1751.4920673004813, 1755.4119370010933, 1795.3267524678245, 1894.7536820213422, 120795.39602301932, 121863.0, 123207.0, 124612.0, 124883.0, 11118.666440006813, 11180.440977951233, 11214.327140371604, 11275.54897804095, 11568.305901645928, 14153.363098660586, 14154.433822647185, 14157.009009369245, 14161.78757318641, 14189.219592922282, 6852.828679283058, 8542.444741091933, 8584.0, 8691.565421728888, 8707.956460217658, 6969.4424446044195, 6986.371226589631, 7078.398336141383, 8572.871406928902, 8745.737627871174, 4347.413099231627, 4383.868483945486, 4397.670174736843, 4408.294672852328, 4458.286674132188, 1739.3129713762992, 1829.4785985993929, 1877.7840548336842, 1878.8966606836482, 1893.583411649435, 872.1060912564545, 885.7785553611598, 920.663957655451, 923.9676611318572, 953.8855337359422, 21413.80323932233, 21936.780632193473, 21981.41486810545, 22027.449313767283, 22105.778942210694, 926.9397489163183, 928.8281667891326, 940.8541676040225, 948.786523032326, 990.8513722941616, 10447.84328235077, 11209.775804484028, 11269.380184089954, 11304.03915667161, 11319.773604528027, 590955.0, 592251.0, 598868.0, 603725.0, 608308.0, 90145.64781528282, 123504.0, 127378.0, 133855.0, 134441.3277933604, 803.8593246182012, 954.3271993244746, 972.9270304727174, 989.5151375825938, 994.0705440413092, 18876.716849247547, 20110.89944550268, 20284.695729563773, 20312.0, 20330.491737706674, 57030.57423564444, 59585.702071489366, 59990.400095998484, 60004.0, 60189.0, 75639.62180189064, 82406.0, 83371.16628833876, 84493.15506844853, 85636.14363856282, 6771.52599318043, 7973.521588704696, 8081.878771818545, 8223.301019413178, 8259.752207433787, 11270.774584508428, 12864.356782161041, 12913.870861291643, 13143.474261029452, 13423.865761342262, 11160.218784684994, 11402.486888090221, 11483.966443020168, 11548.364839933884, 11649.825252621387, 10862.619808306672, 11142.387168705474, 11144.387058711525, 11258.38078905668, 11535.76928461443, 10150.644727434505, 11189.328640281608, 11215.439228038402, 11322.660320190407, 11427.142964277546, 8194.467359621605, 11842.82235766447, 11893.405329733305, 11947.342896140795, 12437.440315185657, 11412.771744564896, 11703.590374336858, 12153.210041347638, 12201.267923924594, 12249.877501224873], "value": 9432.07585181451, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1479.778033295006, 1508.3514088941754, 1687.6877777611135, 1842.4104286628285, 1880.971785423219, 7790.065192176932, 8109.95945020274, 8299.958500207498, 8981.461112333265, 8989.550522473883, 7893.723719669798, 8147.0, 8196.426250162476, 8226.753197404087, 8599.699010534632, 2364.1725396111397, 2374.833761636686, 2400.219928523237, 2400.255920664591, 2402.423418379594, 1724.801647810499, 2155.7736437674052, 2237.8139586019356, 2340.9648855267183, 2366.7278262999716, 2090.216168936649, 2111.3032699209225, 2297.689811875392, 2359.7994170495526, 2359.8230132740027, 2356.15178535727, 2370.0638247892157, 2371.264907878563, 2372.857628542284, 2378.1319818266206, 2320.7679232076825, 2354.764523547649, 2365.207655435431, 2369.8104151667826, 2372.3357459911253, 8765.561721913942, 8829.161229683234, 8895.0, 8945.373823832335, 8967.237784788302, 5104.693718376872, 5302.867428314285, 5333.173358129496, 5334.333208348957, 5366.70483123428, 3429.7084747796466, 3473.89578312651, 3615.2407994321225, 3640.4721315409383, 3650.5254316938895, 1100.5047728522197, 1100.5377741348652, 1101.4712937789907, 1108.2187058124002, 1124.7975364434399, 11060.281081729661, 11252.38111903845, 11508.884911150864, 11517.136214783925, 11544.88455115455, 4511.030128522383, 4532.410786597721, 4661.836835710734, 4720.811167553328, 4820.204666230033, 9830.361026533252, 9851.802963940681, 9855.90144098564, 9921.603135874628, 9942.652007179713, 4538.591526762607, 5331.226972089103, 5332.33345831771, 5345.198220266913, 5371.435999220103, 4716.504766999485, 4728.787204575733, 4740.099381117577, 4768.713877167381, 4833.540813622771, 3533.222691007974, 3783.5811570661003, 3887.028242939265, 3945.2898478273614, 4059.4316795648633, 1265.329375431023, 1269.149669721289, 1273.8216649669055, 1291.6577107066635, 1292.8965682745359, 627.6547898655721, 790.4862188908177, 890.4835195586544, 928.4707716601607, 948.2556193388295, 5854.121881717691, 5881.882362352729, 5910.290765108214, 6022.909656355158, 6048.6673232971725, 894.088030209196, 903.4037535226719, 933.8879334479906, 946.7443790176613, 966.7148191283588, 3842.3852183651043, 4014.498187726534, 4025.5169379674626, 4114.321137012359, 4141.254574176617, 8493.447925884797, 10697.0, 10968.561257549609, 10978.505967231495, 11049.33703977764, 10690.305130166515, 10710.678679639623, 10802.135829133651, 10915.017648411682, 10942.507587158438, 8184.345252379914, 8298.502089874626, 8335.583220838933, 8348.0, 8399.328053755686, 5274.7098909560345, 5299.284596579567, 5667.008273552195, 5689.444934619346, 5797.188393624811, 9899.950500247453, 9959.452230127412, 9976.950115249378, 10209.54057067419, 10239.897601023895, 10031.0, 10175.236857235885, 10193.949030254802, 10214.0, 10280.897191028293, 7093.609851458219, 7295.963520182578, 7336.926630733625, 7360.411167106726, 7464.738734144279, 8015.959920200362, 8171.387145964195, 8174.346052315682, 8201.83596328082, 8281.54451505173, 7588.8482230356185, 7589.3549048329305, 7631.847363052819, 7632.236776322324, 7747.57388343624, 6171.876562468815, 7433.8884916727375, 7611.771646850603, 7664.3485303747575, 7699.153093159636, 6692.196936367667, 6847.589144651138, 7009.12385951756, 7016.158061032709, 7019.122609673791, 4741.454732705645, 4776.331313616027, 4786.114568804782, 4952.587969010163, 5007.47421520735, 4844.491328410607, 5019.799208031638, 5083.1358669027095, 5127.666701664529, 5254.710990895537], "value": 4552.7557228690775, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [298.63566448932295, 302.6897430134113, 312.2194513715711, 313.9497680371141, 317.32726619566523, 4805.975970120153, 5438.83683489495, 5492.697901615409, 5547.140193270039, 5595.49640532353, 5153.587712982961, 5240.528352448279, 5374.543163831079, 5397.355295905008, 5554.611177217596, 3465.2549701814105, 4121.855735049274, 4121.876343709693, 4131.690123240754, 4136.8965775855695, 3534.4521599152044, 3823.541175058983, 4131.326812640886, 4178.665706743468, 4196.559361267069, 3939.3303138466385, 4097.364908439182, 4101.856435024774, 4186.434831297766, 4195.664346852244, 3735.3836616958306, 4192.937105943413, 4198.9370159447635, 4212.726172798758, 4274.636655884223, 2810.9859450702616, 3431.279431319426, 3666.7799932004164, 3678.1540245743363, 3687.115092377837, 4428.800703968329, 4626.514216007338, 4701.623870090384, 5419.620626556142, 5431.293931788842, 4353.782310884443, 4675.532446755331, 4717.599004084657, 4776.49846766088, 4824.734639594821, 4765.0231702500905, 4818.951810481885, 5685.886282274331, 5754.510866576346, 5803.883922321572, 3363.6131844837914, 3922.411638254256, 3977.732692365324, 3993.381025940984, 4034.9394759078637, 5027.773750181214, 5474.507294343528, 5512.629569285205, 6030.819075427744, 6075.301340345873, 4075.8573449929704, 4087.61167689075, 4090.979545102315, 4109.753414795062, 4128.814203360856, 3487.3897068013, 3848.9230215396096, 4144.896377590524, 4189.491782958133, 4205.537390887, 4115.7324773890205, 4225.852095176654, 4575.725456472623, 4800.759962001886, 4816.036792641486, 5231.227449451797, 5466.671999680032, 5759.280089988752, 5796.058320462608, 5799.9130013049835, 1193.3317342288346, 1211.3398197982121, 1409.189715913354, 1420.9502667406591, 1428.4001917852072, 766.5477368352699, 803.8512875118005, 821.9766390843438, 913.4427998920653, 935.462109287149, 4070.2673518766906, 4489.281714925596, 4500.257457519538, 4513.81944722214, 4603.976980115078, 4763.737994410271, 4816.325714399987, 4956.727379994135, 4975.751212439363, 5036.471170527115, 4170.4995400552125, 4326.502452217972, 4524.8416305429155, 4800.639952003614, 5476.507114359727, 2753.485582929381, 3075.646300675451, 3116.532520122, 3121.859516321771, 3129.5775070365667, 5811.535077193815, 5958.940410595838, 6143.928035982009, 6203.96898015507, 6316.873662526724, 4942.308076869242, 5107.974460127675, 5653.575981801381, 6003.787973434191, 6053.697315134225, 4918.5327393896805, 5815.5929084963645, 6131.540134489931, 6166.383361663888, 6210.0, 4963.478834722447, 5139.92290115656, 5907.49786268172, 5944.0, 5972.492338151305, 5055.6713813602, 5496.615236933536, 5781.566382521243, 5835.270591176103, 5848.795292164754, 5387.353517577916, 5955.622274223441, 6106.786262480792, 6197.349278325892, 6218.533609979179, 3445.517627532198, 3806.4290356446754, 3908.843646254118, 3919.9620294272167, 3919.980400097981, 5529.225908372911, 5817.883642327214, 5851.0, 5863.394012682255, 5915.822525324247, 4950.8762280943265, 5412.3196226566315, 5791.102379131242, 5798.76804927815, 5813.215215945793, 5090.796368145381, 5187.377514698261, 5521.309836270466, 5655.293088363955, 5694.0, 4629.814807407666, 5024.924626130684, 5134.793323568883, 5561.6663000220115, 5570.607348162959, 4834.0, 5291.809342897817, 5555.333359996826, 5629.211910332639, 5713.971430142823, 5625.718714064362, 5630.296212973379, 5634.464725851038, 5634.74643641029, 5636.210930469655], "value": 4107.826087324135, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [603.5828439753215, 697.9948873621984, 787.7636708987307, 792.8017995501125, 818.9344852411807, 15140.697186056272, 15403.768943465857, 16106.0, 16120.838791612081, 16589.585260368498, 14577.781333280009, 14922.552323430287, 14923.328450219738, 14949.177795221258, 14962.17708026058, 825.7729124490753, 837.204655577201, 837.4347315561971, 840.4537050916891, 840.9075001749802, 677.4648028057828, 700.0549258501034, 702.6170736948376, 824.6701319472199, 841.7474757572734, 885.3669626217253, 889.2530274569393, 889.8264838356523, 892.2460520859895, 893.4326702543866, 888.7111688701198, 889.7241855024898, 889.7286327670058, 889.7553172877479, 890.7283278600024, 519.8908229271857, 537.1084000559092, 646.214848958513, 660.191265699519, 661.4708233413251, 15034.473793417288, 15094.698106037928, 15103.244837758179, 15110.320035598425, 15147.0, 13592.0, 13831.446742130303, 13908.791368129487, 13992.440302387893, 14146.85853141476, 10236.43699596522, 12341.259524428473, 12587.055970802227, 12713.491460341575, 12912.806307905388, 4413.227685155117, 4563.155816174019, 4621.3299071634765, 4650.581447669692, 4743.430788305391, 120892.39553802263, 123876.0, 125149.37425312815, 126614.0, 128408.0, 10515.789684206273, 10871.728206794734, 11011.174161937886, 11181.664550063511, 11233.10135189183, 19494.415167544998, 20091.69862452035, 21016.159353625684, 21269.78730212709, 22297.331080067623, 7887.526748395115, 7922.405819563556, 8009.199080091944, 8168.469049511763, 8220.671173153007, 3869.806509674505, 4175.728577642443, 4176.749395036247, 4184.686148538872, 4220.767857767853, 3566.5720113586017, 3693.3351996640326, 3723.1809002019513, 3734.5891951885815, 3747.5315585551807, 598.0520874414016, 615.4122812713847, 616.2820314333751, 625.7528276330823, 672.5426709837358, 557.5567423898011, 562.7439515020737, 612.295859761278, 620.271181361898, 621.0, 8886.0, 9316.301277404222, 9389.62441502346, 9443.480608566595, 9467.632494046567, 577.4773829684143, 640.775728495023, 652.9771457998947, 661.8411581220472, 677.4241894389729, 4230.407742915994, 4519.683622146418, 4522.186006518792, 4579.22153233951, 4656.906861862743, 105382.0, 108505.0, 135701.0, 141339.0, 147989.0, 111618.44190779157, 112263.0, 113568.0, 124338.37830810789, 125285.0, 98059.0, 104285.0, 104483.0, 109436.452817737, 112209.31686024716, 9536.189423898768, 9735.659251926148, 9804.65683701067, 9851.359661621971, 9920.751981200528, 62676.68661656663, 62810.0, 64090.99999999814, 64858.02712959404, 66119.0, 78994.21005790099, 95250.0, 96279.037209627, 100495.0, 102571.48714256381, 12097.516099355928, 12358.196717213352, 12673.366331683563, 12701.93649031749, 13134.277614731282, 13717.588472345846, 13794.991785731985, 14634.341454634354, 14814.851851481348, 15139.697206055596, 13050.412731426919, 13223.933880330536, 13740.312984350943, 13747.106438081493, 13820.239886806323, 11458.885411146115, 11460.713482163013, 12904.290264035568, 13108.606741797761, 14112.435502579781, 13033.413496392495, 13128.868711313147, 13130.146540474838, 14357.0, 14372.065815721944, 9499.952500237454, 10812.459377031275, 10901.781964360827, 11074.778504430027, 11300.982911537672, 9848.310618256653, 10806.597480725728, 11010.559577617127, 11083.279586826831, 11270.463270542927], "value": 7742.048304333018, "unit": "score"}], "name": "dromaeo_css", "value": 7361.957426475087, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 116.0, 116.0, 115.0, 115.0, 116.0, 115.0, 113.0, 115.0, 115.0], "value": 115.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 109.0, 108.0, 142.0, 118.0, 139.0, 115.0, 108.0, 141.0, 107.0], "value": 123.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 182.0, 183.0, 182.0, 182.0, 185.0, 183.0, 184.0, 183.0, 186.0], "value": 183.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 59.0, 59.0, 89.0, 61.0, 60.0, 58.0, 58.0, 82.0, 58.0], "value": 66.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 72.0, 96.0, 69.0, 68.0, 70.0, 93.0, 67.0, 68.0, 90.0], "value": 78.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 83.0, 86.0, 83.0, 89.0, 124.0, 86.0, 83.0, 85.0, 83.0], "value": 88.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 132.0, 156.0, 94.0, 95.0, 94.0, 95.0, 95.0, 94.0], "value": 104.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 86.0, 85.0, 86.0, 83.0, 84.0, 86.0, 82.0, 84.0, 83.0], "value": 84.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 54.0, 56.0, 75.0, 88.0, 88.0, 87.0, 57.0, 56.0, 55.0], "value": 67.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 67.0, 67.0, 74.0, 71.0, 69.0, 69.0, 69.0, 70.0, 70.0], "value": 69.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 99.0, 81.0, 84.0, 81.0, 84.0, 80.0, 83.0, 85.0, 88.0], "value": 84.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 146.0, 146.0, 137.0, 134.0, 138.0, 142.0, 141.0, 170.0, 139.0], "value": 144.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 164.0, 165.0, 165.0, 166.0, 167.0, 164.0, 164.0, 165.0, 165.0], "value": 165.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 67.0, 66.0, 66.0, 66.0, 67.0, 66.0, 66.0, 67.0], "value": 66.5, "unit": "score"}], "name": "kraken", "value": 1441.2, "alertThreshold": 2.0}]} 12:45:03 INFO - Return code: 0 12:45:03 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:45:03 INFO - # TBPL SUCCESS # 12:45:03 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:45:03 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:45:03 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:45:03 INFO - 2016-10-28 12:45:03.153 screenresolution[1670:10279] starting screenresolution argv=screenresolution get 12:45:03 INFO - 2016-10-28 12:45:03.155 screenresolution[1670:10279] Display 0: 1600x1200x32@60 12:45:03 INFO - 2016-10-28 12:45:03.161 screenresolution[1671:10282] starting screenresolution argv=screenresolution list 12:45:03 INFO - Available Modes on Display 0 12:45:03 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:45:03 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:45:03 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:45:03 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:45:03 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:45:03 INFO - Intel Iris: 12:45:03 INFO - Chipset Model: Intel Iris 12:45:03 INFO - Type: GPU 12:45:03 INFO - Bus: Built-In 12:45:03 INFO - VRAM (Dynamic, Max): 1536 MB 12:45:03 INFO - Vendor: Intel (0x8086) 12:45:03 INFO - Device ID: 0x0a2e 12:45:03 INFO - Revision ID: 0x0009 12:45:03 INFO - Displays: 12:45:03 INFO - Display: 12:45:03 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:45:03 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:45:03 INFO - Display Serial Number: 1600x1200 60 12:45:03 INFO - Main Display: Yes 12:45:03 INFO - Mirror: Off 12:45:03 INFO - Online: Yes 12:45:03 INFO - Rotation: Supported 12:45:03 INFO - Return code: 0 12:45:03 INFO - Running post-action listener: _resource_record_post_action 12:45:03 INFO - [mozharness: 2016-10-28 19:45:03.396051Z] Finished run-tests step (success) 12:45:03 INFO - Running post-run listener: _resource_record_post_run 12:45:03 INFO - Total resource usage - Wall time: 1209s; CPU: 54.0%; Read bytes: 38487040; Write bytes: 661883392; Read time: 378; Write time: 2084 12:45:03 INFO - TinderboxPrint: CPU usage
53.6% 12:45:03 INFO - TinderboxPrint: I/O read bytes / time
38,487,040 / 378 12:45:03 INFO - TinderboxPrint: I/O write bytes / time
661,883,392 / 2,084 12:45:03 INFO - TinderboxPrint: CPU idle
2,247.1 (46.4%) 12:45:03 INFO - TinderboxPrint: CPU system
972.1 (20.1%) 12:45:03 INFO - TinderboxPrint: CPU user
1,618.6 (33.5%) 12:45:03 INFO - TinderboxPrint: Swap in / out
401,698,816 / 0 12:45:03 INFO - install - Wall time: 32s; CPU: 54.0%; Read bytes: 360813056; Write bytes: 355386880; Read time: 27592; Write time: 652 12:45:03 INFO - run-tests - Wall time: 1178s; CPU: 54.0%; Read bytes: 36402176; Write bytes: 295224320; Read time: 354; Write time: 1394 12:45:03 INFO - Running post-run listener: _upload_blobber_files 12:45:03 INFO - Blob upload gear active. 12:45:03 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:45:03 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 12:45:03 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'] 12:45:03 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 12:45:04 INFO - (blobuploader) - INFO - Open directory for files ... 12:45:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 12:45:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:45:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:45:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 12:45:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:45:04 INFO - (blobuploader) - INFO - Done attempting. 12:45:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 12:45:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:45:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:45:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 12:45:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:45:05 INFO - (blobuploader) - INFO - Done attempting. 12:45:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:45:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:45:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:45:08 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:45:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:45:08 INFO - (blobuploader) - INFO - Done attempting. 12:45:08 INFO - (blobuploader) - INFO - Iteration through files over. 12:45:08 INFO - Return code: 0 12:45:08 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:45:08 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:45:08 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0e5252ed6aabf7aa7e246fc3692c46f26c66f545f8dc6a91dc7cfc689b0461e1240cafea8fc409d2cd9dd454d82f2237ac18596500dc5da1c59540ba35ec9967", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/25331b6d4b8e4a132627a6287e5c1041a21f4fb0231b94bcf2b2dbe5004a718ab2665947c51e3be3fd4b4b1fa421470f6e019a9e3d2b9796a84112ca110ecd51", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/16035919235116a0a7774278d1f543b52137460110379cb786a8a5c8d098497dead95012aba3ced91634cb43247b90af95fd698f9e47ffb96436ea30e08e46a6"} 12:45:08 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:45:08 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:45:08 INFO - Contents: 12:45:08 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0e5252ed6aabf7aa7e246fc3692c46f26c66f545f8dc6a91dc7cfc689b0461e1240cafea8fc409d2cd9dd454d82f2237ac18596500dc5da1c59540ba35ec9967", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/25331b6d4b8e4a132627a6287e5c1041a21f4fb0231b94bcf2b2dbe5004a718ab2665947c51e3be3fd4b4b1fa421470f6e019a9e3d2b9796a84112ca110ecd51", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/16035919235116a0a7774278d1f543b52137460110379cb786a8a5c8d098497dead95012aba3ced91634cb43247b90af95fd698f9e47ffb96436ea30e08e46a6"} 12:45:08 INFO - Running post-run listener: copy_logs_to_upload_dir 12:45:08 INFO - Copying logs to upload dir... 12:45:08 INFO - mkdir: /builds/slave/test/build/upload/logs 12:45:08 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1271.240531 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-10-28 12:45:08.278143) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-28 12:45:08.282018) ========= 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.h2xpHfkexU/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.6PPgRjFIzN/Listeners TMPDIR=/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/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/0e5252ed6aabf7aa7e246fc3692c46f26c66f545f8dc6a91dc7cfc689b0461e1240cafea8fc409d2cd9dd454d82f2237ac18596500dc5da1c59540ba35ec9967", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/25331b6d4b8e4a132627a6287e5c1041a21f4fb0231b94bcf2b2dbe5004a718ab2665947c51e3be3fd4b4b1fa421470f6e019a9e3d2b9796a84112ca110ecd51", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/16035919235116a0a7774278d1f543b52137460110379cb786a8a5c8d098497dead95012aba3ced91634cb43247b90af95fd698f9e47ffb96436ea30e08e46a6"} build_url:https://queue.taskcluster.net/v1/task/Gtaq9pZHS7mF9yPCky-F0A/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011001 build_url: 'https://queue.taskcluster.net/v1/task/Gtaq9pZHS7mF9yPCky-F0A/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/0e5252ed6aabf7aa7e246fc3692c46f26c66f545f8dc6a91dc7cfc689b0461e1240cafea8fc409d2cd9dd454d82f2237ac18596500dc5da1c59540ba35ec9967", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/25331b6d4b8e4a132627a6287e5c1041a21f4fb0231b94bcf2b2dbe5004a718ab2665947c51e3be3fd4b4b1fa421470f6e019a9e3d2b9796a84112ca110ecd51", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/16035919235116a0a7774278d1f543b52137460110379cb786a8a5c8d098497dead95012aba3ced91634cb43247b90af95fd698f9e47ffb96436ea30e08e46a6"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-28 12:45:08.319047) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-28 12:45:08.319383) ========= 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.h2xpHfkexU/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.6PPgRjFIzN/Listeners TMPDIR=/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/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.005098 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-28 12:45:08.368124) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-28 12:45:08.368487) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-28 12:45:08.368799) ========= ========= Total master_lag: 0.18 =========