builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0211 starttime: 1479313439.61 results: success (0) buildid: 20161116062934 builduid: dd8b9568ec7e41ae9b4d07d010975b61 revision: 6fa8b32d419fc4fa119db21ea83bd6931e5ab8a0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-16 08:23:59.605728) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-16 08:23:59.606234) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-16 08:23:59.606553) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-16 08:23:59.633963) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-16 08:23:59.634446) ========= 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.ctULmTJgH2/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.jTY7QrzEtg/Listeners TMPDIR=/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/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-11-16 08:23:59-- 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% 27.7M=0s 2016-11-16 08:23:59 (27.7 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.141547 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-16 08:23:59.799561) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-16 08:23:59.799917) ========= 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.ctULmTJgH2/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.jTY7QrzEtg/Listeners TMPDIR=/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/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.025249 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-16 08:23:59.849324) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-11-16 08:23:59.849726) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 6fa8b32d419fc4fa119db21ea83bd6931e5ab8a0 --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-beta --rev 6fa8b32d419fc4fa119db21ea83bd6931e5ab8a0 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.ctULmTJgH2/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.jTY7QrzEtg/Listeners TMPDIR=/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/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-11-16 08:23:59,951 truncating revision to first 12 chars 2016-11-16 08:23:59,952 Setting DEBUG logging. 2016-11-16 08:23:59,952 attempt 1/10 2016-11-16 08:23:59,952 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/6fa8b32d419f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-16 08:24:01,808 unpacking tar archive at: mozilla-beta-6fa8b32d419f/testing/mozharness/ program finished with exit code 0 elapsedTime=2.155247 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-11-16 08:24:02.027730) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-16 08:24:02.028151) ========= script_repo_revision: 6fa8b32d419fc4fa119db21ea83bd6931e5ab8a0 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-16 08:24:02.028595) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-16 08:24:02.028914) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-16 08:24:02.047621) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2016-11-16 08:24:02.048020) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 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-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.ctULmTJgH2/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.jTY7QrzEtg/Listeners TMPDIR=/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/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 08:24:02 INFO - MultiFileLogger online at 20161116 08:24:02 in /builds/slave/test 08:24:02 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 08:24:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:24:02 INFO - {'append_to_log': False, 08:24:02 INFO - 'base_work_dir': '/builds/slave/test', 08:24:02 INFO - 'blob_upload_branch': 'Mozilla-Beta', 08:24:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:24:02 INFO - 'branch': 'Mozilla-Beta', 08:24:02 INFO - 'buildbot_json_path': 'buildprops.json', 08:24:02 INFO - 'config_files': ('talos/mac_config.py',), 08:24:02 INFO - 'default_actions': ('clobber', 08:24:02 INFO - 'read-buildbot-config', 08:24:02 INFO - 'download-and-extract', 08:24:02 INFO - 'populate-webroot', 08:24:02 INFO - 'create-virtualenv', 08:24:02 INFO - 'install', 08:24:02 INFO - 'run-tests'), 08:24:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:24:02 INFO - 'download_minidump_stackwalk': True, 08:24:02 INFO - 'download_symbols': 'ondemand', 08:24:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:24:02 INFO - 'tooltool.py': '/tools/tooltool.py', 08:24:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:24:02 INFO - '/tools/misc-python/virtualenv.py')}, 08:24:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:24:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:24:02 INFO - 'installer_path': 'installer.exe', 08:24:02 INFO - 'log_level': 'info', 08:24:02 INFO - 'log_name': 'talos', 08:24:02 INFO - 'log_to_console': True, 08:24:02 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:24:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:24:02 INFO - 'opt_config_files': (), 08:24:02 INFO - 'pip_index': False, 08:24:02 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:24:02 INFO - 'cmd': ('bash', 08:24:02 INFO - '-c', 08:24:02 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:24:02 INFO - 'enabled': True, 08:24:02 INFO - 'halt_on_failure': False, 08:24:02 INFO - 'name': 'check_screen_resolution'},), 08:24:02 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:24:02 INFO - 'cmd': ('bash', 08:24:02 INFO - '-c', 08:24:02 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:24:02 INFO - 'enabled': True, 08:24:02 INFO - 'halt_on_failure': False, 08:24:02 INFO - 'name': 'check_screen_resolution'},), 08:24:02 INFO - 'run_cmd_checks_enabled': True, 08:24:02 INFO - 'sps_profile': False, 08:24:02 INFO - 'sps_profile_interval': 0, 08:24:02 INFO - 'suite': 'dromaeojs', 08:24:02 INFO - 'system_bits': '32', 08:24:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:24:02 INFO - 'title': 't-yosemite-r7-0211', 08:24:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:24:02 INFO - 'use_talos_json': True, 08:24:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:24:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:24:02 INFO - 'work_dir': 'build'} 08:24:02 INFO - [mozharness: 2016-11-16 16:24:02.252889Z] Running clobber step. 08:24:02 INFO - Running pre-action listener: _resource_record_pre_action 08:24:02 INFO - Running main action method: clobber 08:24:02 INFO - rmtree: /builds/slave/test/build 08:24:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:24:04 INFO - Running post-action listener: _resource_record_post_action 08:24:04 INFO - [mozharness: 2016-11-16 16:24:04.665310Z] Finished clobber step (success) 08:24:04 INFO - [mozharness: 2016-11-16 16:24:04.665516Z] Running read-buildbot-config step. 08:24:04 INFO - Running pre-action listener: _resource_record_pre_action 08:24:04 INFO - Running main action method: read_buildbot_config 08:24:04 INFO - Using buildbot properties: 08:24:04 INFO - { 08:24:04 INFO - "project": "", 08:24:04 INFO - "product": "firefox", 08:24:04 INFO - "script_repo_revision": "production", 08:24:04 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 08:24:04 INFO - "repository": "", 08:24:04 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 08:24:04 INFO - "buildid": "20161116062934", 08:24:04 INFO - "pgo_build": "False", 08:24:04 INFO - "basedir": "/builds/slave/test", 08:24:04 INFO - "buildnumber": 64, 08:24:04 INFO - "slavename": "t-yosemite-r7-0211", 08:24:04 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 08:24:04 INFO - "platform": "yosemite_r7", 08:24:04 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 08:24:04 INFO - "branch": "mozilla-beta", 08:24:04 INFO - "repo_path": "releases/mozilla-beta", 08:24:04 INFO - "revision": "6fa8b32d419fc4fa119db21ea83bd6931e5ab8a0", 08:24:04 INFO - "stage_platform": "macosx64", 08:24:04 INFO - "builduid": "dd8b9568ec7e41ae9b4d07d010975b61", 08:24:04 INFO - "slavebuilddir": "test" 08:24:04 INFO - } 08:24:04 INFO - Found installer url https://queue.taskcluster.net/v1/task/Upkk4KELQJ6NAO8FhE31-A/artifacts/public/build/firefox-51.0.en-US.mac.dmg. 08:24:04 INFO - Running post-action listener: _resource_record_post_action 08:24:04 INFO - [mozharness: 2016-11-16 16:24:04.669595Z] Finished read-buildbot-config step (success) 08:24:04 INFO - [mozharness: 2016-11-16 16:24:04.669717Z] Running download-and-extract step. 08:24:04 INFO - Running pre-action listener: _resource_record_pre_action 08:24:04 INFO - Running main action method: download_and_extract 08:24:04 INFO - mkdir: /builds/slave/test/build/tests 08:24:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:24:04 INFO - trying https://queue.taskcluster.net/v1/task/Upkk4KELQJ6NAO8FhE31-A/artifacts/public/build/firefox-51.0.en-US.mac.test_packages.json 08:24:04 INFO - Downloading https://queue.taskcluster.net/v1/task/Upkk4KELQJ6NAO8FhE31-A/artifacts/public/build/firefox-51.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0.en-US.mac.test_packages.json 08:24:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Upkk4KELQJ6NAO8FhE31-A/artifacts/public/build/firefox-51.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0.en-US.mac.test_packages.json'}, attempt #1 08:24:06 INFO - Downloaded 1165 bytes. 08:24:06 INFO - Reading from file /builds/slave/test/build/firefox-51.0.en-US.mac.test_packages.json 08:24:06 INFO - Using the following test package requirements: 08:24:06 INFO - {u'common': [u'firefox-51.0.en-US.mac.common.tests.zip'], 08:24:06 INFO - u'cppunittest': [u'firefox-51.0.en-US.mac.common.tests.zip', 08:24:06 INFO - u'firefox-51.0.en-US.mac.cppunittest.tests.zip'], 08:24:06 INFO - u'gtest': [u'firefox-51.0.en-US.mac.common.tests.zip', 08:24:06 INFO - u'firefox-51.0.en-US.mac.gtest.tests.zip'], 08:24:06 INFO - u'jittest': [u'firefox-51.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 08:24:06 INFO - u'mochitest': [u'firefox-51.0.en-US.mac.common.tests.zip', 08:24:06 INFO - u'firefox-51.0.en-US.mac.mochitest.tests.zip'], 08:24:06 INFO - u'mozbase': [u'firefox-51.0.en-US.mac.common.tests.zip'], 08:24:06 INFO - u'reftest': [u'firefox-51.0.en-US.mac.common.tests.zip', 08:24:06 INFO - u'firefox-51.0.en-US.mac.reftest.tests.zip'], 08:24:06 INFO - u'talos': [u'firefox-51.0.en-US.mac.common.tests.zip', 08:24:06 INFO - u'firefox-51.0.en-US.mac.talos.tests.zip'], 08:24:06 INFO - u'web-platform': [u'firefox-51.0.en-US.mac.common.tests.zip', 08:24:06 INFO - u'firefox-51.0.en-US.mac.web-platform.tests.zip'], 08:24:06 INFO - u'xpcshell': [u'firefox-51.0.en-US.mac.common.tests.zip', 08:24:06 INFO - u'firefox-51.0.en-US.mac.xpcshell.tests.zip']} 08:24:06 INFO - Downloading packages: [u'firefox-51.0.en-US.mac.common.tests.zip'] for test suite category: common 08:24:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Upkk4KELQJ6NAO8FhE31-A/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip 08:24:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Upkk4KELQJ6NAO8FhE31-A/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip'}, attempt #1 08:24:06 INFO - Fetch https://queue.taskcluster.net/v1/task/Upkk4KELQJ6NAO8FhE31-A/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip into memory 08:24:06 INFO - Expected file size: 16231297 08:24:13 INFO - Downloading packages: [u'firefox-51.0.en-US.mac.common.tests.zip', u'firefox-51.0.en-US.mac.talos.tests.zip'] for test suite category: talos 08:24:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Upkk4KELQJ6NAO8FhE31-A/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip 08:24:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Upkk4KELQJ6NAO8FhE31-A/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip'}, attempt #1 08:24:13 INFO - Fetch https://queue.taskcluster.net/v1/task/Upkk4KELQJ6NAO8FhE31-A/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip into memory 08:24:14 INFO - Expected file size: 16231297 08:24:20 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Upkk4KELQJ6NAO8FhE31-A/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip 08:24:20 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Upkk4KELQJ6NAO8FhE31-A/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip'}, attempt #1 08:24:20 INFO - Fetch https://queue.taskcluster.net/v1/task/Upkk4KELQJ6NAO8FhE31-A/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip into memory 08:24:21 INFO - Expected file size: 14414089 08:24:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:24:22 INFO - trying https://queue.taskcluster.net/v1/task/Upkk4KELQJ6NAO8FhE31-A/artifacts/public/build/firefox-51.0.en-US.mac.dmg 08:24:22 INFO - Downloading https://queue.taskcluster.net/v1/task/Upkk4KELQJ6NAO8FhE31-A/artifacts/public/build/firefox-51.0.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0.en-US.mac.dmg 08:24:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Upkk4KELQJ6NAO8FhE31-A/artifacts/public/build/firefox-51.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0.en-US.mac.dmg'}, attempt #1 08:24:24 INFO - Downloaded 86010767 bytes. 08:24:24 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Upkk4KELQJ6NAO8FhE31-A/artifacts/public/build/firefox-51.0.en-US.mac.dmg 08:24:24 INFO - mkdir: /builds/slave/test/properties 08:24:24 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:24:24 INFO - Writing to file /builds/slave/test/properties/build_url 08:24:24 INFO - Contents: 08:24:24 INFO - build_url:https://queue.taskcluster.net/v1/task/Upkk4KELQJ6NAO8FhE31-A/artifacts/public/build/firefox-51.0.en-US.mac.dmg 08:24:25 INFO - Running post-action listener: _resource_record_post_action 08:24:25 INFO - Running post-action listener: set_extra_try_arguments 08:24:25 INFO - [mozharness: 2016-11-16 16:24:25.196417Z] Finished download-and-extract step (success) 08:24:25 INFO - [mozharness: 2016-11-16 16:24:25.196533Z] Running populate-webroot step. 08:24:25 INFO - Running pre-action listener: _resource_record_pre_action 08:24:25 INFO - Running main action method: populate_webroot 08:24:25 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:24:25 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:24:25 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:24:25 INFO - '--tppagecycles', 08:24:25 INFO - '7'], 08:24:25 INFO - 'tests': ['tsvgm']}}, 08:24:25 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:24:25 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:24:25 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:24:25 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:24:25 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:24:25 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:24:25 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:24:25 INFO - 'talos_options': ['--disable-e10s'], 08:24:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:24:25 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:24:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:24:25 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:24:25 INFO - 'talos_options': ['--disable-e10s'], 08:24:25 INFO - 'tests': ['damp', 'tps']}, 08:24:25 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:24:25 INFO - 'tests': ['damp', 'tps']}, 08:24:25 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:24:25 INFO - 'tests': ['dromaeo_dom']}, 08:24:25 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:24:25 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:24:25 INFO - 'tests': ['basic_compositor_video']}, 08:24:25 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:24:25 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:24:25 INFO - 'tests': ['a11yr', 08:24:25 INFO - 'ts_paint', 08:24:25 INFO - 'tpaint', 08:24:25 INFO - 'sessionrestore', 08:24:25 INFO - 'sessionrestore_no_auto_restore', 08:24:25 INFO - 'tabpaint']}, 08:24:25 INFO - 'other-e10s': {'tests': ['a11yr', 08:24:25 INFO - 'ts_paint', 08:24:25 INFO - 'tpaint', 08:24:25 INFO - 'sessionrestore', 08:24:25 INFO - 'sessionrestore_no_auto_restore', 08:24:25 INFO - 'tabpaint']}, 08:24:25 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:24:25 INFO - 'ts_paint', 08:24:25 INFO - 'tpaint', 08:24:25 INFO - 'sessionrestore', 08:24:25 INFO - 'sessionrestore_no_auto_restore', 08:24:25 INFO - 'tabpaint']}, 08:24:25 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:24:25 INFO - 'ts_paint', 08:24:25 INFO - 'tpaint', 08:24:25 INFO - 'sessionrestore', 08:24:25 INFO - 'sessionrestore_no_auto_restore', 08:24:25 INFO - 'tabpaint']}, 08:24:25 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:24:25 INFO - 'tests': ['a11yr', 08:24:25 INFO - 'ts_paint', 08:24:25 INFO - 'tpaint', 08:24:25 INFO - 'sessionrestore', 08:24:25 INFO - 'sessionrestore_no_auto_restore', 08:24:25 INFO - 'tabpaint']}, 08:24:25 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:24:25 INFO - 'tests': ['a11yr', 08:24:25 INFO - 'ts_paint', 08:24:25 INFO - 'tpaint', 08:24:25 INFO - 'sessionrestore', 08:24:25 INFO - 'sessionrestore_no_auto_restore', 08:24:25 INFO - 'tabpaint']}, 08:24:25 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:24:25 INFO - 'tests': ['tsvgx', 08:24:25 INFO - 'tsvgr_opacity', 08:24:25 INFO - 'tart', 08:24:25 INFO - 'tscrollx', 08:24:25 INFO - 'cart']}, 08:24:25 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:24:25 INFO - 'tsvgr_opacity', 08:24:25 INFO - 'tart', 08:24:25 INFO - 'tscrollx', 08:24:25 INFO - 'cart']}, 08:24:25 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:24:25 INFO - 'talos_options': ['--disable-e10s'], 08:24:25 INFO - 'tests': ['tp5o']}, 08:24:25 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:24:25 INFO - 'tests': ['tp5o']}, 08:24:25 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:24:25 INFO - 'talos_options': ['--disable-e10s', 08:24:25 INFO - '--xperf_path', 08:24:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:24:25 INFO - 'tests': ['tp5n']}, 08:24:25 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:24:25 INFO - 'talos_options': ['--xperf_path', 08:24:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:24:25 INFO - 'tests': ['tp5n']}}, 08:24:25 INFO - 'talos.zip': {'path': '', 08:24:25 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:24:25 INFO - Running post-action listener: _resource_record_post_action 08:24:25 INFO - [mozharness: 2016-11-16 16:24:25.215126Z] Finished populate-webroot step (success) 08:24:25 INFO - [mozharness: 2016-11-16 16:24:25.215250Z] Running create-virtualenv step. 08:24:25 INFO - Running pre-action listener: _resource_record_pre_action 08:24:25 INFO - Running main action method: create_virtualenv 08:24:25 INFO - Creating virtualenv /builds/slave/test/build/venv 08:24:25 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 08:24:25 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:24:25 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:24:25 INFO - Using real prefix '/tools/python27' 08:24:25 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:24:26 INFO - Installing distribute.............................................................................................................................................................................................done. 08:24:29 INFO - Installing pip.................done. 08:24:29 INFO - Return code: 0 08:24:29 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:24:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:24:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:24:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:24:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:24:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:24:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:24:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ac2d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aba3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbf19d5e8b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aa41d30>, '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 0x10a8a7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10aa39b20>, '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.ctULmTJgH2/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.jTY7QrzEtg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/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 08:24:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:24:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:24:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ctULmTJgH2/Render', 08:24:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:24:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:24:29 INFO - 'HOME': '/Users/cltbld', 08:24:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:24:29 INFO - 'LOGNAME': 'cltbld', 08:24:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:24:29 INFO - 'MOZ_NO_REMOTE': '1', 08:24:29 INFO - 'NO_EM_RESTART': '1', 08:24:29 INFO - 'PAGER': '/bin/cat', 08:24:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:24:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:24:29 INFO - 'PWD': '/builds/slave/test', 08:24:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:24:29 INFO - 'SHELL': '/bin/bash', 08:24:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jTY7QrzEtg/Listeners', 08:24:29 INFO - 'TMPDIR': '/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/', 08:24:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:24:29 INFO - 'USER': 'cltbld', 08:24:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:24:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:24:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:24:29 INFO - 'XPC_FLAGS': '0x0', 08:24:29 INFO - 'XPC_SERVICE_NAME': '0', 08:24:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:24:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:24:29 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 08:24:29 INFO - Cleaning up... 08:24:29 INFO - Return code: 0 08:24:29 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:24:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:24:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:24:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:24:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:24:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:24:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:24:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10ac2d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aba3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbf19d5e8b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aa41d30>, '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 0x10a8a7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10aa39b20>, '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.ctULmTJgH2/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.jTY7QrzEtg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/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 08:24:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:24:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:24:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ctULmTJgH2/Render', 08:24:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:24:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:24:29 INFO - 'HOME': '/Users/cltbld', 08:24:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:24:29 INFO - 'LOGNAME': 'cltbld', 08:24:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:24:29 INFO - 'MOZ_NO_REMOTE': '1', 08:24:29 INFO - 'NO_EM_RESTART': '1', 08:24:29 INFO - 'PAGER': '/bin/cat', 08:24:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:24:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:24:29 INFO - 'PWD': '/builds/slave/test', 08:24:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:24:29 INFO - 'SHELL': '/bin/bash', 08:24:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jTY7QrzEtg/Listeners', 08:24:29 INFO - 'TMPDIR': '/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/', 08:24:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:24:29 INFO - 'USER': 'cltbld', 08:24:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:24:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:24:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:24:29 INFO - 'XPC_FLAGS': '0x0', 08:24:29 INFO - 'XPC_SERVICE_NAME': '0', 08:24:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:24:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:24:29 INFO - Downloading/unpacking psutil>=3.1.1 08:24:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:24:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:24:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:24:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:24:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:24:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:24:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:24:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:24:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:24:33 INFO - Installing collected packages: psutil 08:24:33 INFO - Running setup.py install for psutil 08:24:33 INFO - building 'psutil._psutil_osx' extension 08:24:33 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 08:24:33 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 08:24:33 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 08:24:33 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 08:24:33 INFO - building 'psutil._psutil_posix' extension 08:24:33 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 08:24:34 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 08:24:34 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 08:24:34 INFO - ^ 08:24:34 INFO - 1 warning generated. 08:24:34 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 08:24:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:24:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:24:34 INFO - Successfully installed psutil 08:24:34 INFO - Cleaning up... 08:24:34 INFO - Return code: 0 08:24:34 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:24:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:24:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:24:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:24:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:24:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:24:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:24:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ac2d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aba3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbf19d5e8b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aa41d30>, '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 0x10a8a7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10aa39b20>, '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.ctULmTJgH2/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.jTY7QrzEtg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/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 08:24:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:24:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 08:24:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ctULmTJgH2/Render', 08:24:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:24:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:24:34 INFO - 'HOME': '/Users/cltbld', 08:24:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:24:34 INFO - 'LOGNAME': 'cltbld', 08:24:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:24:34 INFO - 'MOZ_NO_REMOTE': '1', 08:24:34 INFO - 'NO_EM_RESTART': '1', 08:24:34 INFO - 'PAGER': '/bin/cat', 08:24:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:24:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:24:34 INFO - 'PWD': '/builds/slave/test', 08:24:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:24:34 INFO - 'SHELL': '/bin/bash', 08:24:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jTY7QrzEtg/Listeners', 08:24:34 INFO - 'TMPDIR': '/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/', 08:24:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:24:34 INFO - 'USER': 'cltbld', 08:24:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:24:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:24:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:24:34 INFO - 'XPC_FLAGS': '0x0', 08:24:34 INFO - 'XPC_SERVICE_NAME': '0', 08:24:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:24:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:24:34 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:24:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:24:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:24:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:24:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:24:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:24:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:24:37 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:24:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:24:37 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:24:37 INFO - Installing collected packages: mozsystemmonitor 08:24:37 INFO - Running setup.py install for mozsystemmonitor 08:24:37 INFO - Successfully installed mozsystemmonitor 08:24:37 INFO - Cleaning up... 08:24:37 INFO - Return code: 0 08:24:37 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08: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')]} 08:24:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:24:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08: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')]} 08:24:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:24:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08: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', '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 0x10ac2d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aba3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbf19d5e8b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aa41d30>, '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 0x10a8a7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10aa39b20>, '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.ctULmTJgH2/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.jTY7QrzEtg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/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 08: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 08: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 jsonschema==2.5.1 08:24:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ctULmTJgH2/Render', 08:24:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:24:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:24:37 INFO - 'HOME': '/Users/cltbld', 08:24:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:24:37 INFO - 'LOGNAME': 'cltbld', 08:24:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:24:37 INFO - 'MOZ_NO_REMOTE': '1', 08:24:37 INFO - 'NO_EM_RESTART': '1', 08:24:37 INFO - 'PAGER': '/bin/cat', 08:24:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:24:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:24:37 INFO - 'PWD': '/builds/slave/test', 08:24:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:24:37 INFO - 'SHELL': '/bin/bash', 08:24:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jTY7QrzEtg/Listeners', 08:24:37 INFO - 'TMPDIR': '/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/', 08:24:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:24:37 INFO - 'USER': 'cltbld', 08:24:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:24:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:24:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:24:37 INFO - 'XPC_FLAGS': '0x0', 08:24:37 INFO - 'XPC_SERVICE_NAME': '0', 08:24:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:24:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:24:37 INFO - Downloading/unpacking jsonschema==2.5.1 08: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 08: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 08: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 08: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 08: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 08: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 08:24:40 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:24:40 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08: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 08: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 08: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 08: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 08: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 08: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 08:24:40 INFO - Downloading functools32-3.2.3-2.tar.gz 08:24:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:24:40 INFO - warning: no files found matching '*.txt' 08:24:40 INFO - no previously-included directories found matching 'build' 08:24:40 INFO - no previously-included directories found matching 'dist' 08:24:40 INFO - no previously-included directories found matching '.git*' 08:24:40 INFO - Installing collected packages: jsonschema, functools32 08:24:40 INFO - Running setup.py install for functools32 08:24:40 INFO - warning: no files found matching '*.txt' 08:24:40 INFO - no previously-included directories found matching 'build' 08:24:40 INFO - no previously-included directories found matching 'dist' 08:24:40 INFO - no previously-included directories found matching '.git*' 08:24:40 INFO - Successfully installed jsonschema functools32 08:24:40 INFO - Cleaning up... 08:24:40 INFO - Return code: 0 08:24:40 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:24:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:24:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:24:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:24:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:24:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:24:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:24:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10ac2d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aba3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbf19d5e8b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aa41d30>, '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 0x10a8a7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10aa39b20>, '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.ctULmTJgH2/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.jTY7QrzEtg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/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 08:24:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 08:24:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 08:24:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ctULmTJgH2/Render', 08:24:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:24:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:24:40 INFO - 'HOME': '/Users/cltbld', 08:24:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:24:40 INFO - 'LOGNAME': 'cltbld', 08:24:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:24:40 INFO - 'MOZ_NO_REMOTE': '1', 08:24:40 INFO - 'NO_EM_RESTART': '1', 08:24:40 INFO - 'PAGER': '/bin/cat', 08:24:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:24:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:24:40 INFO - 'PWD': '/builds/slave/test', 08:24:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:24:40 INFO - 'SHELL': '/bin/bash', 08:24:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jTY7QrzEtg/Listeners', 08:24:40 INFO - 'TMPDIR': '/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/', 08:24:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:24:40 INFO - 'USER': 'cltbld', 08:24:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:24:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:24:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:24:40 INFO - 'XPC_FLAGS': '0x0', 08:24:40 INFO - 'XPC_SERVICE_NAME': '0', 08:24:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:24:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:24:41 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:24:41 INFO - Cleaning up... 08:24:41 INFO - Return code: 0 08:24:41 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08: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')]} 08:24:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:24:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08: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')]} 08:24:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:24:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:24:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10ac2d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aba3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbf19d5e8b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aa41d30>, '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 0x10a8a7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10aa39b20>, '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.ctULmTJgH2/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.jTY7QrzEtg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/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 08:24:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:24:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:24:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ctULmTJgH2/Render', 08:24:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:24:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:24:41 INFO - 'HOME': '/Users/cltbld', 08:24:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:24:41 INFO - 'LOGNAME': 'cltbld', 08:24:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:24:41 INFO - 'MOZ_NO_REMOTE': '1', 08:24:41 INFO - 'NO_EM_RESTART': '1', 08:24:41 INFO - 'PAGER': '/bin/cat', 08:24:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:24:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:24:41 INFO - 'PWD': '/builds/slave/test', 08:24:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:24:41 INFO - 'SHELL': '/bin/bash', 08:24:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jTY7QrzEtg/Listeners', 08:24:41 INFO - 'TMPDIR': '/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/', 08:24:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:24:41 INFO - 'USER': 'cltbld', 08:24:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:24:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:24:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:24:41 INFO - 'XPC_FLAGS': '0x0', 08:24:41 INFO - 'XPC_SERVICE_NAME': '0', 08:24:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:24:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:24:41 INFO - Downloading/unpacking blobuploader==1.2.4 08:24:41 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 08:24:41 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 08:24:41 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 08:24:41 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 08:24:41 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 08:24:41 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 08:24:44 INFO - Downloading blobuploader-1.2.4.tar.gz 08:24:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:24:44 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:24:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:24:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:24:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:24:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:24:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:24:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:24:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:24:44 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:24:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:24:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:24:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:24:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:24:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:24:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:24:45 INFO - Downloading docopt-0.6.1.tar.gz 08:24:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:24:45 INFO - Installing collected packages: blobuploader, requests, docopt 08:24:45 INFO - Running setup.py install for blobuploader 08:24:45 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:24:45 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:24:45 INFO - Running setup.py install for requests 08:24:45 INFO - Running setup.py install for docopt 08:24:46 INFO - Successfully installed blobuploader requests docopt 08:24:46 INFO - Cleaning up... 08:24:46 INFO - Return code: 0 08:24:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08: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')]} 08:24:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:24:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08: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')]} 08:24:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:24:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:24:46 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 0x10ac2d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aba3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbf19d5e8b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aa41d30>, '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 0x10a8a7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10aa39b20>, '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.ctULmTJgH2/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.jTY7QrzEtg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/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 08:24:46 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 08:24:46 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 08:24:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ctULmTJgH2/Render', 08:24:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:24:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:24:46 INFO - 'HOME': '/Users/cltbld', 08:24:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:24:46 INFO - 'LOGNAME': 'cltbld', 08:24:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:24:46 INFO - 'MOZ_NO_REMOTE': '1', 08:24:46 INFO - 'NO_EM_RESTART': '1', 08:24:46 INFO - 'PAGER': '/bin/cat', 08:24:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:24:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:24:46 INFO - 'PWD': '/builds/slave/test', 08:24:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:24:46 INFO - 'SHELL': '/bin/bash', 08:24:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jTY7QrzEtg/Listeners', 08:24:46 INFO - 'TMPDIR': '/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/', 08:24:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:24:46 INFO - 'USER': 'cltbld', 08:24:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:24:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:24:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:24:46 INFO - 'XPC_FLAGS': '0x0', 08:24:46 INFO - 'XPC_SERVICE_NAME': '0', 08:24:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:24:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:24:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:24:46 INFO - Running setup.py (path:/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/pip-ToFLtE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:24:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:24:46 INFO - Running setup.py (path:/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/pip-dA40Ck-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:24:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:24:46 INFO - Running setup.py (path:/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/pip-dKRYyt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:24:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:24:46 INFO - Running setup.py (path:/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/pip-J1GcA5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:24:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:24:46 INFO - Running setup.py (path:/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/pip-yZfDX3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:24:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:24:46 INFO - Running setup.py (path:/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/pip-n2BHiW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:24:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:24:47 INFO - Running setup.py (path:/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/pip-FtytPo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:24:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:24:47 INFO - Running setup.py (path:/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/pip-g4ZS02-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:24:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:24:47 INFO - Running setup.py (path:/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/pip-J8rDX3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:24:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:24:47 INFO - Running setup.py (path:/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/pip-sJ2b7X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:24:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:24:47 INFO - Running setup.py (path:/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/pip-I2vbZu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:24:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:24:47 INFO - Running setup.py (path:/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/pip-heNcqW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:24:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:24:47 INFO - Running setup.py (path:/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/pip-82v47V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:24:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:24:47 INFO - Running setup.py (path:/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/pip-ADqosG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:24:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:24:47 INFO - Running setup.py (path:/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/pip-7C_zUr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:24:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:24:47 INFO - Running setup.py (path:/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/pip-Y9bW0t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:24:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:24:48 INFO - Running setup.py (path:/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/pip-TZP_OC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:24:48 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:24:48 INFO - Running setup.py install for manifestparser 08:24:48 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:24:48 INFO - Running setup.py install for mozcrash 08:24:48 INFO - Running setup.py install for mozdebug 08:24:48 INFO - Running setup.py install for mozdevice 08:24:48 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:24:48 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:24:48 INFO - Running setup.py install for mozfile 08:24:48 INFO - Running setup.py install for mozhttpd 08:24:49 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:24:49 INFO - Running setup.py install for mozinfo 08:24:49 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:24:49 INFO - Running setup.py install for mozInstall 08:24:49 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:24:49 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:24:49 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:24:49 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:24:49 INFO - Running setup.py install for mozleak 08:24:49 INFO - Running setup.py install for mozlog 08:24:49 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:24:49 INFO - Running setup.py install for moznetwork 08:24:49 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:24:49 INFO - Running setup.py install for mozprocess 08:24:49 INFO - Running setup.py install for mozprofile 08:24:50 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:24:50 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:24:50 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:24:50 INFO - Running setup.py install for mozrunner 08:24:50 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:24:50 INFO - Running setup.py install for mozscreenshot 08:24:50 INFO - Running setup.py install for moztest 08:24:50 INFO - Running setup.py install for mozversion 08:24:50 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:24:50 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:24:50 INFO - Cleaning up... 08:24:50 INFO - Return code: 0 08:24:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:24:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:24:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:24:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08: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')]} 08:24:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:24:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:24:51 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 0x10ac2d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aba3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbf19d5e8b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aa41d30>, '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 0x10a8a7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10aa39b20>, '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.ctULmTJgH2/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.jTY7QrzEtg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/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 08:24:51 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 08:24:51 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 08:24:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ctULmTJgH2/Render', 08:24:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:24:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:24:51 INFO - 'HOME': '/Users/cltbld', 08:24:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:24:51 INFO - 'LOGNAME': 'cltbld', 08:24:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:24:51 INFO - 'MOZ_NO_REMOTE': '1', 08:24:51 INFO - 'NO_EM_RESTART': '1', 08:24:51 INFO - 'PAGER': '/bin/cat', 08:24:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:24:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:24:51 INFO - 'PWD': '/builds/slave/test', 08:24:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:24:51 INFO - 'SHELL': '/bin/bash', 08:24:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jTY7QrzEtg/Listeners', 08:24:51 INFO - 'TMPDIR': '/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/', 08:24:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:24:51 INFO - 'USER': 'cltbld', 08:24:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:24:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:24:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:24:51 INFO - 'XPC_FLAGS': '0x0', 08:24:51 INFO - 'XPC_SERVICE_NAME': '0', 08:24:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:24:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:24:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:24:51 INFO - Running setup.py (path:/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/pip-QoxWjj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:24:51 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)) 08:24:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:24:51 INFO - Running setup.py (path:/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/pip-VWksl8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:24:51 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)) 08:24:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:24:51 INFO - Running setup.py (path:/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/pip-UnHEoJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:24:51 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)) 08:24:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:24:51 INFO - Running setup.py (path:/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/pip-mUIKC5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:24:51 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)) 08:24:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:24:51 INFO - Running setup.py (path:/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/pip-BKyw21-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:24:51 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)) 08:24:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:24:51 INFO - Running setup.py (path:/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/pip-RSpoCf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:24:52 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)) 08:24:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:24:52 INFO - Running setup.py (path:/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/pip-XZ4PLW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:24:52 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)) 08:24:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:24:52 INFO - Running setup.py (path:/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/pip-YqB2rN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:24:52 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)) 08:24:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:24:52 INFO - Running setup.py (path:/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/pip-E9LOf5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:24:52 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)) 08:24:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:24:52 INFO - Running setup.py (path:/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/pip-aU4MLk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:24:52 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)) 08:24:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:24:52 INFO - Running setup.py (path:/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/pip-hTT209-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:24:52 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)) 08:24:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:24:52 INFO - Running setup.py (path:/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/pip-VpAdys-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:24:52 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)) 08:24:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:24:52 INFO - Running setup.py (path:/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/pip-FXQ3Wa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:24:52 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)) 08:24:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:24:52 INFO - Running setup.py (path:/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/pip-3YKvmm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:24:52 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)) 08:24:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:24:52 INFO - Running setup.py (path:/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/pip-yS0OSf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:24:53 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)) 08:24:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:24:53 INFO - Running setup.py (path:/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/pip-NSgDOR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:24:53 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)) 08:24:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:24:53 INFO - Running setup.py (path:/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/pip-I2Nl1v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:24:53 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)) 08:24:53 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)) 08:24:53 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)) 08:24:53 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)) 08:24:53 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)) 08:24:53 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)) 08:24:53 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:24:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:24:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:24:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:24:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:24:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:24:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:24:56 INFO - Downloading blessings-1.6.tar.gz 08:24:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:24:56 INFO - Installing collected packages: blessings 08:24:56 INFO - Running setup.py install for blessings 08:24:56 INFO - Successfully installed blessings 08:24:56 INFO - Cleaning up... 08:24:56 INFO - Return code: 0 08:24:56 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:24:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:24:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:24:56 INFO - Reading from file tmpfile_stdout 08:24:56 INFO - Current package versions: 08:24:56 INFO - blessings == 1.6 08:24:56 INFO - blobuploader == 1.2.4 08:24:56 INFO - docopt == 0.6.1 08:24:56 INFO - functools32 == 3.2.3-2 08:24:56 INFO - jsonschema == 2.5.1 08:24:56 INFO - manifestparser == 1.1 08:24:56 INFO - mozInstall == 1.12 08:24:56 INFO - mozcrash == 0.17 08:24:56 INFO - mozdebug == 0.1 08:24:56 INFO - mozdevice == 0.48 08:24:56 INFO - mozfile == 1.2 08:24:56 INFO - mozhttpd == 0.7 08:24:56 INFO - mozinfo == 0.9 08:24:56 INFO - mozleak == 0.1 08:24:56 INFO - mozlog == 3.4 08:24:56 INFO - moznetwork == 0.27 08:24:56 INFO - mozprocess == 0.23 08:24:56 INFO - mozprofile == 0.28 08:24:56 INFO - mozrunner == 6.12 08:24:56 INFO - mozscreenshot == 0.1 08:24:56 INFO - mozsystemmonitor == 0.3 08:24:56 INFO - moztest == 0.7 08:24:56 INFO - mozversion == 1.4 08:24:56 INFO - psutil == 3.1.1 08:24:56 INFO - requests == 1.2.3 08:24:56 INFO - wsgiref == 0.1.2 08:24:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:24:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:24:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:24:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:24:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:24:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:24:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:24:56 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 0x10ac2d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aba3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbf19d5e8b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aa41d30>, '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 0x10a8a7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10aa39b20>, '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.ctULmTJgH2/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.jTY7QrzEtg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/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 08:24:56 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 08:24:56 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 08:24:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ctULmTJgH2/Render', 08:24:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:24:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:24:56 INFO - 'HOME': '/Users/cltbld', 08:24:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:24:56 INFO - 'LOGNAME': 'cltbld', 08:24:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:24:56 INFO - 'MOZ_NO_REMOTE': '1', 08:24:56 INFO - 'NO_EM_RESTART': '1', 08:24:56 INFO - 'PAGER': '/bin/cat', 08:24:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:24:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:24:56 INFO - 'PWD': '/builds/slave/test', 08:24:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:24:56 INFO - 'SHELL': '/bin/bash', 08:24:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jTY7QrzEtg/Listeners', 08:24:56 INFO - 'TMPDIR': '/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/', 08:24:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:24:56 INFO - 'USER': 'cltbld', 08:24:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:24:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:24:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:24:56 INFO - 'XPC_FLAGS': '0x0', 08:24:56 INFO - 'XPC_SERVICE_NAME': '0', 08:24:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:24:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:24:57 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)) 08:24:57 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)) 08:24:57 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)) 08:24:57 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)) 08:24:57 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)) 08:24:57 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)) 08:24:57 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)) 08:24:57 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)) 08:24:57 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)) 08:24:57 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)) 08:24:57 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)) 08:24:57 INFO - Cleaning up... 08:24:57 INFO - Return code: 0 08:24:57 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:24:57 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')]} 08:24:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:24:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:24:57 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')]} 08:24:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:24:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:24:57 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 0x10ac2d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aba3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbf19d5e8b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aa41d30>, '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 0x10a8a7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10aa39b20>, '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.ctULmTJgH2/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.jTY7QrzEtg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/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 08:24:57 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 08:24:57 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 08:24:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ctULmTJgH2/Render', 08:24:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:24:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:24:57 INFO - 'HOME': '/Users/cltbld', 08:24:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:24:57 INFO - 'LOGNAME': 'cltbld', 08:24:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:24:57 INFO - 'MOZ_NO_REMOTE': '1', 08:24:57 INFO - 'NO_EM_RESTART': '1', 08:24:57 INFO - 'PAGER': '/bin/cat', 08:24:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:24:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:24:57 INFO - 'PWD': '/builds/slave/test', 08:24:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:24:57 INFO - 'SHELL': '/bin/bash', 08:24:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jTY7QrzEtg/Listeners', 08:24:57 INFO - 'TMPDIR': '/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/', 08:24:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:24:57 INFO - 'USER': 'cltbld', 08:24:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:24:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:24:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:24:57 INFO - 'XPC_FLAGS': '0x0', 08:24:57 INFO - 'XPC_SERVICE_NAME': '0', 08:24:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:24:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:24:57 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:24:57 INFO - Cleaning up... 08:24:57 INFO - Return code: 0 08:24:57 INFO - Running post-action listener: _resource_record_post_action 08:24:57 INFO - Running post-action listener: _start_resource_monitoring 08:24:57 INFO - Starting resource monitoring. 08:24:57 INFO - [mozharness: 2016-11-16 16:24:57.385773Z] Finished create-virtualenv step (success) 08:24:57 INFO - [mozharness: 2016-11-16 16:24:57.386723Z] Running install step. 08:24:57 INFO - Running pre-action listener: _resource_record_pre_action 08:24:57 INFO - Running main action method: install 08:24:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:24:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:24:57 INFO - Reading from file tmpfile_stdout 08:24:57 INFO - Detecting whether we're running mozinstall >=1.0... 08:24:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:24:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:24:57 INFO - Reading from file tmpfile_stdout 08:24:57 INFO - Output received: 08:24:57 INFO - Usage: mozinstall [options] installer 08:24:57 INFO - Options: 08:24:57 INFO - -h, --help show this help message and exit 08:24:57 INFO - -d DEST, --destination=DEST 08:24:57 INFO - Directory to install application into. [default: 08:24:57 INFO - "/builds/slave/test"] 08:24:57 INFO - --app=APP Application being installed. [default: firefox] 08:24:57 INFO - mkdir: /builds/slave/test/build/application 08:24:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 08:24:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0.en-US.mac.dmg --destination /builds/slave/test/build/application 08:25:19 INFO - Reading from file tmpfile_stdout 08:25:19 INFO - Output received: 08:25:19 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 08:25:19 INFO - Running post-action listener: _resource_record_post_action 08:25:19 INFO - [mozharness: 2016-11-16 16:25:19.587937Z] Finished install step (success) 08:25:19 INFO - [mozharness: 2016-11-16 16:25:19.588120Z] Running run-tests step. 08:25:19 INFO - Running pre-action listener: _resource_record_pre_action 08:25:19 INFO - Running main action method: run_tests 08:25:19 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:25:19 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:25:19 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:25:19 INFO - 2016-11-16 08:25:19.602 screenresolution[1624:7320] starting screenresolution argv=screenresolution get 08:25:19 INFO - 2016-11-16 08:25:19.605 screenresolution[1624:7320] Display 0: 1600x1200x32@60 08:25:19 INFO - 2016-11-16 08:25:19.611 screenresolution[1625:7323] starting screenresolution argv=screenresolution list 08:25:19 INFO - Available Modes on Display 0 08:25:19 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:25:19 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:25:19 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:25:19 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:25:19 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:25:19 INFO - Intel Iris: 08:25:19 INFO - Chipset Model: Intel Iris 08:25:19 INFO - Type: GPU 08:25:19 INFO - Bus: Built-In 08:25:19 INFO - VRAM (Dynamic, Max): 1536 MB 08:25:19 INFO - Vendor: Intel (0x8086) 08:25:19 INFO - Device ID: 0x0a2e 08:25:19 INFO - Revision ID: 0x0009 08:25:19 INFO - Displays: 08:25:19 INFO - Display: 08:25:19 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:25:19 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:25:19 INFO - Display Serial Number: 1600x1200 60 08:25:19 INFO - Main Display: Yes 08:25:19 INFO - Mirror: Off 08:25:19 INFO - Online: Yes 08:25:19 INFO - Rotation: Supported 08:25:19 INFO - Return code: 0 08:25:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:25:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:25:19 INFO - Python 2.7.3 08:25:19 INFO - Return code: 0 08:25:19 INFO - grabbing minidump binary from tooltool 08:25:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:25:19 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 0x10aa41d30>, '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 0x10a8a7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10aa39b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:25:19 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 08:25:19 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 08:25:19 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 08:25:19 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:25:19 INFO - Return code: 0 08:25:19 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 08:25:19 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:25:19 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:25:19 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 08:25:19 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:25:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Upkk4KELQJ6NAO8FhE31-A/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0211', '--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 08:25:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Upkk4KELQJ6NAO8FhE31-A/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0211 --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 08:25:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ctULmTJgH2/Render', 08:25:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:25:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:25:19 INFO - 'HOME': '/Users/cltbld', 08:25:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:25:19 INFO - 'LOGNAME': 'cltbld', 08:25:19 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:25:19 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 08:25:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:25:19 INFO - 'MOZ_NO_REMOTE': '1', 08:25:19 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:25:19 INFO - 'NO_EM_RESTART': '1', 08:25:19 INFO - 'PAGER': '/bin/cat', 08:25:19 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:25:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:25:19 INFO - 'PWD': '/builds/slave/test', 08:25:19 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:25:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:25:19 INFO - 'SHELL': '/bin/bash', 08:25:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jTY7QrzEtg/Listeners', 08:25:19 INFO - 'TMPDIR': '/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/', 08:25:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:25:19 INFO - 'USER': 'cltbld', 08:25:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:25:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:25:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:25:19 INFO - 'XPC_FLAGS': '0x0', 08:25:19 INFO - 'XPC_SERVICE_NAME': '0', 08:25:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:25:19 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Upkk4KELQJ6NAO8FhE31-A/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0211', '--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 08:25:20 INFO - mozversion application_buildid: 20161116062934 08:25:20 INFO - mozversion application_changeset: 6fa8b32d419fc4fa119db21ea83bd6931e5ab8a0 08:25:20 INFO - mozversion application_display_name: Firefox 08:25:20 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:25:20 INFO - mozversion application_name: Firefox 08:25:20 INFO - mozversion application_remotingname: firefox 08:25:20 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 08:25:20 INFO - mozversion application_vendor: Mozilla 08:25:20 INFO - mozversion application_version: 51.0 08:25:20 INFO - mozversion platform_buildid: 20161116062934 08:25:20 INFO - mozversion platform_changeset: 6fa8b32d419fc4fa119db21ea83bd6931e5ab8a0 08:25:20 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 08:25:20 INFO - mozversion platform_version: 51.0 08:25:20 INFO - using testdate: 1479313520 08:25:20 INFO - actual date: 1479313520 08:25:20 INFO - starting webserver on 'localhost:49243' 08:25:20 INFO - SUITE-START | Running 2 tests 08:25:20 INFO - TEST-START | dromaeo_css 08:25:20 INFO - operating with platform_type : mac_ 08:25:20 INFO - Initialising browser for dromaeo_css test... 08:25:20 INFO - TEST-INFO | started process 1635 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/tmpSleNTJ/profile http://localhost:49243/getInfo.html) 08:25:22 INFO - PROCESS | 1635 | __metrics Screen width/height:1600/1200 08:25:22 INFO - PROCESS | 1635 | colorDepth:24 08:25:22 INFO - PROCESS | 1635 | Browser inner width/height: 1024/689 08:25:22 INFO - PROCESS | 1635 | __metrics 08:25:22 INFO - PROCESS | 1635 | 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" 08:25:22 INFO - PROCESS | 1635 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:25:23 INFO - TEST-INFO | 1635: exit 0 08:25:23 INFO - Browser initialized. 08:25:23 INFO - Running cycle 1/1 for dromaeo_css test... 08:25:23 INFO - TEST-INFO | started process 1638 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/tmpSleNTJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:25:35 INFO - PROCESS | 1638 | RSS: Main: 168534016 08:25:35 INFO - PROCESS | 1638 | 08:26:27 INFO - PROCESS | 1638 | 1479313587109 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] 08:28:37 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49243/tests/dromaeo/cssquery-ext.html) 08:28:38 INFO - PROCESS | 1638 | RSS: Main: 313626624 08:28:38 INFO - PROCESS | 1638 | 08:31:41 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-ext.html (next: http://localhost:49243/tests/dromaeo/cssquery-jquery.html) 08:31:42 INFO - PROCESS | 1638 | RSS: Main: 301391872 08:31:42 INFO - PROCESS | 1638 | 08:34:44 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49243/tests/dromaeo/cssquery-mootools.html) 08:34:45 INFO - PROCESS | 1638 | RSS: Main: 264175616 08:34:45 INFO - PROCESS | 1638 | 08:37:47 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49243/tests/dromaeo/cssquery-prototype.html) 08:37:48 INFO - PROCESS | 1638 | RSS: Main: 264417280 08:37:48 INFO - PROCESS | 1638 | 08:40:51 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49243/tests/dromaeo/cssquery-yui.html) 08:40:52 INFO - PROCESS | 1638 | RSS: Main: 261361664 08:40:52 INFO - PROCESS | 1638 | 08:43:55 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-yui.html (next: http://localhost:49243/tests/dromaeo/cssquery-dojo.html) 08:43:55 INFO - PROCESS | 1638 | RSS: Main: 416313344 08:43:55 INFO - PROCESS | 1638 | 08:43:55 INFO - PROCESS | 1638 | __start_tp_report 08:43:55 INFO - PROCESS | 1638 | _x_x_mozilla_page_load 08:43:55 INFO - PROCESS | 1638 | _x_x_mozilla_page_load_details 08:43:55 INFO - PROCESS | 1638 | |i|pagename|runs| 08:43:55 INFO - PROCESS | 1638 | |0;dojo.html;3441.500982357559;3447.2416068464936;3485.3377858206954;3487.651234876511;3535.7348198885074;5787.594868359217;5850.0932355484965;5885.352611212763;5894.64632122073;5919.08254220596;5561.63849349792;5765.1928729977835;5825.737841797119;5920.763169473216;5930.495907847838;5181.637285390024;5306.867328316804;5352.678839269656;5387.703676297802;5407.567394608442;5262.184361423985;5262.947410517892;5265.8946821063555;5398.649087809299;5434.891302173974;5402;5407.242985981946;5407.621466497347;5418.241446197536;5423.864403389927;5288.127458969266;5335.813246536352;5341.572674186094;5348.786048558053;5371.75827087782;5285.180796976475;5305.761240744176;5321.760520776575;5386.111291636876;5421.2952316199035;5633.40849210831;5937.287525496968;5938.138969849391;5964.791232306892;6043.365446628085;5184.507471790212;6145.095020543601;6187.381261873822;6198.969005154991;6242.656653884034;5675.035244008528;5917.615355001911;6248.968755156195;6257.5619706620555;6265.906011409833;5950;5955.880882382328;5956.434138756811;5962.821115366546;5979.521638268928;6188.9690551546955;6241.500679945593;6261.624302541862;6293.559450838489;6349.809505714836;5408.7830238196875;6215.564910456315;6248.9062664060075;6249.468795152463;6253.437190652772;6144.754209831557;6252.96778546974;6292.811215663537;6307.5269354798575;6321.8735625288155;6111.166351794787;6126.969365153146;6142.587204942888;6168.8766224675255;6232.844178895473;6283.654399008098;6289.433950944437;6308.08532762756;6311.810645680637;6318.178636777189;5059.165237735732;5103.948960510347;5115.948840511547;5118.897622047538;5129.9743501283;4467.061916997402;4479.17135329965;4541.72749635023;4567.6802623816675;4618.237990731559;5198.896022079537;5478.671279723229;5800.303963524404;5864.648121112747;5920.585559010914;5505.898820235969;5978.103284507271;6239.438450539473;6259.123722678829;6272.8118156455375;5665.320161580555;5855.443732845373;5855.677937713382;5860;5897.056470964625;4407.449068866392;5421.241026256327;5497.45025497455;5505.6696598204235;5535.086710692691;6422.068800024063;6486.870262594816;6489.0266460030425;6493.51298652603;6494.512911531559;6296.622202667854;6296.685165741603;6299.212598425197;6307.653079080511;6308.243010838729;6259.499240060875;6282.089097080989;6346.524010699124;6358;6395.392437718409;6295.622262664255;6298.685065746786;6313.05304204373;6319.304876463493;6327.11420401135;6267.655278959519;6281.246250449975;6283.277423096402;6285.120083188266;6301.873962520815;6069.575129740876;6116.457510225511;6128.233970753656;6235.563510554399;6289.119523266838;6119.724612392542;6263.96868015657;6269.467095296951;6275.843103922256;6284.591501552384;5947.9702601486715;6140.846478838065;6146.6004709693725;6178.783742568989;6188.876222475616;6081.422264884829;6140.350877193083;6200.472959798287;6208.751649933952;6278.372162783685;6052.394760523913;6109.419605137505;6121.785737499166;6174.598651087665;6184.505239580732 08:43:55 INFO - PROCESS | 1638 | |1;ext.html;497.5323196195578;503.57990466883405;513.9563137133343;534.5589888342117;577.0853197681674;32690.509642355384;42172.945676358104;43507.78246108773;43599.34600980988;46045.539544604544;44974.550254497524;45268.86827829306;45298.77350613251;45411.31883021758;45620.54379456204;9888.950555247231;10060.496975151249;10067.899321006806;10071.093601575856;10081;9236.722898313028;9515.333926625104;12178.878211217907;12438.440270187863;12485.188462749938;12458.688532786708;12545.874541254607;12560.246385216871;12561.183523070971;12564.371781410939;12433.689157771083;12475.438605262785;12484.188527745713;12486.313252771093;12493.187942783781;12270.938645306716;12337.938310308391;12338.444769985283;12340.951019163382;12363.93818030904;41872;42100.78949605263;42146.36780448296;42155.15689686189;42166;3415.351083294166;3551.147724546116;3715.386961151407;3935.153941902505;3983.940240896389;26155.607665885025;32324;32472.675273247438;32935;33378.831740889196;3316.6351701312838;3392.0671815250757;3399.456087026089;3403.064157356722;3416.5900091988874;543821.2808935969;543860;544398.5560144427;544905;545061;34322.59741818099;58730;59224;59292.51768705817;59321;35421;36404.63595364065;36516.45225321622;36573.451398229045;36576.63423365785;15910.12494312824;16069.758953615705;16093.436729714404;16105.27526261321;16136.273867675984;12509.562165324352;12748.298843563507;13630.250336231602;13781.793273100911;13800.93099534496;7771.72798952034;8076.232757887991;8081.787731840153;8084.7574572762915;8141.0230772307705;3341.2649217172184;3369.629340772562;3384.323135372935;3393.1177893747804;3403.9489407658907;960.6109525642127;979.4955597867104;1067.893210678926;1136.4261048170622;1145.627671006926;30801.69198308033;30837.229069273;30980.380392392028;31334;31452.37095258082;912.7991841794794;960.188640598693;1078.245228340165;1138.3283862521153;1153.8730739618802;15244.771328430083;16010;16016.199190040452;16084;16363.918180409022;758200;760419;764582;764785;764836;61034;61310;61317.77364452686;61353.69323153356;61567;1280.846298444174;1287.3756228229488;1300.674831292177;1434.6771976305247;1465.157534417714;24270.51458970846;31054.068377948697;31922;32799.344013119124;33256.33487330288;59221;60064.69967650134;60099.69950150221;60136.09795853153;60220;699573.0042699508;705217;705646;705682;706352;27743.167704968884;37500.62499374971;42619.786901065294;45153.77423112995;45209.77395113135;47845.76077119592;48958;49514;49519.50480495149;50521.49478505168;39413.408798868615;40903.977400564036;40964.38553421761;41058.5629502966;42317.576824231364;39652.2069558613;40734.185316294104;40855;40865.687460629924;42247;37480.437793432575;37648.43527347037;37649.62350376461;39991.400128997506;40076.599234008456;33015.83492082524;34555;34607;35380.82309588538;35488.822555887054;26114.347141321618;26557.07050253232;26596.069137580093;26750.59874101851;26780.77369323976 08:43:55 INFO - PROCESS | 1638 | |2;jquery.html;346.4560639795521;370.9944350834736;376.65347879950446;382.8372941499863;406.7640768354355;19311.46469697121;21279.893600531977;22288.331350059485;23050.423739406524;23160.884195578998;11810.409479526032;12170.695732606668;12384.938075309634;12421.875781242185;12428.073648584485;5384.3538775346915;5686.914696279559;5692.829215123532;5703.230063941377;5704.8859022819515;5565.165225216229;5592.86017849555;6201.596896201755;6295.842603934915;6327.46216571592;6266.404691554295;6280.371962803706;6284.994400895857;6293.968530157343;6326.430621244087;5551.2228288039705;5623.409541998072;5630.690312032836;5632.35227948787;5659.575531835108;5205.453427390145;5450.509454149145;5459.808906688247;5474.151506516497;5483.341998960151;13129;13288.335583220896;13339.799903001463;13377.331133443386;13451.394687239097;2126.319577735125;2225.810806081485;2345.8944347504403;2375.239923224569;2424.5878200705924;10242.79514409715;10340.689779306633;10351.327163734333;10749.462526873704;10752.623658172004;1900.7338972543855;1915.8467322614297;1950.4636225038228;1999.2502811445709;2011.8532436511196;59612.10581841276;92021;107795.92204077938;124606;136883.47140907246;11527.020203282815;11583.305001699924;11855.288682679067;11949.88050119505;11996.220245684002;15005.849941500444;15039.699206016037;15164.696706066037;15195.92402038005;15208.08751474915;9036.32227582934;9077.319201059947;9134;9165.129312715282;9257.814843703223;9090.27277817773;9105.908940910638;9155.084491550924;9313.161815436642;9317.16145546904;4627.5603817637275;4628.884277893079;4633.189191891405;4637.072585482917;4698.1778188816825;1699.447679504166;1960.5686748915216;2014.2245235584405;2016.3043749906258;2024.514116612032;833.3458235285393;896.6996056321075;899.572702966099;987.4914419074182;991.2714155095998;18230.726539101925;21454.892725536272;22222.555548888933;22650;22852.65721014186;908.8000639859221;923.2798417234568;933.883264591926;938.4650749072963;954.8042651256476;10940.945295273472;11560.446339291462;11573.652790416301;11629.418529073513;11700.239484433654;590592;607148.928510718;642707;643094;645521.772391135;100044.39722043446;107515.46242268896;127764;129897;137567.62432375748;1004.9397036177853;1018.1549314069305;1022.3967858963099;1023.3194925374692;1042.5517027678172;19935.10292036833;20270.898645506677;20669.793302067388;20799.792002079786;20847.8957605211;55780.721096394256;55902.44097558972;57510;58146.12780808206;58156.4184358151;80292;82557.17442825495;82996.58501707453;84938;86337.56831215804;7962.08436029864;8157.4289799715825;8172.141925098017;8372.162783721578;8401.83196336082;10302.278840481094;12819.615411537668;13053.151545149534;13263.80104298417;13282.867171328164;9211.67759128454;11114.277571957797;11373.43132843338;11679.591214307458;11794.52821887115;8611.354148438766;10079.496025198565;10816.567337306735;11021.559137634405;11824.349660768741;9473.763155921157;9650.613975440903;11634;11670.70823229426;11771.882281177079;7259.27407259291;7492.925070749441;7601.201873803171;7756.146823849259;8644;9927.751806204902;11354.432278386214;11604.245724027911;11860.525578977089;11929.403529823301 08:43:55 INFO - PROCESS | 1638 | |3;mootools.html;1467.8825693944486;1578.7947566816308;1788.204249109146;1944.0182707732592;1958.1090603775274;8802.779930501732;9335.113164249402;9341.486218258011;9344.439333639977;9350.298727595433;8197.262246397822;8484.533350665712;8885.289176865852;9074.137956894085;9098.818023639524;2423.81821363398;2455.177515532299;2456.545539075277;2457;2458.7787099161073;2420.5400973814917;2423.4789520253144;2454.484558242771;2456.5946618807875;2460.520198561281;2431.513697260555;2436.488337449138;2449.1428000199876;2455.472073504196;2459.213051823417;2408.5664580375524;2417.637354396837;2425.0542288507318;2425.4785221177353;2441.2554170977846;2414.5291668124723;2430.3316587938457;2431.0761910474084;2431.258466167818;2434.6713193718974;9125.45247285165;9345.719628411158;9355.578998945064;9369.43783372993;9371.812563748756;5460.672359658433;5639.802606908779;5643.097104463307;5651.886962260732;5652.18043383707;3652.415613501827;3772.641599048086;3818.9618103818884;3855.267499175148;3861.710371722104;1013.554036224059;1030.237624158125;1036.8600238967717;1052.6421016854306;1054.5939813171908;12249.693757656041;12296.877031229662;12310.50757969689;12322.81515777264;12336.259824410474;4749.168895443353;4767.16700446488;4811.49479304675;4923.335349727812;4938.234573641092;10457.790844183073;10465.84301235482;10491.055804977588;10491.213159012952;10501.47492625381;5588.2455868458055;5589.077802162679;5590.161475778585;5605.943940560543;5608.411116832755;4086.3870419436726;4585.541445855454;4737.24204127338;5060.746962651852;5095.821646242363;3999.1601763629383;4020.3165461871554;4102.405151253051;4131.5042194936195;4131.690123240769;1276.2980360801523;1277.7827769279245;1283.4160456992047;1292.4636275945566;1301.2517802263546;778.190681691035;813.8494378539989;911.8996910339857;915.7527467583715;927.823713494434;5881.735321910524;5895.911561326584;6078.3921607838865;6094.299155597163;6173.555644797385;893.6425429827991;905.1536813079791;932.47315266874;970.9611615535441;1003.82934901067;3769.0577355661085;3895.1370742504237;4001.8599349023225;4065.4670042901953;4085.5097388312997;9480.525973701288;10611.681649550372;11340.94329528347;11363.488643011084;11394.259373140885;10476.895231047745;11294.60468883585;11307.434628268553;11311.717207069725;11319.773604528027;8224.300934420642;8556.016058153267;8564.614592343234;8575.142485751376;8585.527795971157;5754.446299499028;6032.6983650818165;6064.363241859718;6068;6186.072089186658;9889.159421449258;10280.383177009404;10317.793644126925;10467.424291663727;10468.319559228627;10728.624498142528;10738.355698658106;10743.140548756237;10754.247202695737;10797.406142662228;7187.460940429384;7426.2945020223;7634.427417943565;7829.217078292125;7967.123616402307;8474.406791524534;8805.823883522422;8806.691765788166;8819.955900220715;8820.603072861608;7547.924520754722;7690.538567685957;7696.461247712607;7794.961025194838;7817.218278172138;7373.262673732584;7506.211847755907;7532.39740820744;7555.773326800205;7571.507851989603;7147.821304467222;7293.562386256842;7293.890591641023;7303.415726741954;7327.74352897646;4636.698614590176;4880.316755654282;4911.705297682151;5081.11080560893;5107.182850743863;5065.240213967787;5073.441921388718;5179;5182.714950677749;5232.319798426181 08:43:55 INFO - PROCESS | 1638 | |4;prototype.html;270.1638429062052;298.5074626865671;303.5749950069903;309.9256178517156;315.91628218522095;5350.2777125088105;5373.677579345242;5399.572350672441;5443.9585155566665;5448.918266226005;4696.459907110683;5138.306328645632;5167.018266529366;5194.818181363653;5197.1424714922;3889.4554762333296;4013.4581831452747;4042.959570404302;4053.371727382246;4149.232392007489;4036.1524079943247;4049.2711311963835;4104.486939132608;4130.834766609332;4163.5836416358425;3845.365514690073;4021.4973128358956;4023.718339716221;4031.5162180538377;4053.7299112497094;3364.444866597021;3981.203759248133;3997.900052498682;4015;4029.315016447211;3024.561438591392;3071.9401806376763;3459.238967427187;3462.9480557791403;3463.6709512596262;4140.627343539066;5022.296878437021;5114.590832733373;5137.460566640524;5229.555487783505;4501.954980450187;4552.817887284505;4590.678652494326;4590.74750888701;4596.184507119702;4994.650374473788;5234.97382513085;5470.452954704538;5501.642393244426;5525.364583072957;3586.4082426399614;3682.6317368263226;3793.2413517296377;3875.341191997339;3877.2051729395407;5600.0759874620235;5811.302643682743;5814.609969473021;5818.537969907898;5878.470937615635;3206.6633003534293;3434.866494056955;3847.403652433877;3890.9805450972563;3899.53205615328;3927.9410808837893;3936.5079365079364;3942.6845852331744;3951.8221680023894;3978.224246272007;4242.554531774181;4275.978620106942;4344.9131017380105;4587.990642058741;4600.723956562617;4507.706999045052;4631.282151266559;5497.972510137423;5570.972145139248;5617.8033768817895;1083.5124194112682;1130.925620660376;1184.6860581945791;1297.156848048757;1309.6183526379762;783.0759703549866;796.1719811396083;849.6261644876234;865.7229686500259;870.9825803484022;4533.387992620954;4556.225441674923;5181.740912954338;5183.300254465675;5195.558377537876;4625.201752939423;5226.712530810766;5344.503539009083;5597.692126933058;5621;4949.430815456197;5110.390227078458;5221.503957124067;5305.416404195613;5353.7590808413715;2438.780509754095;2985.4178435205363;2991.641003079601;2994.9850250748605;2996.7302942734823;5572;5677.829665109971;5899;5921.28944526651;5971.581989260797;5896.587238893237;5921.467067963904;5921.703914804242;5932.673702946379;5934.673592952343;6007.219061522062;6041.335453100155;6056.515478761688;6094.750576131793;6101.481374083252;5365.651232669864;5708.771649133988;5762.567807414544;5857.092150716646;5867.471927526543;5290.307101727411;5678.886422271614;5782.768689252551;5791.942080579309;5799.739011744397;5870.5010074144175;5968.134620480093;5971.552133589911;6061.424164704346;6095.51235901118;3306.0908250231378;3851.5185601799776;3893;3911.3350730376474;3929.724919255739;5053.2420136979745;5813.7674493021495;5857.414258574108;5900.970495147497;5929.733162007807;4241.6606671466825;5600.719964001865;5746.885062298814;5757.3591526414775;5796.782675638163;5017.59507337946;5428.918566221589;5581.7209139543675;5599.160125981135;5599.356074051536;4896.094222568836;5214.2960700304975;5238.764255608583;5245.082110630548;5443.183522471502;5514.455952333353;5603.859903502445;5616.893664875672;5632.971835140798;5700.600957932905;4859.757012149449;5076.974615126901;5506.697131657797;5534.142207957773;5565.5825813063375 08:43:55 INFO - PROCESS | 1638 | |5;yui.html;713.2724620886696;723.2442098007582;814.8044469327364;833.1335411172381;863.2662237098464;15962.521124366272;17119.31522739092;17138.400155994543;17192.39826606066;17214.74177887331;15387;15457.922710386432;15488.535343939671;15495;15569.922150389231;659.9078525041065;696.8571442854203;709.9041629380046;892.228222587462;895.4403497813867;905.307439808547;906.5104843384564;915.2083447817623;916.7891384981458;921.4563407589521;976.1946394224793;979.9314048016641;981.4552923127661;981.5141504955021;982.5038355630433;969.1423090564865;973.4062222044547;975.9268054895912;977.5894124467741;979.8775153105826;724.4638967164313;724.5109551053071;726.4515290955347;729.2160927003492;729.2743719998582;14766.483173088998;15746.291416886268;16493.34026638933;16548.42080527176;16704.331826726917;14847.851521484863;15313.371099721257;15437.691246175014;15551.007024830336;16026.5993350166;11714.53141874324;12153.447775967057;12402.75194496105;12478.688032799162;12517;3922.2743792398214;3994.1811928554575;4176.0395109124765;4209.410682504452;4212.052288235153;126232;126277;129059;136169;136626.6337336624;11696.70758231051;11914.225575337576;12016.819747703792;12406.317652529198;12476.064295177897;25279.988800447776;25321.113761018278;25322;25340.366490837878;25350.239492815246;7689.538627682357;8381.622826972802;8486.40595158333;8562.700305489278;8664.306855451548;3880.980595097063;4491.955080449219;4585.082983403333;4640.025594625166;4689.062187562501;3618.7285953553587;3634.945475817865;3785.413260944558;3787.5833658298116;3790.0714324990554;629.8079085878759;694.6492021529095;695.6035060015844;704.8731228378839;712.7469748239404;629.3141466847015;642.1972534332085;643.6620774093544;647.9935200648027;652.6932341799346;9191.31065170115;9493.335466517416;9593.472359020321;9611.759706007266;9757.463339516395;578.3146970839568;655.0891179657438;669.6383952665603;670.7216505150406;677.1265068062145;4488.842890498817;4659.697119687209;4668.719876807402;4680.08738296029;4703.341532185496;152202;153541.23229384006;156585;157315;173687;134524;134951;134969.55213134986;137238;140549;110280;113767;114247;117358.41320793513;117994;10277;10574.788504230026;10641.14870810318;10717.624883129052;10911.454427278446;62626.37373626205;62648;64638.35361646323;64654;64761;90098.54950725204;90492.5475372619;91006;92150;99045;13605.251711155981;13630.522931697344;14005.859941400455;14017.789733153806;14141.575752727435;14943.327550260046;15161.772573411186;15502.689946200788;15711.528654140395;15744.370225190863;14035.719285614026;14227.928860355632;14281.214533200773;14364.066335688147;14386.352614132598;13893.722125557635;14149.646258843612;14442.566722998326;14658.486952956595;15278.618034548781;14010.649733756738;14075.085119467201;14089.929550352183;14164;14307.92846035763;11144.275622084539;11558.711032224262;11710.12174086964;12185;12580.87419125797;8612.65549378018;9936.509523571522;10822.40476773785;10983;11337.489812958273 08:43:55 INFO - PROCESS | 1638 | __end_tp_report 08:43:55 INFO - PROCESS | 1638 | __start_cc_report 08:43:55 INFO - PROCESS | 1638 | _x_x_mozilla_cycle_collect,1343 08:43:55 INFO - PROCESS | 1638 | __end_cc_report 08:43:55 INFO - PROCESS | 1638 | __startTimestamp1479314635363__endTimestamp 08:43:55 INFO - PROCESS | 1638 | 08:43:55 INFO - PROCESS | 1638 | ------- Summary: start ------- 08:43:55 INFO - PROCESS | 1638 | Number of tests: 6 08:43:55 INFO - PROCESS | 1638 | 08:43:55 INFO - PROCESS | 1638 | [#0] dojo.html Cycles:165 Average:5814.38 Median:6052.39 stddev:625.81 (10.3%) stddev-sans-first:599.40 08:43:55 INFO - PROCESS | 1638 | Values: 3441.5 3447.2 3485.3 3487.7 3535.7 5787.6 5850.1 5885.4 5894.6 5919.1 5561.6 5765.2 5825.7 5920.8 5930.5 5181.6 5306.9 5352.7 5387.7 5407.6 5262.2 5262.9 5265.9 5398.6 5434.9 5402.0 5407.2 5407.6 5418.2 5423.9 5288.1 5335.8 5341.6 5348.8 5371.8 5285.2 5305.8 5321.8 5386.1 5421.3 5633.4 5937.3 5938.1 5964.8 6043.4 5184.5 6145.1 6187.4 6199.0 6242.7 5675.0 5917.6 6249.0 6257.6 6265.9 5950.0 5955.9 5956.4 5962.8 5979.5 6189.0 6241.5 6261.6 6293.6 6349.8 5408.8 6215.6 6248.9 6249.5 6253.4 6144.8 6253.0 6292.8 6307.5 6321.9 6111.2 6127.0 6142.6 6168.9 6232.8 6283.7 6289.4 6308.1 6311.8 6318.2 5059.2 5103.9 5115.9 5118.9 5130.0 4467.1 4479.2 4541.7 4567.7 4618.2 5198.9 5478.7 5800.3 5864.6 5920.6 5505.9 5978.1 6239.4 6259.1 6272.8 5665.3 5855.4 5855.7 5860.0 5897.1 4407.4 5421.2 5497.5 5505.7 5535.1 6422.1 6486.9 6489.0 6493.5 6494.5 6296.6 6296.7 6299.2 6307.7 6308.2 6259.5 6282.1 6346.5 6358.0 6395.4 6295.6 6298.7 6313.1 6319.3 6327.1 6267.7 6281.2 6283.3 6285.1 6301.9 6069.6 6116.5 6128.2 6235.6 6289.1 6119.7 6264.0 6269.5 6275.8 6284.6 5948.0 6140.8 6146.6 6178.8 6188.9 6081.4 6140.4 6200.5 6208.8 6278.4 6052.4 6109.4 6121.8 6174.6 6184.5 08:43:55 INFO - PROCESS | 1638 | 08:43:55 INFO - PROCESS | 1638 | [#1] ext.html Cycles:180 Average:78950.49 Median:36544.95 stddev:181727.01 (497.3%) stddev-sans-first:182141.34 08:43:55 INFO - PROCESS | 1638 | Values: 497.5 503.6 514.0 534.6 577.1 32690.5 42172.9 43507.8 43599.3 46045.5 44974.6 45268.9 45298.8 45411.3 45620.5 9889.0 10060.5 10067.9 10071.1 10081.0 9236.7 9515.3 12178.9 12438.4 12485.2 12458.7 12545.9 12560.2 12561.2 12564.4 12433.7 12475.4 12484.2 12486.3 12493.2 12270.9 12337.9 12338.4 12341.0 12363.9 41872.0 42100.8 42146.4 42155.2 42166.0 3415.4 3551.1 3715.4 3935.2 3983.9 26155.6 32324.0 32472.7 32935.0 33378.8 3316.6 3392.1 3399.5 3403.1 3416.6 543821.3 543860.0 544398.6 544905.0 545061.0 34322.6 58730.0 59224.0 59292.5 59321.0 35421.0 36404.6 36516.5 36573.5 36576.6 15910.1 16069.8 16093.4 16105.3 16136.3 12509.6 12748.3 13630.3 13781.8 13800.9 7771.7 8076.2 8081.8 8084.8 8141.0 3341.3 3369.6 3384.3 3393.1 3403.9 960.6 979.5 1067.9 1136.4 1145.6 30801.7 30837.2 30980.4 31334.0 31452.4 912.8 960.2 1078.2 1138.3 1153.9 15244.8 16010.0 16016.2 16084.0 16363.9 758200.0 760419.0 764582.0 764785.0 764836.0 61034.0 61310.0 61317.8 61353.7 61567.0 1280.8 1287.4 1300.7 1434.7 1465.2 24270.5 31054.1 31922.0 32799.3 33256.3 59221.0 60064.7 60099.7 60136.1 60220.0 699573.0 705217.0 705646.0 705682.0 706352.0 27743.2 37500.6 42619.8 45153.8 45209.8 47845.8 48958.0 49514.0 49519.5 50521.5 39413.4 40904.0 40964.4 41058.6 42317.6 39652.2 40734.2 40855.0 40865.7 42247.0 37480.4 37648.4 37649.6 39991.4 40076.6 33015.8 34555.0 34607.0 35380.8 35488.8 26114.3 26557.1 26596.1 26750.6 26780.8 08:43:55 INFO - PROCESS | 1638 | 08:43:55 INFO - PROCESS | 1638 | [#2] jquery.html Cycles:180 Average:35080.20 Median:2360.57 stddev:104083.79 (4409.3%) stddev-sans-first:104343.09 08:43:55 INFO - PROCESS | 1638 | Values: 346.5 371.0 376.7 382.8 406.8 19311.5 21279.9 22288.3 23050.4 23160.9 11810.4 12170.7 12384.9 12421.9 12428.1 5384.4 5686.9 5692.8 5703.2 5704.9 5565.2 5592.9 6201.6 6295.8 6327.5 6266.4 6280.4 6285.0 6294.0 6326.4 5551.2 5623.4 5630.7 5632.4 5659.6 5205.5 5450.5 5459.8 5474.2 5483.3 13129.0 13288.3 13339.8 13377.3 13451.4 2126.3 2225.8 2345.9 2375.2 2424.6 10242.8 10340.7 10351.3 10749.5 10752.6 1900.7 1915.8 1950.5 1999.3 2011.9 59612.1 92021.0 107795.9 124606.0 136883.5 11527.0 11583.3 11855.3 11949.9 11996.2 15005.8 15039.7 15164.7 15195.9 15208.1 9036.3 9077.3 9134.0 9165.1 9257.8 9090.3 9105.9 9155.1 9313.2 9317.2 4627.6 4628.9 4633.2 4637.1 4698.2 1699.4 1960.6 2014.2 2016.3 2024.5 833.3 896.7 899.6 987.5 991.3 18230.7 21454.9 22222.6 22650.0 22852.7 908.8 923.3 933.9 938.5 954.8 10940.9 11560.4 11573.7 11629.4 11700.2 590592.0 607148.9 642707.0 643094.0 645521.8 100044.4 107515.5 127764.0 129897.0 137567.6 1004.9 1018.2 1022.4 1023.3 1042.6 19935.1 20270.9 20669.8 20799.8 20847.9 55780.7 55902.4 57510.0 58146.1 58156.4 80292.0 82557.2 82996.6 84938.0 86337.6 7962.1 8157.4 8172.1 8372.2 8401.8 10302.3 12819.6 13053.2 13263.8 13282.9 9211.7 11114.3 11373.4 11679.6 11794.5 8611.4 10079.5 10816.6 11021.6 11824.3 9473.8 9650.6 11634.0 11670.7 11771.9 7259.3 7492.9 7601.2 7756.1 8644.0 9927.8 11354.4 11604.2 11860.5 11929.4 08:43:55 INFO - PROCESS | 1638 | 08:43:55 INFO - PROCESS | 1638 | [#3] mootools.html Cycles:180 Average:5922.87 Median:4845.91 stddev:3351.34 (69.2%) stddev-sans-first:3344.02 08:43:55 INFO - PROCESS | 1638 | Values: 1467.9 1578.8 1788.2 1944.0 1958.1 8802.8 9335.1 9341.5 9344.4 9350.3 8197.3 8484.5 8885.3 9074.1 9098.8 2423.8 2455.2 2456.5 2457.0 2458.8 2420.5 2423.5 2454.5 2456.6 2460.5 2431.5 2436.5 2449.1 2455.5 2459.2 2408.6 2417.6 2425.1 2425.5 2441.3 2414.5 2430.3 2431.1 2431.3 2434.7 9125.5 9345.7 9355.6 9369.4 9371.8 5460.7 5639.8 5643.1 5651.9 5652.2 3652.4 3772.6 3819.0 3855.3 3861.7 1013.6 1030.2 1036.9 1052.6 1054.6 12249.7 12296.9 12310.5 12322.8 12336.3 4749.2 4767.2 4811.5 4923.3 4938.2 10457.8 10465.8 10491.1 10491.2 10501.5 5588.2 5589.1 5590.2 5605.9 5608.4 4086.4 4585.5 4737.2 5060.7 5095.8 3999.2 4020.3 4102.4 4131.5 4131.7 1276.3 1277.8 1283.4 1292.5 1301.3 778.2 813.8 911.9 915.8 927.8 5881.7 5895.9 6078.4 6094.3 6173.6 893.6 905.2 932.5 971.0 1003.8 3769.1 3895.1 4001.9 4065.5 4085.5 9480.5 10611.7 11340.9 11363.5 11394.3 10476.9 11294.6 11307.4 11311.7 11319.8 8224.3 8556.0 8564.6 8575.1 8585.5 5754.4 6032.7 6064.4 6068.0 6186.1 9889.2 10280.4 10317.8 10467.4 10468.3 10728.6 10738.4 10743.1 10754.2 10797.4 7187.5 7426.3 7634.4 7829.2 7967.1 8474.4 8805.8 8806.7 8820.0 8820.6 7547.9 7690.5 7696.5 7795.0 7817.2 7373.3 7506.2 7532.4 7555.8 7571.5 7147.8 7293.6 7293.9 7303.4 7327.7 4636.7 4880.3 4911.7 5081.1 5107.2 5065.2 5073.4 5179.0 5182.7 5232.3 08:43:55 INFO - PROCESS | 1638 | 08:43:55 INFO - PROCESS | 1638 | [#4] prototype.html Cycles:180 Average:4544.98 Median:5174.38 stddev:1429.75 (27.6%) stddev-sans-first:1397.29 08:43:55 INFO - PROCESS | 1638 | Values: 270.2 298.5 303.6 309.9 315.9 5350.3 5373.7 5399.6 5444.0 5448.9 4696.5 5138.3 5167.0 5194.8 5197.1 3889.5 4013.5 4043.0 4053.4 4149.2 4036.2 4049.3 4104.5 4130.8 4163.6 3845.4 4021.5 4023.7 4031.5 4053.7 3364.4 3981.2 3997.9 4015.0 4029.3 3024.6 3071.9 3459.2 3462.9 3463.7 4140.6 5022.3 5114.6 5137.5 5229.6 4502.0 4552.8 4590.7 4590.7 4596.2 4994.7 5235.0 5470.5 5501.6 5525.4 3586.4 3682.6 3793.2 3875.3 3877.2 5600.1 5811.3 5814.6 5818.5 5878.5 3206.7 3434.9 3847.4 3891.0 3899.5 3927.9 3936.5 3942.7 3951.8 3978.2 4242.6 4276.0 4344.9 4588.0 4600.7 4507.7 4631.3 5498.0 5571.0 5617.8 1083.5 1130.9 1184.7 1297.2 1309.6 783.1 796.2 849.6 865.7 871.0 4533.4 4556.2 5181.7 5183.3 5195.6 4625.2 5226.7 5344.5 5597.7 5621.0 4949.4 5110.4 5221.5 5305.4 5353.8 2438.8 2985.4 2991.6 2995.0 2996.7 5572.0 5677.8 5899.0 5921.3 5971.6 5896.6 5921.5 5921.7 5932.7 5934.7 6007.2 6041.3 6056.5 6094.8 6101.5 5365.7 5708.8 5762.6 5857.1 5867.5 5290.3 5678.9 5782.8 5791.9 5799.7 5870.5 5968.1 5971.6 6061.4 6095.5 3306.1 3851.5 3893.0 3911.3 3929.7 5053.2 5813.8 5857.4 5901.0 5929.7 4241.7 5600.7 5746.9 5757.4 5796.8 5017.6 5428.9 5581.7 5599.2 5599.4 4896.1 5214.3 5238.8 5245.1 5443.2 5514.5 5603.9 5616.9 5633.0 5700.6 4859.8 5077.0 5506.7 5534.1 5565.6 08:43:55 INFO - PROCESS | 1638 | 08:43:55 INFO - PROCESS | 1638 | [#5] yui.html Cycles:180 Average:26600.56 Median:25331.18 stddev:42599.23 (168.2%) stddev-sans-first:42674.39 08:43:55 INFO - PROCESS | 1638 | Values: 713.3 723.2 814.8 833.1 863.3 15962.5 17119.3 17138.4 17192.4 17214.7 15387.0 15457.9 15488.5 15495.0 15569.9 659.9 696.9 709.9 892.2 895.4 905.3 906.5 915.2 916.8 921.5 976.2 979.9 981.5 981.5 982.5 969.1 973.4 975.9 977.6 979.9 724.5 724.5 726.5 729.2 729.3 14766.5 15746.3 16493.3 16548.4 16704.3 14847.9 15313.4 15437.7 15551.0 16026.6 11714.5 12153.4 12402.8 12478.7 12517.0 3922.3 3994.2 4176.0 4209.4 4212.1 126232.0 126277.0 129059.0 136169.0 136626.6 11696.7 11914.2 12016.8 12406.3 12476.1 25280.0 25321.1 25322.0 25340.4 25350.2 7689.5 8381.6 8486.4 8562.7 8664.3 3881.0 4492.0 4585.1 4640.0 4689.1 3618.7 3634.9 3785.4 3787.6 3790.1 629.8 694.6 695.6 704.9 712.7 629.3 642.2 643.7 648.0 652.7 9191.3 9493.3 9593.5 9611.8 9757.5 578.3 655.1 669.6 670.7 677.1 4488.8 4659.7 4668.7 4680.1 4703.3 152202.0 153541.2 156585.0 157315.0 173687.0 134524.0 134951.0 134969.6 137238.0 140549.0 110280.0 113767.0 114247.0 117358.4 117994.0 10277.0 10574.8 10641.1 10717.6 10911.5 62626.4 62648.0 64638.4 64654.0 64761.0 90098.5 90492.5 91006.0 92150.0 99045.0 13605.3 13630.5 14005.9 14017.8 14141.6 14943.3 15161.8 15502.7 15711.5 15744.4 14035.7 14227.9 14281.2 14364.1 14386.4 13893.7 14149.6 14442.6 14658.5 15278.6 14010.6 14075.1 14089.9 14164.0 14307.9 11144.3 11558.7 11710.1 12185.0 12580.9 8612.7 9936.5 10822.4 10983.0 11337.5 08:43:55 INFO - PROCESS | 1638 | -------- Summary: end -------- 08:43:55 INFO - PROCESS | 1638 | 08:43:55 INFO - TEST-INFO | 1638: exit 0 08:43:55 INFO - TEST-OK | dromaeo_css | took 1115783ms 08:43:55 INFO - TEST-START | kraken 08:43:55 INFO - operating with platform_type : mac_ 08:43:55 INFO - Initialising browser for kraken test... 08:43:55 INFO - TEST-INFO | started process 1649 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/tmpZHT3jt/profile http://localhost:49243/getInfo.html) 08:43:58 INFO - PROCESS | 1649 | __metrics Screen width/height:1600/1200 08:43:58 INFO - PROCESS | 1649 | colorDepth:24 08:43:58 INFO - PROCESS | 1649 | Browser inner width/height: 1024/689 08:43:58 INFO - PROCESS | 1649 | __metrics 08:43:58 INFO - PROCESS | 1649 | 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" 08:43:58 INFO - PROCESS | 1649 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:43:58 INFO - TEST-INFO | 1649: exit 0 08:43:58 INFO - Browser initialized. 08:43:58 INFO - Running cycle 1/1 for kraken test... 08:43:58 INFO - TEST-INFO | started process 1651 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/tmpZHT3jt/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:44:10 INFO - PROCESS | 1651 | RSS: Main: 168112128 08:44:10 INFO - PROCESS | 1651 | 08:44:13 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-beat-detection) 08:44:14 INFO - PROCESS | 1651 | RSS: Main: 217600000 08:44:14 INFO - PROCESS | 1651 | 08:44:17 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-dft) 08:44:17 INFO - PROCESS | 1651 | RSS: Main: 228298752 08:44:17 INFO - PROCESS | 1651 | 08:44:20 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-fft) 08:44:21 INFO - PROCESS | 1651 | RSS: Main: 325992448 08:44:21 INFO - PROCESS | 1651 | 08:44:23 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-oscillator) 08:44:24 INFO - PROCESS | 1651 | RSS: Main: 227864576 08:44:24 INFO - PROCESS | 1651 | 08:44:26 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:44:26 INFO - PROCESS | 1651 | RSS: Main: 229617664 08:44:26 INFO - PROCESS | 1651 | 08:44:29 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-darkroom) 08:44:30 INFO - PROCESS | 1651 | RSS: Main: 265949184 08:44:30 INFO - PROCESS | 1651 | 08:44:32 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-desaturate) 08:44:33 INFO - PROCESS | 1651 | RSS: Main: 266260480 08:44:33 INFO - PROCESS | 1651 | 08:44:36 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49243/tests/kraken/driver.html?testName=json-parse-financial) 08:44:36 INFO - PROCESS | 1651 | RSS: Main: 264482816 08:44:36 INFO - PROCESS | 1651 | 08:44:38 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49243/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:44:38 INFO - PROCESS | 1651 | RSS: Main: 240418816 08:44:38 INFO - PROCESS | 1651 | 08:44:40 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:44:41 INFO - PROCESS | 1651 | RSS: Main: 245223424 08:44:41 INFO - PROCESS | 1651 | 08:44:43 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:44:44 INFO - PROCESS | 1651 | RSS: Main: 252661760 08:44:44 INFO - PROCESS | 1651 | 08:44:46 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:44:47 INFO - PROCESS | 1651 | RSS: Main: 263720960 08:44:47 INFO - PROCESS | 1651 | 08:44:50 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:44:51 INFO - PROCESS | 1651 | RSS: Main: 257847296 08:44:51 INFO - PROCESS | 1651 | 08:44:52 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49243/tests/kraken/driver.html?testName=ai-astar) 08:44:53 INFO - PROCESS | 1651 | RSS: Main: 301662208 08:44:53 INFO - PROCESS | 1651 | 08:44:53 INFO - PROCESS | 1651 | __start_tp_report 08:44:53 INFO - PROCESS | 1651 | _x_x_mozilla_page_load 08:44:53 INFO - PROCESS | 1651 | _x_x_mozilla_page_load_details 08:44:53 INFO - PROCESS | 1651 | |i|pagename|runs| 08:44:53 INFO - PROCESS | 1651 | |0;ai-astar;114;113;112;113;113;111;111;113;111;113 08:44:53 INFO - PROCESS | 1651 | |1;audio-beat-detection;142;108;112;138;107;94;135;93;159;138 08:44:53 INFO - PROCESS | 1651 | |2;audio-dft;183;183;195;257;204;182;182;180;184;183 08:44:53 INFO - PROCESS | 1651 | |3;audio-fft;80;58;59;86;67;58;57;59;81;59 08:44:53 INFO - PROCESS | 1651 | |4;audio-oscillator;90;71;92;70;67;68;90;66;67;89 08:44:53 INFO - PROCESS | 1651 | |5;imaging-gaussian-blur;87;84;87;83;86;87;134;125;86;83 08:44:53 INFO - PROCESS | 1651 | |6;imaging-darkroom;92;92;92;92;91;92;92;92;93;91 08:44:53 INFO - PROCESS | 1651 | |7;imaging-desaturate;85;84;95;142;84;83;83;83;85;84 08:44:53 INFO - PROCESS | 1651 | |8;json-parse-financial;55;53;54;52;54;56;56;54;55;55 08:44:53 INFO - PROCESS | 1651 | |9;json-stringify-tinderbox;70;67;67;76;69;69;68;69;68;69 08:44:53 INFO - PROCESS | 1651 | |10;stanford-crypto-aes;84;83;81;71;79;93;100;101;102;77 08:44:53 INFO - PROCESS | 1651 | |11;stanford-crypto-ccm;136;135;132;132;134;134;139;140;165;141 08:44:53 INFO - PROCESS | 1651 | |12;stanford-crypto-pbkdf2;162;159;159;157;162;158;156;158;159;161 08:44:53 INFO - PROCESS | 1651 | |13;stanford-crypto-sha256-iterative;66;66;65;65;66;66;65;65;66;76 08:44:53 INFO - PROCESS | 1651 | __end_tp_report 08:44:53 INFO - PROCESS | 1651 | __start_cc_report 08:44:53 INFO - PROCESS | 1651 | _x_x_mozilla_cycle_collect,1944 08:44:53 INFO - PROCESS | 1651 | __end_cc_report 08:44:53 INFO - PROCESS | 1651 | __startTimestamp1479314693106__endTimestamp 08:44:53 INFO - PROCESS | 1651 | 08:44:53 INFO - PROCESS | 1651 | ------- Summary: start ------- 08:44:53 INFO - PROCESS | 1651 | Number of tests: 14 08:44:53 INFO - PROCESS | 1651 | 08:44:53 INFO - PROCESS | 1651 | [#0] ai-astar Cycles:10 Average:112.40 Median:113.00 stddev:1.07 (1.0%) stddev-sans-first:0.97 08:44:53 INFO - PROCESS | 1651 | Values: 114.0 113.0 112.0 113.0 113.0 111.0 111.0 113.0 111.0 113.0 08:44:53 INFO - PROCESS | 1651 | 08:44:53 INFO - PROCESS | 1651 | [#1] audio-beat-detection Cycles:10 Average:122.60 Median:140.00 stddev:22.59 (16.1%) stddev-sans-first:22.84 08:44:53 INFO - PROCESS | 1651 | Values: 142.0 108.0 112.0 138.0 107.0 94.0 135.0 93.0 159.0 138.0 08:44:53 INFO - PROCESS | 1651 | 08:44:53 INFO - PROCESS | 1651 | [#2] audio-dft Cycles:10 Average:193.30 Median:183.50 stddev:23.60 (12.9%) stddev-sans-first:24.73 08:44:53 INFO - PROCESS | 1651 | Values: 183.0 183.0 195.0 257.0 204.0 182.0 182.0 180.0 184.0 183.0 08:44:53 INFO - PROCESS | 1651 | 08:44:53 INFO - PROCESS | 1651 | [#3] audio-fft Cycles:10 Average:66.40 Median:63.00 stddev:11.43 (18.1%) stddev-sans-first:11.02 08:44:53 INFO - PROCESS | 1651 | Values: 80.0 58.0 59.0 86.0 67.0 58.0 57.0 59.0 81.0 59.0 08:44:53 INFO - PROCESS | 1651 | 08:44:53 INFO - PROCESS | 1651 | [#4] audio-oscillator Cycles:10 Average:77.00 Median:80.00 stddev:11.52 (14.4%) stddev-sans-first:11.22 08:44:53 INFO - PROCESS | 1651 | Values: 90.0 71.0 92.0 70.0 67.0 68.0 90.0 66.0 67.0 89.0 08:44:53 INFO - PROCESS | 1651 | 08:44:53 INFO - PROCESS | 1651 | [#5] imaging-gaussian-blur Cycles:10 Average:94.20 Median:86.00 stddev:18.79 (21.8%) stddev-sans-first:19.75 08:44:53 INFO - PROCESS | 1651 | Values: 87.0 84.0 87.0 83.0 86.0 87.0 134.0 125.0 86.0 83.0 08:44:53 INFO - PROCESS | 1651 | 08:44:53 INFO - PROCESS | 1651 | [#6] imaging-darkroom Cycles:10 Average:91.90 Median:92.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 08:44:53 INFO - PROCESS | 1651 | Values: 92.0 92.0 92.0 92.0 91.0 92.0 92.0 92.0 93.0 91.0 08:44:53 INFO - PROCESS | 1651 | 08:44:53 INFO - PROCESS | 1651 | [#7] imaging-desaturate Cycles:10 Average:90.80 Median:84.00 stddev:18.34 (21.8%) stddev-sans-first:19.33 08:44:53 INFO - PROCESS | 1651 | Values: 85.0 84.0 95.0 142.0 84.0 83.0 83.0 83.0 85.0 84.0 08:44:53 INFO - PROCESS | 1651 | 08:44:53 INFO - PROCESS | 1651 | [#8] json-parse-financial Cycles:10 Average:54.40 Median:55.00 stddev:1.26 (2.3%) stddev-sans-first:1.32 08:44:53 INFO - PROCESS | 1651 | Values: 55.0 53.0 54.0 52.0 54.0 56.0 56.0 54.0 55.0 55.0 08:44:53 INFO - PROCESS | 1651 | 08:44:53 INFO - PROCESS | 1651 | [#9] json-stringify-tinderbox Cycles:10 Average:69.20 Median:69.00 stddev:2.57 (3.7%) stddev-sans-first:2.71 08:44:53 INFO - PROCESS | 1651 | Values: 70.0 67.0 67.0 76.0 69.0 69.0 68.0 69.0 68.0 69.0 08:44:53 INFO - PROCESS | 1651 | 08:44:53 INFO - PROCESS | 1651 | [#10] stanford-crypto-aes Cycles:10 Average:87.10 Median:80.00 stddev:11.09 (13.9%) stddev-sans-first:11.71 08:44:53 INFO - PROCESS | 1651 | Values: 84.0 83.0 81.0 71.0 79.0 93.0 100.0 101.0 102.0 77.0 08:44:53 INFO - PROCESS | 1651 | 08:44:53 INFO - PROCESS | 1651 | [#11] stanford-crypto-ccm Cycles:10 Average:138.80 Median:137.50 stddev:9.74 (7.1%) stddev-sans-first:10.28 08:44:53 INFO - PROCESS | 1651 | Values: 136.0 135.0 132.0 132.0 134.0 134.0 139.0 140.0 165.0 141.0 08:44:53 INFO - PROCESS | 1651 | 08:44:53 INFO - PROCESS | 1651 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.10 Median:159.00 stddev:2.02 (1.3%) stddev-sans-first:1.86 08:44:53 INFO - PROCESS | 1651 | Values: 162.0 159.0 159.0 157.0 162.0 158.0 156.0 158.0 159.0 161.0 08:44:53 INFO - PROCESS | 1651 | 08:44:53 INFO - PROCESS | 1651 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.60 Median:66.00 stddev:3.34 (5.1%) stddev-sans-first:3.54 08:44:53 INFO - PROCESS | 1651 | Values: 66.0 66.0 65.0 65.0 66.0 66.0 65.0 65.0 66.0 76.0 08:44:53 INFO - PROCESS | 1651 | -------- Summary: end -------- 08:44:53 INFO - PROCESS | 1651 | 08:44:53 INFO - TEST-INFO | 1651: exit 0 08:44:54 INFO - TEST-OK | kraken | took 58065ms 08:44:54 INFO - SUITE-END | took 1173s 08:44:54 INFO - Completed test suite (00:19:34) 08:44:54 INFO - javascript benchmark 08:44:54 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3441.500982357559, 3447.2416068464936, 3485.3377858206954, 3487.651234876511, 3535.7348198885074, 5787.594868359217, 5850.0932355484965, 5885.352611212763, 5894.64632122073, 5919.08254220596, 5561.63849349792, 5765.1928729977835, 5825.737841797119, 5920.763169473216, 5930.495907847838, 5181.637285390024, 5306.867328316804, 5352.678839269656, 5387.703676297802, 5407.567394608442, 5262.184361423985, 5262.947410517892, 5265.8946821063555, 5398.649087809299, 5434.891302173974, 5402.0, 5407.242985981946, 5407.621466497347, 5418.241446197536, 5423.864403389927, 5288.127458969266, 5335.813246536352, 5341.572674186094, 5348.786048558053, 5371.75827087782, 5285.180796976475, 5305.761240744176, 5321.760520776575, 5386.111291636876, 5421.2952316199035, 5633.40849210831, 5937.287525496968, 5938.138969849391, 5964.791232306892, 6043.365446628085, 5184.507471790212, 6145.095020543601, 6187.381261873822, 6198.969005154991, 6242.656653884034, 5675.035244008528, 5917.615355001911, 6248.968755156195, 6257.5619706620555, 6265.906011409833, 5950.0, 5955.880882382328, 5956.434138756811, 5962.821115366546, 5979.521638268928, 6188.9690551546955, 6241.500679945593, 6261.624302541862, 6293.559450838489, 6349.809505714836, 5408.7830238196875, 6215.564910456315, 6248.9062664060075, 6249.468795152463, 6253.437190652772, 6144.754209831557, 6252.96778546974, 6292.811215663537, 6307.5269354798575, 6321.8735625288155, 6111.166351794787, 6126.969365153146, 6142.587204942888, 6168.8766224675255, 6232.844178895473, 6283.654399008098, 6289.433950944437, 6308.08532762756, 6311.810645680637, 6318.178636777189, 5059.165237735732, 5103.948960510347, 5115.948840511547, 5118.897622047538, 5129.9743501283, 4467.061916997402, 4479.17135329965, 4541.72749635023, 4567.6802623816675, 4618.237990731559, 5198.896022079537, 5478.671279723229, 5800.303963524404, 5864.648121112747, 5920.585559010914, 5505.898820235969, 5978.103284507271, 6239.438450539473, 6259.123722678829, 6272.8118156455375, 5665.320161580555, 5855.443732845373, 5855.677937713382, 5860.0, 5897.056470964625, 4407.449068866392, 5421.241026256327, 5497.45025497455, 5505.6696598204235, 5535.086710692691, 6422.068800024063, 6486.870262594816, 6489.0266460030425, 6493.51298652603, 6494.512911531559, 6296.622202667854, 6296.685165741603, 6299.212598425197, 6307.653079080511, 6308.243010838729, 6259.499240060875, 6282.089097080989, 6346.524010699124, 6358.0, 6395.392437718409, 6295.622262664255, 6298.685065746786, 6313.05304204373, 6319.304876463493, 6327.11420401135, 6267.655278959519, 6281.246250449975, 6283.277423096402, 6285.120083188266, 6301.873962520815, 6069.575129740876, 6116.457510225511, 6128.233970753656, 6235.563510554399, 6289.119523266838, 6119.724612392542, 6263.96868015657, 6269.467095296951, 6275.843103922256, 6284.591501552384, 5947.9702601486715, 6140.846478838065, 6146.6004709693725, 6178.783742568989, 6188.876222475616, 6081.422264884829, 6140.350877193083, 6200.472959798287, 6208.751649933952, 6278.372162783685, 6052.394760523913, 6109.419605137505, 6121.785737499166, 6174.598651087665, 6184.505239580732], "value": 5776.885529844671, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [497.5323196195578, 503.57990466883405, 513.9563137133343, 534.5589888342117, 577.0853197681674, 32690.509642355384, 42172.945676358104, 43507.78246108773, 43599.34600980988, 46045.539544604544, 44974.550254497524, 45268.86827829306, 45298.77350613251, 45411.31883021758, 45620.54379456204, 9888.950555247231, 10060.496975151249, 10067.899321006806, 10071.093601575856, 10081.0, 9236.722898313028, 9515.333926625104, 12178.878211217907, 12438.440270187863, 12485.188462749938, 12458.688532786708, 12545.874541254607, 12560.246385216871, 12561.183523070971, 12564.371781410939, 12433.689157771083, 12475.438605262785, 12484.188527745713, 12486.313252771093, 12493.187942783781, 12270.938645306716, 12337.938310308391, 12338.444769985283, 12340.951019163382, 12363.93818030904, 41872.0, 42100.78949605263, 42146.36780448296, 42155.15689686189, 42166.0, 3415.351083294166, 3551.147724546116, 3715.386961151407, 3935.153941902505, 3983.940240896389, 26155.607665885025, 32324.0, 32472.675273247438, 32935.0, 33378.831740889196, 3316.6351701312838, 3392.0671815250757, 3399.456087026089, 3403.064157356722, 3416.5900091988874, 543821.2808935969, 543860.0, 544398.5560144427, 544905.0, 545061.0, 34322.59741818099, 58730.0, 59224.0, 59292.51768705817, 59321.0, 35421.0, 36404.63595364065, 36516.45225321622, 36573.451398229045, 36576.63423365785, 15910.12494312824, 16069.758953615705, 16093.436729714404, 16105.27526261321, 16136.273867675984, 12509.562165324352, 12748.298843563507, 13630.250336231602, 13781.793273100911, 13800.93099534496, 7771.72798952034, 8076.232757887991, 8081.787731840153, 8084.7574572762915, 8141.0230772307705, 3341.2649217172184, 3369.629340772562, 3384.323135372935, 3393.1177893747804, 3403.9489407658907, 960.6109525642127, 979.4955597867104, 1067.893210678926, 1136.4261048170622, 1145.627671006926, 30801.69198308033, 30837.229069273, 30980.380392392028, 31334.0, 31452.37095258082, 912.7991841794794, 960.188640598693, 1078.245228340165, 1138.3283862521153, 1153.8730739618802, 15244.771328430083, 16010.0, 16016.199190040452, 16084.0, 16363.918180409022, 758200.0, 760419.0, 764582.0, 764785.0, 764836.0, 61034.0, 61310.0, 61317.77364452686, 61353.69323153356, 61567.0, 1280.846298444174, 1287.3756228229488, 1300.674831292177, 1434.6771976305247, 1465.157534417714, 24270.51458970846, 31054.068377948697, 31922.0, 32799.344013119124, 33256.33487330288, 59221.0, 60064.69967650134, 60099.69950150221, 60136.09795853153, 60220.0, 699573.0042699508, 705217.0, 705646.0, 705682.0, 706352.0, 27743.167704968884, 37500.62499374971, 42619.786901065294, 45153.77423112995, 45209.77395113135, 47845.76077119592, 48958.0, 49514.0, 49519.50480495149, 50521.49478505168, 39413.408798868615, 40903.977400564036, 40964.38553421761, 41058.5629502966, 42317.576824231364, 39652.2069558613, 40734.185316294104, 40855.0, 40865.687460629924, 42247.0, 37480.437793432575, 37648.43527347037, 37649.62350376461, 39991.400128997506, 40076.599234008456, 33015.83492082524, 34555.0, 34607.0, 35380.82309588538, 35488.822555887054, 26114.347141321618, 26557.07050253232, 26596.069137580093, 26750.59874101851, 26780.77369323976], "value": 20293.829378025534, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [346.4560639795521, 370.9944350834736, 376.65347879950446, 382.8372941499863, 406.7640768354355, 19311.46469697121, 21279.893600531977, 22288.331350059485, 23050.423739406524, 23160.884195578998, 11810.409479526032, 12170.695732606668, 12384.938075309634, 12421.875781242185, 12428.073648584485, 5384.3538775346915, 5686.914696279559, 5692.829215123532, 5703.230063941377, 5704.8859022819515, 5565.165225216229, 5592.86017849555, 6201.596896201755, 6295.842603934915, 6327.46216571592, 6266.404691554295, 6280.371962803706, 6284.994400895857, 6293.968530157343, 6326.430621244087, 5551.2228288039705, 5623.409541998072, 5630.690312032836, 5632.35227948787, 5659.575531835108, 5205.453427390145, 5450.509454149145, 5459.808906688247, 5474.151506516497, 5483.341998960151, 13129.0, 13288.335583220896, 13339.799903001463, 13377.331133443386, 13451.394687239097, 2126.319577735125, 2225.810806081485, 2345.8944347504403, 2375.239923224569, 2424.5878200705924, 10242.79514409715, 10340.689779306633, 10351.327163734333, 10749.462526873704, 10752.623658172004, 1900.7338972543855, 1915.8467322614297, 1950.4636225038228, 1999.2502811445709, 2011.8532436511196, 59612.10581841276, 92021.0, 107795.92204077938, 124606.0, 136883.47140907246, 11527.020203282815, 11583.305001699924, 11855.288682679067, 11949.88050119505, 11996.220245684002, 15005.849941500444, 15039.699206016037, 15164.696706066037, 15195.92402038005, 15208.08751474915, 9036.32227582934, 9077.319201059947, 9134.0, 9165.129312715282, 9257.814843703223, 9090.27277817773, 9105.908940910638, 9155.084491550924, 9313.161815436642, 9317.16145546904, 4627.5603817637275, 4628.884277893079, 4633.189191891405, 4637.072585482917, 4698.1778188816825, 1699.447679504166, 1960.5686748915216, 2014.2245235584405, 2016.3043749906258, 2024.514116612032, 833.3458235285393, 896.6996056321075, 899.572702966099, 987.4914419074182, 991.2714155095998, 18230.726539101925, 21454.892725536272, 22222.555548888933, 22650.0, 22852.65721014186, 908.8000639859221, 923.2798417234568, 933.883264591926, 938.4650749072963, 954.8042651256476, 10940.945295273472, 11560.446339291462, 11573.652790416301, 11629.418529073513, 11700.239484433654, 590592.0, 607148.928510718, 642707.0, 643094.0, 645521.772391135, 100044.39722043446, 107515.46242268896, 127764.0, 129897.0, 137567.62432375748, 1004.9397036177853, 1018.1549314069305, 1022.3967858963099, 1023.3194925374692, 1042.5517027678172, 19935.10292036833, 20270.898645506677, 20669.793302067388, 20799.792002079786, 20847.8957605211, 55780.721096394256, 55902.44097558972, 57510.0, 58146.12780808206, 58156.4184358151, 80292.0, 82557.17442825495, 82996.58501707453, 84938.0, 86337.56831215804, 7962.08436029864, 8157.4289799715825, 8172.141925098017, 8372.162783721578, 8401.83196336082, 10302.278840481094, 12819.615411537668, 13053.151545149534, 13263.80104298417, 13282.867171328164, 9211.67759128454, 11114.277571957797, 11373.43132843338, 11679.591214307458, 11794.52821887115, 8611.354148438766, 10079.496025198565, 10816.567337306735, 11021.559137634405, 11824.349660768741, 9473.763155921157, 9650.613975440903, 11634.0, 11670.70823229426, 11771.882281177079, 7259.27407259291, 7492.925070749441, 7601.201873803171, 7756.146823849259, 8644.0, 9927.751806204902, 11354.432278386214, 11604.245724027911, 11860.525578977089, 11929.403529823301], "value": 9392.414033952691, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1467.8825693944486, 1578.7947566816308, 1788.204249109146, 1944.0182707732592, 1958.1090603775274, 8802.779930501732, 9335.113164249402, 9341.486218258011, 9344.439333639977, 9350.298727595433, 8197.262246397822, 8484.533350665712, 8885.289176865852, 9074.137956894085, 9098.818023639524, 2423.81821363398, 2455.177515532299, 2456.545539075277, 2457.0, 2458.7787099161073, 2420.5400973814917, 2423.4789520253144, 2454.484558242771, 2456.5946618807875, 2460.520198561281, 2431.513697260555, 2436.488337449138, 2449.1428000199876, 2455.472073504196, 2459.213051823417, 2408.5664580375524, 2417.637354396837, 2425.0542288507318, 2425.4785221177353, 2441.2554170977846, 2414.5291668124723, 2430.3316587938457, 2431.0761910474084, 2431.258466167818, 2434.6713193718974, 9125.45247285165, 9345.719628411158, 9355.578998945064, 9369.43783372993, 9371.812563748756, 5460.672359658433, 5639.802606908779, 5643.097104463307, 5651.886962260732, 5652.18043383707, 3652.415613501827, 3772.641599048086, 3818.9618103818884, 3855.267499175148, 3861.710371722104, 1013.554036224059, 1030.237624158125, 1036.8600238967717, 1052.6421016854306, 1054.5939813171908, 12249.693757656041, 12296.877031229662, 12310.50757969689, 12322.81515777264, 12336.259824410474, 4749.168895443353, 4767.16700446488, 4811.49479304675, 4923.335349727812, 4938.234573641092, 10457.790844183073, 10465.84301235482, 10491.055804977588, 10491.213159012952, 10501.47492625381, 5588.2455868458055, 5589.077802162679, 5590.161475778585, 5605.943940560543, 5608.411116832755, 4086.3870419436726, 4585.541445855454, 4737.24204127338, 5060.746962651852, 5095.821646242363, 3999.1601763629383, 4020.3165461871554, 4102.405151253051, 4131.5042194936195, 4131.690123240769, 1276.2980360801523, 1277.7827769279245, 1283.4160456992047, 1292.4636275945566, 1301.2517802263546, 778.190681691035, 813.8494378539989, 911.8996910339857, 915.7527467583715, 927.823713494434, 5881.735321910524, 5895.911561326584, 6078.3921607838865, 6094.299155597163, 6173.555644797385, 893.6425429827991, 905.1536813079791, 932.47315266874, 970.9611615535441, 1003.82934901067, 3769.0577355661085, 3895.1370742504237, 4001.8599349023225, 4065.4670042901953, 4085.5097388312997, 9480.525973701288, 10611.681649550372, 11340.94329528347, 11363.488643011084, 11394.259373140885, 10476.895231047745, 11294.60468883585, 11307.434628268553, 11311.717207069725, 11319.773604528027, 8224.300934420642, 8556.016058153267, 8564.614592343234, 8575.142485751376, 8585.527795971157, 5754.446299499028, 6032.6983650818165, 6064.363241859718, 6068.0, 6186.072089186658, 9889.159421449258, 10280.383177009404, 10317.793644126925, 10467.424291663727, 10468.319559228627, 10728.624498142528, 10738.355698658106, 10743.140548756237, 10754.247202695737, 10797.406142662228, 7187.460940429384, 7426.2945020223, 7634.427417943565, 7829.217078292125, 7967.123616402307, 8474.406791524534, 8805.823883522422, 8806.691765788166, 8819.955900220715, 8820.603072861608, 7547.924520754722, 7690.538567685957, 7696.461247712607, 7794.961025194838, 7817.218278172138, 7373.262673732584, 7506.211847755907, 7532.39740820744, 7555.773326800205, 7571.507851989603, 7147.821304467222, 7293.562386256842, 7293.890591641023, 7303.415726741954, 7327.74352897646, 4636.698614590176, 4880.316755654282, 4911.705297682151, 5081.11080560893, 5107.182850743863, 5065.240213967787, 5073.441921388718, 5179.0, 5182.714950677749, 5232.319798426181], "value": 4735.225246180743, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [270.1638429062052, 298.5074626865671, 303.5749950069903, 309.9256178517156, 315.91628218522095, 5350.2777125088105, 5373.677579345242, 5399.572350672441, 5443.9585155566665, 5448.918266226005, 4696.459907110683, 5138.306328645632, 5167.018266529366, 5194.818181363653, 5197.1424714922, 3889.4554762333296, 4013.4581831452747, 4042.959570404302, 4053.371727382246, 4149.232392007489, 4036.1524079943247, 4049.2711311963835, 4104.486939132608, 4130.834766609332, 4163.5836416358425, 3845.365514690073, 4021.4973128358956, 4023.718339716221, 4031.5162180538377, 4053.7299112497094, 3364.444866597021, 3981.203759248133, 3997.900052498682, 4015.0, 4029.315016447211, 3024.561438591392, 3071.9401806376763, 3459.238967427187, 3462.9480557791403, 3463.6709512596262, 4140.627343539066, 5022.296878437021, 5114.590832733373, 5137.460566640524, 5229.555487783505, 4501.954980450187, 4552.817887284505, 4590.678652494326, 4590.74750888701, 4596.184507119702, 4994.650374473788, 5234.97382513085, 5470.452954704538, 5501.642393244426, 5525.364583072957, 3586.4082426399614, 3682.6317368263226, 3793.2413517296377, 3875.341191997339, 3877.2051729395407, 5600.0759874620235, 5811.302643682743, 5814.609969473021, 5818.537969907898, 5878.470937615635, 3206.6633003534293, 3434.866494056955, 3847.403652433877, 3890.9805450972563, 3899.53205615328, 3927.9410808837893, 3936.5079365079364, 3942.6845852331744, 3951.8221680023894, 3978.224246272007, 4242.554531774181, 4275.978620106942, 4344.9131017380105, 4587.990642058741, 4600.723956562617, 4507.706999045052, 4631.282151266559, 5497.972510137423, 5570.972145139248, 5617.8033768817895, 1083.5124194112682, 1130.925620660376, 1184.6860581945791, 1297.156848048757, 1309.6183526379762, 783.0759703549866, 796.1719811396083, 849.6261644876234, 865.7229686500259, 870.9825803484022, 4533.387992620954, 4556.225441674923, 5181.740912954338, 5183.300254465675, 5195.558377537876, 4625.201752939423, 5226.712530810766, 5344.503539009083, 5597.692126933058, 5621.0, 4949.430815456197, 5110.390227078458, 5221.503957124067, 5305.416404195613, 5353.7590808413715, 2438.780509754095, 2985.4178435205363, 2991.641003079601, 2994.9850250748605, 2996.7302942734823, 5572.0, 5677.829665109971, 5899.0, 5921.28944526651, 5971.581989260797, 5896.587238893237, 5921.467067963904, 5921.703914804242, 5932.673702946379, 5934.673592952343, 6007.219061522062, 6041.335453100155, 6056.515478761688, 6094.750576131793, 6101.481374083252, 5365.651232669864, 5708.771649133988, 5762.567807414544, 5857.092150716646, 5867.471927526543, 5290.307101727411, 5678.886422271614, 5782.768689252551, 5791.942080579309, 5799.739011744397, 5870.5010074144175, 5968.134620480093, 5971.552133589911, 6061.424164704346, 6095.51235901118, 3306.0908250231378, 3851.5185601799776, 3893.0, 3911.3350730376474, 3929.724919255739, 5053.2420136979745, 5813.7674493021495, 5857.414258574108, 5900.970495147497, 5929.733162007807, 4241.6606671466825, 5600.719964001865, 5746.885062298814, 5757.3591526414775, 5796.782675638163, 5017.59507337946, 5428.918566221589, 5581.7209139543675, 5599.160125981135, 5599.356074051536, 4896.094222568836, 5214.2960700304975, 5238.764255608583, 5245.082110630548, 5443.183522471502, 5514.455952333353, 5603.859903502445, 5616.893664875672, 5632.971835140798, 5700.600957932905, 4859.757012149449, 5076.974615126901, 5506.697131657797, 5534.142207957773, 5565.5825813063375], "value": 4076.5630888166975, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [713.2724620886696, 723.2442098007582, 814.8044469327364, 833.1335411172381, 863.2662237098464, 15962.521124366272, 17119.31522739092, 17138.400155994543, 17192.39826606066, 17214.74177887331, 15387.0, 15457.922710386432, 15488.535343939671, 15495.0, 15569.922150389231, 659.9078525041065, 696.8571442854203, 709.9041629380046, 892.228222587462, 895.4403497813867, 905.307439808547, 906.5104843384564, 915.2083447817623, 916.7891384981458, 921.4563407589521, 976.1946394224793, 979.9314048016641, 981.4552923127661, 981.5141504955021, 982.5038355630433, 969.1423090564865, 973.4062222044547, 975.9268054895912, 977.5894124467741, 979.8775153105826, 724.4638967164313, 724.5109551053071, 726.4515290955347, 729.2160927003492, 729.2743719998582, 14766.483173088998, 15746.291416886268, 16493.34026638933, 16548.42080527176, 16704.331826726917, 14847.851521484863, 15313.371099721257, 15437.691246175014, 15551.007024830336, 16026.5993350166, 11714.53141874324, 12153.447775967057, 12402.75194496105, 12478.688032799162, 12517.0, 3922.2743792398214, 3994.1811928554575, 4176.0395109124765, 4209.410682504452, 4212.052288235153, 126232.0, 126277.0, 129059.0, 136169.0, 136626.6337336624, 11696.70758231051, 11914.225575337576, 12016.819747703792, 12406.317652529198, 12476.064295177897, 25279.988800447776, 25321.113761018278, 25322.0, 25340.366490837878, 25350.239492815246, 7689.538627682357, 8381.622826972802, 8486.40595158333, 8562.700305489278, 8664.306855451548, 3880.980595097063, 4491.955080449219, 4585.082983403333, 4640.025594625166, 4689.062187562501, 3618.7285953553587, 3634.945475817865, 3785.413260944558, 3787.5833658298116, 3790.0714324990554, 629.8079085878759, 694.6492021529095, 695.6035060015844, 704.8731228378839, 712.7469748239404, 629.3141466847015, 642.1972534332085, 643.6620774093544, 647.9935200648027, 652.6932341799346, 9191.31065170115, 9493.335466517416, 9593.472359020321, 9611.759706007266, 9757.463339516395, 578.3146970839568, 655.0891179657438, 669.6383952665603, 670.7216505150406, 677.1265068062145, 4488.842890498817, 4659.697119687209, 4668.719876807402, 4680.08738296029, 4703.341532185496, 152202.0, 153541.23229384006, 156585.0, 157315.0, 173687.0, 134524.0, 134951.0, 134969.55213134986, 137238.0, 140549.0, 110280.0, 113767.0, 114247.0, 117358.41320793513, 117994.0, 10277.0, 10574.788504230026, 10641.14870810318, 10717.624883129052, 10911.454427278446, 62626.37373626205, 62648.0, 64638.35361646323, 64654.0, 64761.0, 90098.54950725204, 90492.5475372619, 91006.0, 92150.0, 99045.0, 13605.251711155981, 13630.522931697344, 14005.859941400455, 14017.789733153806, 14141.575752727435, 14943.327550260046, 15161.772573411186, 15502.689946200788, 15711.528654140395, 15744.370225190863, 14035.719285614026, 14227.928860355632, 14281.214533200773, 14364.066335688147, 14386.352614132598, 13893.722125557635, 14149.646258843612, 14442.566722998326, 14658.486952956595, 15278.618034548781, 14010.649733756738, 14075.085119467201, 14089.929550352183, 14164.0, 14307.92846035763, 11144.275622084539, 11558.711032224262, 11710.12174086964, 12185.0, 12580.87419125797, 8612.65549378018, 9936.509523571522, 10822.40476773785, 10983.0, 11337.489812958273], "value": 8270.022629184901, "unit": "score"}], "name": "dromaeo_css", "value": 7484.629735547545, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 113.0, 112.0, 113.0, 113.0, 111.0, 111.0, 113.0, 111.0, 113.0], "value": 112.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 108.0, 112.0, 138.0, 107.0, 94.0, 135.0, 93.0, 159.0, 138.0], "value": 122.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 183.0, 195.0, 257.0, 204.0, 182.0, 182.0, 180.0, 184.0, 183.0], "value": 193.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 58.0, 59.0, 86.0, 67.0, 58.0, 57.0, 59.0, 81.0, 59.0], "value": 66.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 71.0, 92.0, 70.0, 67.0, 68.0, 90.0, 66.0, 67.0, 89.0], "value": 77.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 84.0, 87.0, 83.0, 86.0, 87.0, 134.0, 125.0, 86.0, 83.0], "value": 94.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 92.0, 92.0, 92.0, 91.0, 92.0, 92.0, 92.0, 93.0, 91.0], "value": 91.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 95.0, 142.0, 84.0, 83.0, 83.0, 83.0, 85.0, 84.0], "value": 90.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 53.0, 54.0, 52.0, 54.0, 56.0, 56.0, 54.0, 55.0, 55.0], "value": 54.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 67.0, 67.0, 76.0, 69.0, 69.0, 68.0, 69.0, 68.0, 69.0], "value": 69.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 81.0, 71.0, 79.0, 93.0, 100.0, 101.0, 102.0, 77.0], "value": 87.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 135.0, 132.0, 132.0, 134.0, 134.0, 139.0, 140.0, 165.0, 141.0], "value": 138.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 159.0, 159.0, 157.0, 162.0, 158.0, 156.0, 158.0, 159.0, 161.0], "value": 159.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 65.0, 65.0, 66.0, 66.0, 65.0, 65.0, 66.0, 76.0], "value": 66.6, "unit": "score"}], "name": "kraken", "value": 1423.7999999999997, "alertThreshold": 2.0}]} 08:44:54 INFO - Return code: 0 08:44:54 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:44:54 INFO - # TBPL SUCCESS # 08:44:54 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:44:54 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:44:54 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:44:54 INFO - 2016-11-16 08:44:54.406 screenresolution[1655:9757] starting screenresolution argv=screenresolution get 08:44:54 INFO - 2016-11-16 08:44:54.409 screenresolution[1655:9757] Display 0: 1600x1200x32@60 08:44:54 INFO - 2016-11-16 08:44:54.416 screenresolution[1656:9760] starting screenresolution argv=screenresolution list 08:44:54 INFO - Available Modes on Display 0 08:44:54 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:44:54 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:44:54 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:44:54 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:44:54 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:44:54 INFO - Intel Iris: 08:44:54 INFO - Chipset Model: Intel Iris 08:44:54 INFO - Type: GPU 08:44:54 INFO - Bus: Built-In 08:44:54 INFO - VRAM (Dynamic, Max): 1536 MB 08:44:54 INFO - Vendor: Intel (0x8086) 08:44:54 INFO - Device ID: 0x0a2e 08:44:54 INFO - Revision ID: 0x0009 08:44:54 INFO - Displays: 08:44:54 INFO - Display: 08:44:54 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:44:54 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:44:54 INFO - Display Serial Number: 1600x1200 60 08:44:54 INFO - Main Display: Yes 08:44:54 INFO - Mirror: Off 08:44:54 INFO - Online: Yes 08:44:54 INFO - Rotation: Supported 08:44:54 INFO - Return code: 0 08:44:54 INFO - Running post-action listener: _resource_record_post_action 08:44:54 INFO - [mozharness: 2016-11-16 16:44:54.651113Z] Finished run-tests step (success) 08:44:54 INFO - Running post-run listener: _resource_record_post_run 08:44:54 INFO - Total resource usage - Wall time: 1196s; CPU: 53.0%; Read bytes: 37557248; Write bytes: 492579840; Read time: 240; Write time: 1540 08:44:54 INFO - TinderboxPrint: CPU usage
53.3% 08:44:54 INFO - TinderboxPrint: I/O read bytes / time
37,557,248 / 240 08:44:54 INFO - TinderboxPrint: I/O write bytes / time
492,579,840 / 1,540 08:44:54 INFO - TinderboxPrint: CPU idle
2,233.7 (46.7%) 08:44:54 INFO - TinderboxPrint: CPU system
957.8 (20.0%) 08:44:54 INFO - TinderboxPrint: CPU user
1,594.3 (33.3%) 08:44:54 INFO - TinderboxPrint: Swap in / out
232,779,776 / 0 08:44:54 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 194429440; Write bytes: 186834944; Read time: 17831; Write time: 392 08:44:54 INFO - run-tests - Wall time: 1175s; CPU: 53.0%; Read bytes: 34481152; Write bytes: 295386112; Read time: 218; Write time: 1114 08:44:55 INFO - Running post-run listener: _upload_blobber_files 08:44:55 INFO - Blob upload gear active. 08:44:55 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:44:55 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 08:44:55 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-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:44:55 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-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:44:55 INFO - (blobuploader) - INFO - Open directory for files ... 08:44:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:44:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:44:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:44:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:44:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:44:56 INFO - (blobuploader) - INFO - Done attempting. 08:44:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:44:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:44:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:44:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:44:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:44:57 INFO - (blobuploader) - INFO - Done attempting. 08:44:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:44:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:44:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:44:59 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:44:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:44:59 INFO - (blobuploader) - INFO - Done attempting. 08:44:59 INFO - (blobuploader) - INFO - Iteration through files over. 08:44:59 INFO - Return code: 0 08:44:59 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:44:59 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:44:59 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e3eb1521cd58673b73e694e744e9a97abc6d14c2272fdd78970ab3a6049251ea740cf287b17a23a55f74d054ccd520c6dfa22cbbe500a4c40d66ecb05765d938", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3f6f125273b586201bcfeed0f5d304083e041ecdc746b6cd90db17bc729db6c02a249ad4c2f76e0270fdb260c688f76391e2745dc956d2416751b6b80189d59e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0aff06ca66f2a056b552339b2b1d2326df12633efb2b992385406ce034bb4636e90938303277a3077f0421ce3eeb23f72bab8db5451143c03ffc8c4c17d9318f"} 08:44:59 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:44:59 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:44:59 INFO - Contents: 08:44:59 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e3eb1521cd58673b73e694e744e9a97abc6d14c2272fdd78970ab3a6049251ea740cf287b17a23a55f74d054ccd520c6dfa22cbbe500a4c40d66ecb05765d938", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3f6f125273b586201bcfeed0f5d304083e041ecdc746b6cd90db17bc729db6c02a249ad4c2f76e0270fdb260c688f76391e2745dc956d2416751b6b80189d59e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0aff06ca66f2a056b552339b2b1d2326df12633efb2b992385406ce034bb4636e90938303277a3077f0421ce3eeb23f72bab8db5451143c03ffc8c4c17d9318f"} 08:44:59 INFO - Running post-run listener: copy_logs_to_upload_dir 08:44:59 INFO - Copying logs to upload dir... 08:44:59 INFO - mkdir: /builds/slave/test/build/upload/logs 08:44:59 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1257.864051 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2016-11-16 08:44:59.949245) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-16 08:44:59.952556) ========= 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.ctULmTJgH2/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.jTY7QrzEtg/Listeners TMPDIR=/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/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-Beta/sha512/e3eb1521cd58673b73e694e744e9a97abc6d14c2272fdd78970ab3a6049251ea740cf287b17a23a55f74d054ccd520c6dfa22cbbe500a4c40d66ecb05765d938", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3f6f125273b586201bcfeed0f5d304083e041ecdc746b6cd90db17bc729db6c02a249ad4c2f76e0270fdb260c688f76391e2745dc956d2416751b6b80189d59e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0aff06ca66f2a056b552339b2b1d2326df12633efb2b992385406ce034bb4636e90938303277a3077f0421ce3eeb23f72bab8db5451143c03ffc8c4c17d9318f"} build_url:https://queue.taskcluster.net/v1/task/Upkk4KELQJ6NAO8FhE31-A/artifacts/public/build/firefox-51.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011499 build_url: 'https://queue.taskcluster.net/v1/task/Upkk4KELQJ6NAO8FhE31-A/artifacts/public/build/firefox-51.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e3eb1521cd58673b73e694e744e9a97abc6d14c2272fdd78970ab3a6049251ea740cf287b17a23a55f74d054ccd520c6dfa22cbbe500a4c40d66ecb05765d938", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3f6f125273b586201bcfeed0f5d304083e041ecdc746b6cd90db17bc729db6c02a249ad4c2f76e0270fdb260c688f76391e2745dc956d2416751b6b80189d59e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0aff06ca66f2a056b552339b2b1d2326df12633efb2b992385406ce034bb4636e90938303277a3077f0421ce3eeb23f72bab8db5451143c03ffc8c4c17d9318f"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-16 08:44:59.986095) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-16 08:44:59.986416) ========= 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.ctULmTJgH2/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.jTY7QrzEtg/Listeners TMPDIR=/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/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.005030 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-16 08:45:00.035208) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-16 08:45:00.035577) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-16 08:45:00.035964) ========= ========= Total master_lag: 0.17 =========