builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0149 starttime: 1477673624.55 results: success (0) buildid: 20161028072858 builduid: 53e75692a7ea4801b6db916559c31f56 revision: 70025dbda133b182ebdb88e7f2baa62d914648ce ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-28 09:53:44.547342) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-28 09:53:44.547765) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-28 09:53:44.548050) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-28 09:53:44.573831) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-28 09:53:44.574179) ========= 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.7A89hmbq5J/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.j4ipFywaKg/Listeners TMPDIR=/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-10-28 09:53:44-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 64.5M=0s 2016-10-28 09:53:44 (64.5 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.144464 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-28 09:53:44.741072) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-28 09:53:44.741381) ========= 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.7A89hmbq5J/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.j4ipFywaKg/Listeners TMPDIR=/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/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.026090 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-28 09:53:44.789593) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-28 09:53:44.789921) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 70025dbda133b182ebdb88e7f2baa62d914648ce --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 70025dbda133b182ebdb88e7f2baa62d914648ce --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.7A89hmbq5J/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.j4ipFywaKg/Listeners TMPDIR=/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-10-28 09:53:44,866 truncating revision to first 12 chars 2016-10-28 09:53:44,866 Setting DEBUG logging. 2016-10-28 09:53:44,866 attempt 1/10 2016-10-28 09:53:44,866 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/70025dbda133?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-28 09:53:46,039 unpacking tar archive at: mozilla-aurora-70025dbda133/testing/mozharness/ program finished with exit code 0 elapsedTime=1.420546 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-28 09:53:46.232095) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-28 09:53:46.232408) ========= script_repo_revision: 70025dbda133b182ebdb88e7f2baa62d914648ce ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-28 09:53:46.232789) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-28 09:53:46.233065) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-28 09:53:46.251307) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-10-28 09:53:46.251668) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.7A89hmbq5J/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.j4ipFywaKg/Listeners TMPDIR=/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 09:53:46 INFO - MultiFileLogger online at 20161028 09:53:46 in /builds/slave/test 09:53:46 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 09:53:46 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:53:46 INFO - {'append_to_log': False, 09:53:46 INFO - 'base_work_dir': '/builds/slave/test', 09:53:46 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 09:53:46 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:53:46 INFO - 'branch': 'Mozilla-Aurora', 09:53:46 INFO - 'buildbot_json_path': 'buildprops.json', 09:53:46 INFO - 'config_files': ('talos/mac_config.py',), 09:53:46 INFO - 'default_actions': ('clobber', 09:53:46 INFO - 'read-buildbot-config', 09:53:46 INFO - 'download-and-extract', 09:53:46 INFO - 'populate-webroot', 09:53:46 INFO - 'create-virtualenv', 09:53:46 INFO - 'install', 09:53:46 INFO - 'run-tests'), 09:53:46 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:53:46 INFO - 'download_minidump_stackwalk': True, 09:53:46 INFO - 'download_symbols': 'ondemand', 09:53:46 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:53:46 INFO - 'tooltool.py': '/tools/tooltool.py', 09:53:46 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:53:46 INFO - '/tools/misc-python/virtualenv.py')}, 09:53:46 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:53:46 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:53:46 INFO - 'installer_path': 'installer.exe', 09:53:46 INFO - 'log_level': 'info', 09:53:46 INFO - 'log_name': 'talos', 09:53:46 INFO - 'log_to_console': True, 09:53:46 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 09:53:46 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 09:53:46 INFO - 'opt_config_files': (), 09:53:46 INFO - 'pip_index': False, 09:53:46 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:53:46 INFO - 'cmd': ('bash', 09:53:46 INFO - '-c', 09:53:46 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:53:46 INFO - 'enabled': True, 09:53:46 INFO - 'halt_on_failure': False, 09:53:46 INFO - 'name': 'check_screen_resolution'},), 09:53:46 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:53:46 INFO - 'cmd': ('bash', 09:53:46 INFO - '-c', 09:53:46 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:53:46 INFO - 'enabled': True, 09:53:46 INFO - 'halt_on_failure': False, 09:53:46 INFO - 'name': 'check_screen_resolution'},), 09:53:46 INFO - 'run_cmd_checks_enabled': True, 09:53:46 INFO - 'sps_profile': False, 09:53:46 INFO - 'sps_profile_interval': 0, 09:53:46 INFO - 'suite': 'dromaeojs', 09:53:46 INFO - 'system_bits': '32', 09:53:46 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:53:46 INFO - 'title': 't-yosemite-r7-0149', 09:53:46 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:53:46 INFO - 'use_talos_json': True, 09:53:46 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:53:46 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:53:46 INFO - 'work_dir': 'build'} 09:53:46 INFO - [mozharness: 2016-10-28 16:53:46.452524Z] Running clobber step. 09:53:46 INFO - Running pre-action listener: _resource_record_pre_action 09:53:46 INFO - Running main action method: clobber 09:53:46 INFO - rmtree: /builds/slave/test/build 09:53:46 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:53:48 INFO - Running post-action listener: _resource_record_post_action 09:53:48 INFO - [mozharness: 2016-10-28 16:53:48.566628Z] Finished clobber step (success) 09:53:48 INFO - [mozharness: 2016-10-28 16:53:48.566794Z] Running read-buildbot-config step. 09:53:48 INFO - Running pre-action listener: _resource_record_pre_action 09:53:48 INFO - Running main action method: read_buildbot_config 09:53:48 INFO - Using buildbot properties: 09:53:48 INFO - { 09:53:48 INFO - "project": "", 09:53:48 INFO - "product": "firefox", 09:53:48 INFO - "script_repo_revision": "production", 09:53:48 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 09:53:48 INFO - "repository": "", 09:53:48 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 09:53:48 INFO - "buildid": "20161028072858", 09:53:48 INFO - "pgo_build": "False", 09:53:48 INFO - "basedir": "/builds/slave/test", 09:53:48 INFO - "buildnumber": 20, 09:53:48 INFO - "slavename": "t-yosemite-r7-0149", 09:53:48 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 09:53:48 INFO - "platform": "yosemite_r7", 09:53:48 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 09:53:48 INFO - "branch": "mozilla-aurora", 09:53:48 INFO - "repo_path": "releases/mozilla-aurora", 09:53:48 INFO - "revision": "70025dbda133b182ebdb88e7f2baa62d914648ce", 09:53:48 INFO - "stage_platform": "macosx64", 09:53:48 INFO - "builduid": "53e75692a7ea4801b6db916559c31f56", 09:53:48 INFO - "slavebuilddir": "test" 09:53:48 INFO - } 09:53:48 INFO - Found installer url https://queue.taskcluster.net/v1/task/IRur0sm6SxKg_kCPoZLeuQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg. 09:53:48 INFO - Running post-action listener: _resource_record_post_action 09:53:48 INFO - [mozharness: 2016-10-28 16:53:48.570334Z] Finished read-buildbot-config step (success) 09:53:48 INFO - [mozharness: 2016-10-28 16:53:48.570432Z] Running download-and-extract step. 09:53:48 INFO - Running pre-action listener: _resource_record_pre_action 09:53:48 INFO - Running main action method: download_and_extract 09:53:48 INFO - mkdir: /builds/slave/test/build/tests 09:53:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:53:48 INFO - trying https://queue.taskcluster.net/v1/task/IRur0sm6SxKg_kCPoZLeuQ/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json 09:53:48 INFO - Downloading https://queue.taskcluster.net/v1/task/IRur0sm6SxKg_kCPoZLeuQ/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 09:53:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IRur0sm6SxKg_kCPoZLeuQ/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json'}, attempt #1 09:53:49 INFO - Downloaded 1199 bytes. 09:53:49 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 09:53:49 INFO - Using the following test package requirements: 09:53:49 INFO - {u'common': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 09:53:49 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 09:53:49 INFO - u'firefox-51.0a2.en-US.mac.cppunittest.tests.zip'], 09:53:49 INFO - u'gtest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 09:53:49 INFO - u'firefox-51.0a2.en-US.mac.gtest.tests.zip'], 09:53:49 INFO - u'jittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 09:53:49 INFO - u'jsshell-mac.zip'], 09:53:49 INFO - u'mochitest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 09:53:49 INFO - u'firefox-51.0a2.en-US.mac.mochitest.tests.zip'], 09:53:49 INFO - u'mozbase': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 09:53:49 INFO - u'reftest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 09:53:49 INFO - u'firefox-51.0a2.en-US.mac.reftest.tests.zip'], 09:53:49 INFO - u'talos': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 09:53:49 INFO - u'firefox-51.0a2.en-US.mac.talos.tests.zip'], 09:53:49 INFO - u'web-platform': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 09:53:49 INFO - u'firefox-51.0a2.en-US.mac.web-platform.tests.zip'], 09:53:49 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 09:53:49 INFO - u'firefox-51.0a2.en-US.mac.xpcshell.tests.zip']} 09:53:49 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip'] for test suite category: common 09:53:49 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IRur0sm6SxKg_kCPoZLeuQ/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 09:53:49 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IRur0sm6SxKg_kCPoZLeuQ/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 09:53:49 INFO - Fetch https://queue.taskcluster.net/v1/task/IRur0sm6SxKg_kCPoZLeuQ/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 09:53:50 INFO - Expected file size: 16421014 09:53:57 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip', u'firefox-51.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 09:53:57 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IRur0sm6SxKg_kCPoZLeuQ/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 09:53:57 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IRur0sm6SxKg_kCPoZLeuQ/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 09:53:57 INFO - Fetch https://queue.taskcluster.net/v1/task/IRur0sm6SxKg_kCPoZLeuQ/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 09:53:57 INFO - Expected file size: 16421014 09:54:04 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IRur0sm6SxKg_kCPoZLeuQ/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip 09:54:04 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IRur0sm6SxKg_kCPoZLeuQ/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip'}, attempt #1 09:54:04 INFO - Fetch https://queue.taskcluster.net/v1/task/IRur0sm6SxKg_kCPoZLeuQ/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip into memory 09:54:05 INFO - Expected file size: 14414081 09:54:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:54:05 INFO - trying https://queue.taskcluster.net/v1/task/IRur0sm6SxKg_kCPoZLeuQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 09:54:05 INFO - Downloading https://queue.taskcluster.net/v1/task/IRur0sm6SxKg_kCPoZLeuQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg 09:54:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IRur0sm6SxKg_kCPoZLeuQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg'}, attempt #1 09:54:08 INFO - Downloaded 115421362 bytes. 09:54:08 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/IRur0sm6SxKg_kCPoZLeuQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 09:54:08 INFO - mkdir: /builds/slave/test/properties 09:54:08 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:54:08 INFO - Writing to file /builds/slave/test/properties/build_url 09:54:08 INFO - Contents: 09:54:08 INFO - build_url:https://queue.taskcluster.net/v1/task/IRur0sm6SxKg_kCPoZLeuQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 09:54:09 INFO - Running post-action listener: _resource_record_post_action 09:54:09 INFO - Running post-action listener: set_extra_try_arguments 09:54:09 INFO - [mozharness: 2016-10-28 16:54:09.427110Z] Finished download-and-extract step (success) 09:54:09 INFO - [mozharness: 2016-10-28 16:54:09.427228Z] Running populate-webroot step. 09:54:09 INFO - Running pre-action listener: _resource_record_pre_action 09:54:09 INFO - Running main action method: populate_webroot 09:54:09 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:54:09 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:54:09 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:54:09 INFO - '--tppagecycles', 09:54:09 INFO - '7'], 09:54:09 INFO - 'tests': ['tsvgm']}}, 09:54:09 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:54:09 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:54:09 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:54:09 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:54:09 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:54:09 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:54:09 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:54:09 INFO - 'talos_options': ['--disable-e10s'], 09:54:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:54:09 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:54:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:54:09 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:54:09 INFO - 'talos_options': ['--disable-e10s'], 09:54:09 INFO - 'tests': ['damp', 'tps']}, 09:54:09 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:54:09 INFO - 'tests': ['damp', 'tps']}, 09:54:09 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:54:09 INFO - 'tests': ['dromaeo_dom']}, 09:54:09 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:54:09 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:54:09 INFO - 'tests': ['basic_compositor_video']}, 09:54:09 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:54:09 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:54:09 INFO - 'tests': ['a11yr', 09:54:09 INFO - 'ts_paint', 09:54:09 INFO - 'tpaint', 09:54:09 INFO - 'sessionrestore', 09:54:09 INFO - 'sessionrestore_no_auto_restore', 09:54:09 INFO - 'tabpaint']}, 09:54:09 INFO - 'other-e10s': {'tests': ['a11yr', 09:54:09 INFO - 'ts_paint', 09:54:09 INFO - 'tpaint', 09:54:09 INFO - 'sessionrestore', 09:54:09 INFO - 'sessionrestore_no_auto_restore', 09:54:09 INFO - 'tabpaint']}, 09:54:09 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:54:09 INFO - 'ts_paint', 09:54:09 INFO - 'tpaint', 09:54:09 INFO - 'sessionrestore', 09:54:09 INFO - 'sessionrestore_no_auto_restore', 09:54:09 INFO - 'tabpaint']}, 09:54:09 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:54:09 INFO - 'ts_paint', 09:54:09 INFO - 'tpaint', 09:54:09 INFO - 'sessionrestore', 09:54:09 INFO - 'sessionrestore_no_auto_restore', 09:54:09 INFO - 'tabpaint']}, 09:54:09 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:54:09 INFO - 'tests': ['a11yr', 09:54:09 INFO - 'ts_paint', 09:54:09 INFO - 'tpaint', 09:54:09 INFO - 'sessionrestore', 09:54:09 INFO - 'sessionrestore_no_auto_restore', 09:54:09 INFO - 'tabpaint']}, 09:54:09 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:54:09 INFO - 'tests': ['a11yr', 09:54:09 INFO - 'ts_paint', 09:54:09 INFO - 'tpaint', 09:54:09 INFO - 'sessionrestore', 09:54:09 INFO - 'sessionrestore_no_auto_restore', 09:54:09 INFO - 'tabpaint']}, 09:54:09 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:54:09 INFO - 'tests': ['tsvgx', 09:54:09 INFO - 'tsvgr_opacity', 09:54:09 INFO - 'tart', 09:54:09 INFO - 'tscrollx', 09:54:09 INFO - 'cart']}, 09:54:09 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:54:09 INFO - 'tsvgr_opacity', 09:54:09 INFO - 'tart', 09:54:09 INFO - 'tscrollx', 09:54:09 INFO - 'cart']}, 09:54:09 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:54:09 INFO - 'talos_options': ['--disable-e10s'], 09:54:09 INFO - 'tests': ['tp5o']}, 09:54:09 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:54:09 INFO - 'tests': ['tp5o']}, 09:54:09 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:54:09 INFO - 'talos_options': ['--disable-e10s', 09:54:09 INFO - '--xperf_path', 09:54:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:54:09 INFO - 'tests': ['tp5n']}, 09:54:09 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:54:09 INFO - 'talos_options': ['--xperf_path', 09:54:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:54:09 INFO - 'tests': ['tp5n']}}, 09:54:09 INFO - 'talos.zip': {'path': '', 09:54:09 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:54:09 INFO - Running post-action listener: _resource_record_post_action 09:54:09 INFO - [mozharness: 2016-10-28 16:54:09.446086Z] Finished populate-webroot step (success) 09:54:09 INFO - [mozharness: 2016-10-28 16:54:09.446213Z] Running create-virtualenv step. 09:54:09 INFO - Running pre-action listener: _resource_record_pre_action 09:54:09 INFO - Running main action method: create_virtualenv 09:54:09 INFO - Creating virtualenv /builds/slave/test/build/venv 09:54:09 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 09:54:09 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:54:09 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:54:09 INFO - Using real prefix '/tools/python27' 09:54:09 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:54:10 INFO - Installing distribute.............................................................................................................................................................................................done. 09:54:13 INFO - Installing pip.................done. 09:54:13 INFO - Return code: 0 09:54:13 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:54:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:54:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:54:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:54:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:54:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:54:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:54:13 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 0x10c517490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c48d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff898558000>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c32bd30>, '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 0x10c191db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c323b20>, '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.7A89hmbq5J/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.j4ipFywaKg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:54:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 09:54:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:54:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7A89hmbq5J/Render', 09:54:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:54:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:54:13 INFO - 'HOME': '/Users/cltbld', 09:54:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:54:13 INFO - 'LOGNAME': 'cltbld', 09:54:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:54:13 INFO - 'MOZ_NO_REMOTE': '1', 09:54:13 INFO - 'NO_EM_RESTART': '1', 09:54:13 INFO - 'PAGER': '/bin/cat', 09:54:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:54:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:54:13 INFO - 'PWD': '/builds/slave/test', 09:54:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:54:13 INFO - 'SHELL': '/bin/bash', 09:54:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.j4ipFywaKg/Listeners', 09:54:13 INFO - 'TMPDIR': '/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/', 09:54:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:54:13 INFO - 'USER': 'cltbld', 09:54:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:54:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:54:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:54:13 INFO - 'XPC_FLAGS': '0x0', 09:54:13 INFO - 'XPC_SERVICE_NAME': '0', 09:54:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:54:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:54:13 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 09:54:13 INFO - Cleaning up... 09:54:13 INFO - Return code: 0 09:54:13 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:54:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:54:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:54:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:54:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:54:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:54:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:54:13 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 0x10c517490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c48d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff898558000>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c32bd30>, '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 0x10c191db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c323b20>, '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.7A89hmbq5J/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.j4ipFywaKg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:54:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 09:54:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 09:54:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7A89hmbq5J/Render', 09:54:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:54:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:54:13 INFO - 'HOME': '/Users/cltbld', 09:54:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:54:13 INFO - 'LOGNAME': 'cltbld', 09:54:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:54:13 INFO - 'MOZ_NO_REMOTE': '1', 09:54:13 INFO - 'NO_EM_RESTART': '1', 09:54:13 INFO - 'PAGER': '/bin/cat', 09:54:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:54:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:54:13 INFO - 'PWD': '/builds/slave/test', 09:54:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:54:13 INFO - 'SHELL': '/bin/bash', 09:54:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.j4ipFywaKg/Listeners', 09:54:13 INFO - 'TMPDIR': '/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/', 09:54:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:54:13 INFO - 'USER': 'cltbld', 09:54:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:54:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:54:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:54:13 INFO - 'XPC_FLAGS': '0x0', 09:54:13 INFO - 'XPC_SERVICE_NAME': '0', 09:54:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:54:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:54:13 INFO - Downloading/unpacking psutil>=3.1.1 09:54:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:54:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:54:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:54:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:54:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:54:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:54:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:54:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:54:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:54:16 INFO - Installing collected packages: psutil 09:54:16 INFO - Running setup.py install for psutil 09:54:16 INFO - building 'psutil._psutil_osx' extension 09:54:16 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 09:54:17 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 09:54:17 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 09:54:17 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 09:54:17 INFO - building 'psutil._psutil_posix' extension 09:54:17 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 09:54:17 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 09:54:17 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 09:54:17 INFO - ^ 09:54:17 INFO - 1 warning generated. 09:54:17 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 09:54:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:54:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:54:17 INFO - Successfully installed psutil 09:54:17 INFO - Cleaning up... 09:54:17 INFO - Return code: 0 09:54:17 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:54:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:54:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:54:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:54:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:54:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:54:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:54:17 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 0x10c517490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c48d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff898558000>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c32bd30>, '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 0x10c191db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c323b20>, '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.7A89hmbq5J/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.j4ipFywaKg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:54:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 09:54:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 09:54:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7A89hmbq5J/Render', 09:54:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:54:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:54:17 INFO - 'HOME': '/Users/cltbld', 09:54:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:54:17 INFO - 'LOGNAME': 'cltbld', 09:54:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:54:17 INFO - 'MOZ_NO_REMOTE': '1', 09:54:17 INFO - 'NO_EM_RESTART': '1', 09:54:17 INFO - 'PAGER': '/bin/cat', 09:54:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:54:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:54:17 INFO - 'PWD': '/builds/slave/test', 09:54:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:54:17 INFO - 'SHELL': '/bin/bash', 09:54:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.j4ipFywaKg/Listeners', 09:54:17 INFO - 'TMPDIR': '/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/', 09:54:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:54:17 INFO - 'USER': 'cltbld', 09:54:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:54:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:54:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:54:17 INFO - 'XPC_FLAGS': '0x0', 09:54:17 INFO - 'XPC_SERVICE_NAME': '0', 09:54:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:54:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:54:18 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:54:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:54:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:54:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:54:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:54:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:54:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:54:20 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:54:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:54:20 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:54:20 INFO - Installing collected packages: mozsystemmonitor 09:54:20 INFO - Running setup.py install for mozsystemmonitor 09:54:20 INFO - Successfully installed mozsystemmonitor 09:54:20 INFO - Cleaning up... 09:54:20 INFO - Return code: 0 09:54:20 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:54:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:54:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:54:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:54:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:54:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:54:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:54:20 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 0x10c517490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c48d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff898558000>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c32bd30>, '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 0x10c191db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c323b20>, '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.7A89hmbq5J/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.j4ipFywaKg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:54:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 09:54:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 09:54:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7A89hmbq5J/Render', 09:54:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:54:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:54:21 INFO - 'HOME': '/Users/cltbld', 09:54:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:54:21 INFO - 'LOGNAME': 'cltbld', 09:54:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:54:21 INFO - 'MOZ_NO_REMOTE': '1', 09:54:21 INFO - 'NO_EM_RESTART': '1', 09:54:21 INFO - 'PAGER': '/bin/cat', 09:54:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:54:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:54:21 INFO - 'PWD': '/builds/slave/test', 09:54:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:54:21 INFO - 'SHELL': '/bin/bash', 09:54:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.j4ipFywaKg/Listeners', 09:54:21 INFO - 'TMPDIR': '/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/', 09:54:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:54:21 INFO - 'USER': 'cltbld', 09:54:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:54:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:54:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:54:21 INFO - 'XPC_FLAGS': '0x0', 09:54:21 INFO - 'XPC_SERVICE_NAME': '0', 09:54:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:54:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:54:21 INFO - Downloading/unpacking jsonschema==2.5.1 09:54:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:54:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:54:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:54:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:54:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:54:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:54:23 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:54:23 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:54:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:54:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:54:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:54:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:54:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:54:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:54:24 INFO - Downloading functools32-3.2.3-2.tar.gz 09:54:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:54:24 INFO - warning: no files found matching '*.txt' 09:54:24 INFO - no previously-included directories found matching 'build' 09:54:24 INFO - no previously-included directories found matching 'dist' 09:54:24 INFO - no previously-included directories found matching '.git*' 09:54:24 INFO - Installing collected packages: jsonschema, functools32 09:54:24 INFO - Running setup.py install for functools32 09:54:24 INFO - warning: no files found matching '*.txt' 09:54:24 INFO - no previously-included directories found matching 'build' 09:54:24 INFO - no previously-included directories found matching 'dist' 09:54:24 INFO - no previously-included directories found matching '.git*' 09:54:24 INFO - Successfully installed jsonschema functools32 09:54:24 INFO - Cleaning up... 09:54:24 INFO - Return code: 0 09:54:24 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:54:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:54:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:54:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:54:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:54:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:54:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:54:24 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 0x10c517490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c48d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff898558000>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c32bd30>, '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 0x10c191db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c323b20>, '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.7A89hmbq5J/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.j4ipFywaKg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:54:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 09:54:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 09:54:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7A89hmbq5J/Render', 09:54:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:54:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:54:24 INFO - 'HOME': '/Users/cltbld', 09:54:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:54:24 INFO - 'LOGNAME': 'cltbld', 09:54:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:54:24 INFO - 'MOZ_NO_REMOTE': '1', 09:54:24 INFO - 'NO_EM_RESTART': '1', 09:54:24 INFO - 'PAGER': '/bin/cat', 09:54:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:54:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:54:24 INFO - 'PWD': '/builds/slave/test', 09:54:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:54:24 INFO - 'SHELL': '/bin/bash', 09:54:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.j4ipFywaKg/Listeners', 09:54:24 INFO - 'TMPDIR': '/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/', 09:54:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:54:24 INFO - 'USER': 'cltbld', 09:54:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:54:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:54:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:54:24 INFO - 'XPC_FLAGS': '0x0', 09:54:24 INFO - 'XPC_SERVICE_NAME': '0', 09:54:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:54:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:54:24 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:54:24 INFO - Cleaning up... 09:54:24 INFO - Return code: 0 09:54:24 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:54:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:54:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:54:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:54:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:54:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:54:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:54:24 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 0x10c517490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c48d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff898558000>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c32bd30>, '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 0x10c191db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c323b20>, '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.7A89hmbq5J/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.j4ipFywaKg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:54:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:54:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:54:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7A89hmbq5J/Render', 09:54:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:54:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:54:24 INFO - 'HOME': '/Users/cltbld', 09:54:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:54:24 INFO - 'LOGNAME': 'cltbld', 09:54:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:54:24 INFO - 'MOZ_NO_REMOTE': '1', 09:54:24 INFO - 'NO_EM_RESTART': '1', 09:54:24 INFO - 'PAGER': '/bin/cat', 09:54:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:54:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:54:24 INFO - 'PWD': '/builds/slave/test', 09:54:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:54:24 INFO - 'SHELL': '/bin/bash', 09:54:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.j4ipFywaKg/Listeners', 09:54:24 INFO - 'TMPDIR': '/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/', 09:54:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:54:24 INFO - 'USER': 'cltbld', 09:54:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:54:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:54:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:54:24 INFO - 'XPC_FLAGS': '0x0', 09:54:24 INFO - 'XPC_SERVICE_NAME': '0', 09:54:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:54:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:54:24 INFO - Downloading/unpacking blobuploader==1.2.4 09:54:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:54:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:54:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:54:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:54:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:54:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:54:27 INFO - Downloading blobuploader-1.2.4.tar.gz 09:54:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:54:27 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:54:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:54:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:54:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:54:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:54:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:54:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:54:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:54:28 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:54:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:54:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:54:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:54:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:54:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:54:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:54:28 INFO - Downloading docopt-0.6.1.tar.gz 09:54:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:54:28 INFO - Installing collected packages: blobuploader, requests, docopt 09:54:28 INFO - Running setup.py install for blobuploader 09:54:28 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:54:28 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:54:28 INFO - Running setup.py install for requests 09:54:29 INFO - Running setup.py install for docopt 09:54:29 INFO - Successfully installed blobuploader requests docopt 09:54:29 INFO - Cleaning up... 09:54:29 INFO - Return code: 0 09:54:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:54: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')]} 09:54:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:54:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:54: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')]} 09:54:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:54:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:54:29 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 0x10c517490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c48d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff898558000>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c32bd30>, '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 0x10c191db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c323b20>, '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.7A89hmbq5J/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.j4ipFywaKg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:54:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:54:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:54:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7A89hmbq5J/Render', 09:54:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:54:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:54:29 INFO - 'HOME': '/Users/cltbld', 09:54:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:54:29 INFO - 'LOGNAME': 'cltbld', 09:54:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:54:29 INFO - 'MOZ_NO_REMOTE': '1', 09:54:29 INFO - 'NO_EM_RESTART': '1', 09:54:29 INFO - 'PAGER': '/bin/cat', 09:54:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:54:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:54:29 INFO - 'PWD': '/builds/slave/test', 09:54:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:54:29 INFO - 'SHELL': '/bin/bash', 09:54:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.j4ipFywaKg/Listeners', 09:54:29 INFO - 'TMPDIR': '/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/', 09:54:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:54:29 INFO - 'USER': 'cltbld', 09:54:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:54:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:54:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:54:29 INFO - 'XPC_FLAGS': '0x0', 09:54:29 INFO - 'XPC_SERVICE_NAME': '0', 09:54:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:54:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:54:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:54:29 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-M8okyd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:54:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:54:30 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-2_yugP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:54:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:54:30 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-7NDGkt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:54:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:54:30 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-2U4jTV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:54:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:54:30 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-a7t1m8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:54:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:54:30 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-PvrOL_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:54:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:54:30 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-JSIeEF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:54:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:54:30 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-JTJjwL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:54:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:54:30 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-Z7hWP5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:54:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:54:30 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-2bzuQb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:54:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:54:30 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-QroWBs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:54:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:54:31 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-WAox1s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:54:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:54:31 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-lx8joW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:54:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:54:31 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-pH2MRS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:54:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:54:31 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-8c0PC5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:54:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:54:31 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-6tkJOb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:54:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:54:31 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-5oyDWC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:54:31 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:54:31 INFO - Running setup.py install for manifestparser 09:54:31 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:54:31 INFO - Running setup.py install for mozcrash 09:54:31 INFO - Running setup.py install for mozdebug 09:54:32 INFO - Running setup.py install for mozdevice 09:54:32 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:54:32 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:54:32 INFO - Running setup.py install for mozfile 09:54:32 INFO - Running setup.py install for mozhttpd 09:54:32 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:54:32 INFO - Running setup.py install for mozinfo 09:54:32 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:54:32 INFO - Running setup.py install for mozInstall 09:54:32 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:54:32 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:54:32 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:54:32 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:54:32 INFO - Running setup.py install for mozleak 09:54:33 INFO - Running setup.py install for mozlog 09:54:33 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:54:33 INFO - Running setup.py install for moznetwork 09:54:33 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:54:33 INFO - Running setup.py install for mozprocess 09:54:33 INFO - Running setup.py install for mozprofile 09:54:33 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:54:33 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:54:33 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:54:33 INFO - Running setup.py install for mozrunner 09:54:33 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:54:33 INFO - Running setup.py install for mozscreenshot 09:54:33 INFO - Running setup.py install for moztest 09:54:34 INFO - Running setup.py install for mozversion 09:54:34 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:54:34 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:54:34 INFO - Cleaning up... 09:54:34 INFO - Return code: 0 09:54:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:54: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')]} 09:54:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:54:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:54: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')]} 09:54:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:54:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:54:34 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 0x10c517490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c48d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff898558000>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c32bd30>, '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 0x10c191db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c323b20>, '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.7A89hmbq5J/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.j4ipFywaKg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:54:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:54:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:54:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7A89hmbq5J/Render', 09:54:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:54:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:54:34 INFO - 'HOME': '/Users/cltbld', 09:54:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:54:34 INFO - 'LOGNAME': 'cltbld', 09:54:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:54:34 INFO - 'MOZ_NO_REMOTE': '1', 09:54:34 INFO - 'NO_EM_RESTART': '1', 09:54:34 INFO - 'PAGER': '/bin/cat', 09:54:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:54:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:54:34 INFO - 'PWD': '/builds/slave/test', 09:54:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:54:34 INFO - 'SHELL': '/bin/bash', 09:54:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.j4ipFywaKg/Listeners', 09:54:34 INFO - 'TMPDIR': '/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/', 09:54:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:54:34 INFO - 'USER': 'cltbld', 09:54:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:54:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:54:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:54:34 INFO - 'XPC_FLAGS': '0x0', 09:54:34 INFO - 'XPC_SERVICE_NAME': '0', 09:54:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:54:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:54:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:54:34 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-AvgRIX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:54:34 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 09:54:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:54:34 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-n58RVI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:54:34 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)) 09:54:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:54:34 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-qGm5Oc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:54:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:54:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:54:34 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-j2rnqE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:54:35 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)) 09:54:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:54:35 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-zZcrui-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:54:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 09:54:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:54:35 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-9VAE9m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:54:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 09:54:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:54:35 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-KH2fdL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:54:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 09:54:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:54:35 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-0yHtT7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:54:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 09:54:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:54:35 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-WLXms_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:54:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 09:54:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:54:35 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-ioiebw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:54:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:54:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:54:35 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-8_BKco-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:54:35 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 09:54:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:54:35 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-5XhN9a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:54:35 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)) 09:54:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:54:35 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-rLzPJA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:54:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 09:54:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:54:35 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-RoACJw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:54:36 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)) 09:54:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:54:36 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-IeN6KH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:54:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 09:54:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:54:36 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-YFBawy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:54:36 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)) 09:54:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:54:36 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-fXliTx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:54:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 09:54:36 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)) 09:54:36 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)) 09:54:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:54:36 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)) 09:54:36 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)) 09:54:36 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:54:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:54:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:54:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:54:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:54:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:54:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:54:38 INFO - Downloading blessings-1.6.tar.gz 09:54:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:54:39 INFO - Installing collected packages: blessings 09:54:39 INFO - Running setup.py install for blessings 09:54:39 INFO - Successfully installed blessings 09:54:39 INFO - Cleaning up... 09:54:39 INFO - Return code: 0 09:54:39 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:54:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:54:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:54:39 INFO - Reading from file tmpfile_stdout 09:54:39 INFO - Current package versions: 09:54:39 INFO - blessings == 1.6 09:54:39 INFO - blobuploader == 1.2.4 09:54:39 INFO - docopt == 0.6.1 09:54:39 INFO - functools32 == 3.2.3-2 09:54:39 INFO - jsonschema == 2.5.1 09:54:39 INFO - manifestparser == 1.1 09:54:39 INFO - mozInstall == 1.12 09:54:39 INFO - mozcrash == 0.17 09:54:39 INFO - mozdebug == 0.1 09:54:39 INFO - mozdevice == 0.48 09:54:39 INFO - mozfile == 1.2 09:54:39 INFO - mozhttpd == 0.7 09:54:39 INFO - mozinfo == 0.9 09:54:39 INFO - mozleak == 0.1 09:54:39 INFO - mozlog == 3.4 09:54:39 INFO - moznetwork == 0.27 09:54:39 INFO - mozprocess == 0.23 09:54:39 INFO - mozprofile == 0.28 09:54:39 INFO - mozrunner == 6.12 09:54:39 INFO - mozscreenshot == 0.1 09:54:39 INFO - mozsystemmonitor == 0.3 09:54:39 INFO - moztest == 0.7 09:54:39 INFO - mozversion == 1.4 09:54:39 INFO - psutil == 3.1.1 09:54:39 INFO - requests == 1.2.3 09:54:39 INFO - wsgiref == 0.1.2 09:54:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:54:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:54:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:54:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:54:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:54:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:54:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:54:39 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 0x10c517490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c48d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff898558000>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c32bd30>, '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 0x10c191db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c323b20>, '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.7A89hmbq5J/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.j4ipFywaKg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:54:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 09:54:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:54:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7A89hmbq5J/Render', 09:54:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:54:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:54:39 INFO - 'HOME': '/Users/cltbld', 09:54:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:54:39 INFO - 'LOGNAME': 'cltbld', 09:54:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:54:39 INFO - 'MOZ_NO_REMOTE': '1', 09:54:39 INFO - 'NO_EM_RESTART': '1', 09:54:39 INFO - 'PAGER': '/bin/cat', 09:54:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:54:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:54:39 INFO - 'PWD': '/builds/slave/test', 09:54:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:54:39 INFO - 'SHELL': '/bin/bash', 09:54:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.j4ipFywaKg/Listeners', 09:54:39 INFO - 'TMPDIR': '/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/', 09:54:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:54:39 INFO - 'USER': 'cltbld', 09:54:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:54:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:54:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:54:39 INFO - 'XPC_FLAGS': '0x0', 09:54:39 INFO - 'XPC_SERVICE_NAME': '0', 09:54:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:54:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:54:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:54:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 09:54:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 09:54:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:54:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 09:54:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 09:54:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 09:54:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 09:54:39 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 09:54:39 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:54:39 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:54:39 INFO - Cleaning up... 09:54:39 INFO - Return code: 0 09:54:39 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:54:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:54:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:54:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:54:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:54:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:54:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:54:39 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 0x10c517490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c48d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff898558000>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c32bd30>, '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 0x10c191db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c323b20>, '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.7A89hmbq5J/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.j4ipFywaKg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:54:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 09:54:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:54:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7A89hmbq5J/Render', 09:54:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:54:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:54:39 INFO - 'HOME': '/Users/cltbld', 09:54:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:54:39 INFO - 'LOGNAME': 'cltbld', 09:54:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:54:39 INFO - 'MOZ_NO_REMOTE': '1', 09:54:39 INFO - 'NO_EM_RESTART': '1', 09:54:39 INFO - 'PAGER': '/bin/cat', 09:54:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:54:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:54:39 INFO - 'PWD': '/builds/slave/test', 09:54:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:54:39 INFO - 'SHELL': '/bin/bash', 09:54:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.j4ipFywaKg/Listeners', 09:54:39 INFO - 'TMPDIR': '/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/', 09:54:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:54:39 INFO - 'USER': 'cltbld', 09:54:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:54:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:54:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:54:39 INFO - 'XPC_FLAGS': '0x0', 09:54:39 INFO - 'XPC_SERVICE_NAME': '0', 09:54:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:54:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:54:40 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:54:40 INFO - Cleaning up... 09:54:40 INFO - Return code: 0 09:54:40 INFO - Running post-action listener: _resource_record_post_action 09:54:40 INFO - Running post-action listener: _start_resource_monitoring 09:54:40 INFO - Starting resource monitoring. 09:54:40 INFO - [mozharness: 2016-10-28 16:54:40.164973Z] Finished create-virtualenv step (success) 09:54:40 INFO - [mozharness: 2016-10-28 16:54:40.165899Z] Running install step. 09:54:40 INFO - Running pre-action listener: _resource_record_pre_action 09:54:40 INFO - Running main action method: install 09:54:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:54:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:54:40 INFO - Reading from file tmpfile_stdout 09:54:40 INFO - Detecting whether we're running mozinstall >=1.0... 09:54:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:54:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:54:40 INFO - Reading from file tmpfile_stdout 09:54:40 INFO - Output received: 09:54:40 INFO - Usage: mozinstall [options] installer 09:54:40 INFO - Options: 09:54:40 INFO - -h, --help show this help message and exit 09:54:40 INFO - -d DEST, --destination=DEST 09:54:40 INFO - Directory to install application into. [default: 09:54:40 INFO - "/builds/slave/test"] 09:54:40 INFO - --app=APP Application being installed. [default: firefox] 09:54:40 INFO - mkdir: /builds/slave/test/build/application 09:54:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 09:54:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 09:55:13 INFO - Reading from file tmpfile_stdout 09:55:13 INFO - Output received: 09:55:13 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 09:55:13 INFO - Running post-action listener: _resource_record_post_action 09:55:13 INFO - [mozharness: 2016-10-28 16:55:13.117053Z] Finished install step (success) 09:55:13 INFO - [mozharness: 2016-10-28 16:55:13.117187Z] Running run-tests step. 09:55:13 INFO - Running pre-action listener: _resource_record_pre_action 09:55:13 INFO - Running main action method: run_tests 09:55:13 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:55:13 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:55:13 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:55:13 INFO - 2016-10-28 09:55:13.131 screenresolution[1637:7665] starting screenresolution argv=screenresolution get 09:55:13 INFO - 2016-10-28 09:55:13.134 screenresolution[1637:7665] Display 0: 1600x1200x32@60 09:55:13 INFO - 2016-10-28 09:55:13.139 screenresolution[1638:7667] starting screenresolution argv=screenresolution list 09:55:13 INFO - Available Modes on Display 0 09:55:13 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:55:13 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:55:13 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:55:13 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:55:13 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:55:13 INFO - Intel Iris: 09:55:13 INFO - Chipset Model: Intel Iris 09:55:13 INFO - Type: GPU 09:55:13 INFO - Bus: Built-In 09:55:13 INFO - VRAM (Dynamic, Max): 1536 MB 09:55:13 INFO - Vendor: Intel (0x8086) 09:55:13 INFO - Device ID: 0x0a2e 09:55:13 INFO - Revision ID: 0x0009 09:55:13 INFO - Displays: 09:55:13 INFO - Display: 09:55:13 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:55:13 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:55:13 INFO - Display Serial Number: 1600x1200 60 09:55:13 INFO - Main Display: Yes 09:55:13 INFO - Mirror: Off 09:55:13 INFO - Online: Yes 09:55:13 INFO - Rotation: Supported 09:55:13 INFO - Return code: 0 09:55:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:55:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:55:13 INFO - Python 2.7.3 09:55:13 INFO - Return code: 0 09:55:13 INFO - grabbing minidump binary from tooltool 09:55:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:55:13 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 0x10c32bd30>, '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 0x10c191db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c323b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:55:13 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 09:55:13 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 09:55:13 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 09:55:13 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:55:13 INFO - Return code: 0 09:55:13 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 09:55:13 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:55:13 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:55:13 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 09:55:13 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:55:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IRur0sm6SxKg_kCPoZLeuQ/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0149', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 09:55:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/IRur0sm6SxKg_kCPoZLeuQ/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0149 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 09:55:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7A89hmbq5J/Render', 09:55:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:55:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:55:13 INFO - 'HOME': '/Users/cltbld', 09:55:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:55:13 INFO - 'LOGNAME': 'cltbld', 09:55:13 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:55:13 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 09:55:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:55:13 INFO - 'MOZ_NO_REMOTE': '1', 09:55:13 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:55:13 INFO - 'NO_EM_RESTART': '1', 09:55:13 INFO - 'PAGER': '/bin/cat', 09:55:13 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:55:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:55:13 INFO - 'PWD': '/builds/slave/test', 09:55:13 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:55:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:55:13 INFO - 'SHELL': '/bin/bash', 09:55:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.j4ipFywaKg/Listeners', 09:55:13 INFO - 'TMPDIR': '/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/', 09:55:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:55:13 INFO - 'USER': 'cltbld', 09:55:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:55:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:55:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:55:13 INFO - 'XPC_FLAGS': '0x0', 09:55:13 INFO - 'XPC_SERVICE_NAME': '0', 09:55:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:55:13 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IRur0sm6SxKg_kCPoZLeuQ/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0149', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 09:55:13 INFO - mozversion application_buildid: 20161028072858 09:55:13 INFO - mozversion application_changeset: 70025dbda133b182ebdb88e7f2baa62d914648ce 09:55:13 INFO - mozversion application_display_name: FirefoxDeveloperEdition 09:55:13 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:55:13 INFO - mozversion application_name: Firefox 09:55:13 INFO - mozversion application_remotingname: firefox-dev 09:55:13 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:55:13 INFO - mozversion application_vendor: Mozilla 09:55:13 INFO - mozversion application_version: 51.0a2 09:55:13 INFO - mozversion platform_buildid: 20161028072858 09:55:13 INFO - mozversion platform_changeset: 70025dbda133b182ebdb88e7f2baa62d914648ce 09:55:13 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:55:13 INFO - mozversion platform_version: 51.0a2 09:55:13 INFO - using testdate: 1477673713 09:55:13 INFO - actual date: 1477673713 09:55:13 INFO - starting webserver on 'localhost:49272' 09:55:13 INFO - SUITE-START | Running 2 tests 09:55:13 INFO - TEST-START | dromaeo_css 09:55:13 INFO - operating with platform_type : mac_ 09:55:13 INFO - Initialising browser for dromaeo_css test... 09:55:13 INFO - TEST-INFO | started process 1648 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/tmpz10b6x/profile http://localhost:49272/getInfo.html) 09:55:16 INFO - PROCESS | 1648 | __metrics Screen width/height:1600/1200 09:55:16 INFO - PROCESS | 1648 | colorDepth:24 09:55:16 INFO - PROCESS | 1648 | Browser inner width/height: 1024/689 09:55:16 INFO - PROCESS | 1648 | __metrics 09:55:16 INFO - PROCESS | 1648 | 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" 09:55:16 INFO - PROCESS | 1648 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:55:17 INFO - TEST-INFO | 1648: exit 0 09:55:17 INFO - Browser initialized. 09:55:17 INFO - Running cycle 1/1 for dromaeo_css test... 09:55:17 INFO - TEST-INFO | started process 1650 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/tmpz10b6x/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:55:29 INFO - PROCESS | 1650 | RSS: Main: 219881472 09:55:29 INFO - PROCESS | 1650 | 09:56:21 INFO - PROCESS | 1650 | 1477673781084 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] 09:58:33 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49272/tests/dromaeo/cssquery-ext.html) 09:58:34 INFO - PROCESS | 1650 | RSS: Main: 334008320 09:58:34 INFO - PROCESS | 1650 | 10:01:37 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-ext.html (next: http://localhost:49272/tests/dromaeo/cssquery-jquery.html) 10:01:38 INFO - PROCESS | 1650 | RSS: Main: 352407552 10:01:38 INFO - PROCESS | 1650 | 10:04:40 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49272/tests/dromaeo/cssquery-mootools.html) 10:04:41 INFO - PROCESS | 1650 | RSS: Main: 314204160 10:04:41 INFO - PROCESS | 1650 | 10:07:43 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49272/tests/dromaeo/cssquery-prototype.html) 10:07:44 INFO - PROCESS | 1650 | RSS: Main: 318836736 10:07:44 INFO - PROCESS | 1650 | 10:10:47 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49272/tests/dromaeo/cssquery-yui.html) 10:10:48 INFO - PROCESS | 1650 | RSS: Main: 310054912 10:10:48 INFO - PROCESS | 1650 | 10:13:51 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-yui.html (next: http://localhost:49272/tests/dromaeo/cssquery-dojo.html) 10:13:51 INFO - PROCESS | 1650 | RSS: Main: 488206336 10:13:51 INFO - PROCESS | 1650 | 10:13:51 INFO - PROCESS | 1650 | __start_tp_report 10:13:51 INFO - PROCESS | 1650 | _x_x_mozilla_page_load 10:13:51 INFO - PROCESS | 1650 | _x_x_mozilla_page_load_details 10:13:51 INFO - PROCESS | 1650 | |i|pagename|runs| 10:13:51 INFO - PROCESS | 1650 | |0;dojo.html;3325.5177999190114;3341.431956567383;3364.3607714534237;3375.6455572164905;3401.608814986277;5393.730313484325;5798.681072541009;5807.157962095504;5821.301443826746;5834.2998840139135;5712.285964254468;5786.768529258825;5789.160571717099;5807.854803629912;5828.562857785672;5233.9738301308535;5282.630215884889;5307.840764777063;5321.73391330432;5355.866103347428;5222.4255331913455;5235.450277720842;5249.343832020997;5332.720147164672;5400.081986062359;5313.654612450178;5331.067063263933;5338.946610533903;5345.358556973169;5345.652532585389;5317.654352467097;5344.412114667383;5345.973270133624;5359.973200133974;5362.981033603623;4490.899729566245;5211.296474975868;5221.634485586011;5279;5280.841574752763;5708.115242137475;5765.509931655814;5811.476967072984;5863.912041319341;5901.350851406385;6309.3690630937;6309.716062777186;6318.526110541728;6325.5255855811;6347.96826015867;6160.5687601867885;6241.921692616683;6250.156228909084;6266.749330026793;6340.682965851689;5744.798932037359;5767.596268261265;5809.099589563624;5841.50347220491;5850.210221620112;6275.748970041239;6330.493560515148;6339.334369891095;6340.207474065742;6346.555741098079;6023.69881505923;6127.877442451126;6204.565680402418;6250.124982502453;6265.028920517327;6225.564210505312;6262.2172228471445;6263.906041409383;6341.334159913143;6353.96823015882;6301.96849015752;6314.336994615591;6319.778807741707;6323.20959880015;6324.430801227912;6104.938950610437;6247.500199983991;6327.209098862642;6340.682965851781;6342.8414289642205;4913.557779799835;4962.15643340633;4971.602271818246;4974.676646017997;4975.975120124376;4417.204903117406;4453.888652783707;4470.754108524063;4472;4518.299663552155;5796.88406231873;5862.70686465675;5889.204957330791;5903.173555702205;5914.704264786744;6203.193584834033;6283.277423096311;6315.842103947346;6316.873662526816;6341.3341599132345;5704.971475142598;5737.483626473638;5824.767009319579;5832.825015249549;5894.292684877756;5437.374701909252;5438.755256013489;5450.073487507133;5456.181572764038;5462.9726851365485;6169.81490555284;6365.809025729235;6367.108604795239;6376.744930202833;6379.521535884827;6255.56211065221;6255.9374406257175;6307.211598550181;6320.273168585672;6328.9050664240995;6333.366663333814;6374.617522948638;6378.968105159444;6381.138546296191;6396;6275.717592708431;6286.025666021774;6324.335944725737;6328.557001009885;6329.050642403677;5759.790444006638;6103.974138059581;6126.059675755388;6237.7193026314835;6257.499400047895;5405.189221616789;6190.597611155261;6255;6266;6268.27914789805;6201.844953876189;6230.657313847782;6238.937610624017;6247.031710084944;6274.341194174728;5879.088741245114;5970.880582388241;5974.940250597612;6023.524236562071;6042.697865106639;6222.439980401605;6231.345708700521;6233.812985610439;6241.251049874044;6252.906206406817;6091.02543593023;6101.969490152521;6105.641708308169;6105.786297479567;6110.847228819137 10:13:51 INFO - PROCESS | 1650 | |1;ext.html;455.599072815922;513.7302915969117;534.9598780091494;535.0663092902882;544.8147629805865;26768.732312676868;29944.25139371514;31142.844285778567;32408.027759167235;32409;32808.85169019085;33619.831900840465;41183.38224926629;42290.57709422913;42416.78791606038;9662.227021838253;9812.165965892907;9818.067283608047;9829.65596204133;9833.557489912972;9704.175145112638;9783.0706082922;9797.167240784542;9799.461029643368;9802;7464.402847772192;7801.687932482694;9784.90215097847;11815.291082535032;12087.335196564185;11888.58389956356;11892.643220703392;12201;12292.508299668047;12322.260664360077;12064.034877209802;12121.272723636523;12130.514779408813;12151.392430378446;12151.878481215252;31288.687113128806;31705.52441713376;31754.841225793953;32912.506312405334;38811.41782873259;3141.905742827696;3246.4156451838658;3404.3021180657906;3611.801350925698;3886.1839013807135;29307.168642094395;29957;31422.900198492942;31866.681333186603;32203.51694724581;3019.5017822059335;3233.676632336771;3240.740740740735;3242.7405807535342;3253.869845206189;513890;518139.40930295864;519260.9999999962;522735;523234;61911;62301;62406.687966559875;62457.68771156115;62493.68753156296;54873.45126548763;55826.72086639541;55902.720486398124;58493;58633.4136658628;13576.59270221895;14983.400663973536;15383.923080384526;15610.12678478567;16216.594585135466;12027.158098933165;12038.39808009596;12126.969207617274;12231.938840305742;12290.262584244974;15917.52247432579;18756.343527976456;18781.96699181531;18807.623847522973;18918.621627567372;6743.819831529463;6921.446284297244;7016.92983070173;8138.348932085419;8204.876926846102;828.4035494443991;888.1784349476708;893.6961433112773;943.5376665433888;957.7988622389377;28666.14001579956;29800;29950.850245748632;30613.540796888065;30662.233444164074;921.8156368726281;1016.9542370593341;1024.5594394410325;1057.8836328003913;1064.2443864855884;14722.11667299944;15340.846591534166;15478.767818482731;15740;15839.52481425559;721220.3938980376;728578;729639;730314;732761;49112;50079;56755.43244567502;57001;57552.71223643855;1353.2286596640017;1381.0884816021578;1384.3977869626744;1385.736710025092;1391.7773156294945;29291.68187431528;30530.694693052785;30623.54064688987;30753.15585551806;31507;48406.757966209945;48956;49066.26400604065;49166.77083072952;49224.50775492199;620094;622057;624139;624151;626398;25926.481470370865;26319.07883224078;26353.341166470993;26405;26471.073512426974;46343.76828115838;46820.531794681614;47196;47491.52508474871;47771.28343074787;37740.81129594444;38932.221355573296;38980.6101938977;39265.80367098146;39680.80159599299;31813;37175.25649487049;37524.061898452754;38501.844944651704;39350.40974385329;32111.518327225578;37076.629233708394;38258.61741382662;38490.80754596209;38500.80749596234;31515.151515151698;34458.65541344655;34598.481022785185;35423.11442213965;36202.8189859049;22826.543469130193;25020.37449063715;25742.297058809305;25996.22011339663;26342.473150537266 10:13:51 INFO - PROCESS | 1650 | |2;jquery.html;303.55983823455966;331.5391605668121;377.36790875283873;379.1771855074487;399.96600288975435;14960.401583936644;15414.69170616587;16273.349066037374;20602.69095963558;21114.155433782667;19543.315983940563;19876.90061549694;20503.589928201425;20644;20805.16779328825;5800.53595712343;6098.4511393974535;6112.358202388752;6114.663693496856;6116.938830611703;4163.188178305217;4283.721558098714;5966.2840459144745;6034.818955431344;6036;4275.166342563201;4357.978210108961;6354.237491501026;6675.132232809752;6693.799186024427;6428.871422571569;6576.342365763433;6690.197176338822;6743.258241593421;6766.052752614638;5793.246877905887;5793.942060579425;5798.536117110621;5801.3328467225965;5834.241548598655;24298.514029719485;25009.499810003697;25087.372815679755;25239.621405678747;25333.74666253332;2398.6761787158857;2493.551160791057;2682.8390296582265;2830.674472435676;2838.304615369227;14906.925465372713;15154.469593564283;15319.770203446846;15722.292496837556;15768.605784855356;1709.6922553940285;1798.4065258464675;1842.677531431994;1852.657258407199;1867.7105048717472;114992.42503787512;118935;122145;124108.37945810214;124303.75696243012;9027.77430564228;10350.120239779553;10428.739281517872;10505;10890.985167743993;13545;13554.796678049837;13566.186028838301;13566.186028838301;13567.59297221085;7895.921040789519;8153.776933460029;8185.099639039701;8251.174882511701;8295.129011453831;8118.066422361386;8135.1051384347675;8174.3051840593025;8290.046644635944;8297.917020829835;5435.456454354612;6493.155889734304;6523.967380163163;6539.836504087436;6552.541322107407;1642.5072478256475;1771.8582513398896;1800.36087189046;1802.0539216911227;1803.819618038212;670.3698523388;919.8206349761866;939.3987847777428;977.6138425321958;1019.4494972714651;21288.893555532122;21678.674819877713;21725;21743;21753.891230543744;917.9173874351341;936.1901954809177;959.8769439755503;964.8118616869783;967.3712087143413;10968.890311096788;11315.490802913888;11506.424678766029;11519.078473722082;11525.711857203636;596112;598813;609054;611258;613810;119583;120019;120223;125350;129338;971.4851128901694;982.464556816551;999.6751055906859;1000.8498725191134;1001.2740762946951;16767;17691.469255922344;19320.903395483496;19331;19378.515537111685;51474.485255148466;51578.74210628923;53360.73319633377;55062.449375507334;56480.43519564916;59431;75342;75409.86885196617;78625;78891;7770.961145194238;7796.922030779847;7823.569703666125;7824.530528168328;7970.043594768665;12093.697657558632;12180;12183;12345.321007344683;12404.19372740769;8361.331093512383;8426.536540490331;10986.780264394507;11003.559857605926;11155;9433.245340372616;10854.945725271324;11155.27490713101;11288.153388495732;11506.482208300478;9751.853722194031;11078.446077696244;11161.497732602214;11186.552537898393;11242.718932026764;7675.884861727191;7839.725609603636;7953.880691789512;7992.8001799953145;8043.632582461113;9131.634734610541;10504.737381565215;10859.51132199037;10861;11027.83458248143 10:13:51 INFO - PROCESS | 1650 | |3;mootools.html;1441.4378392426956;1493.313075985047;1621.878359123066;1677.2955358749325;1884.3122260374967;8684.73945781626;9275.211607013403;9278.396904201221;9279.582418791153;9285.628574857006;7980.760577182679;8236.83526329473;8253.79365515861;8719.17167869053;8890.555472226395;2359.09174967637;2385.296337580418;2385.3917251101034;2388.5103553771523;2393.7247216570145;2369.2892132360307;2379.7263314718857;2413.4087148648605;2414.8671823049726;2418.1899063813557;2122.628540005501;2198.373463562885;2322.2104484475276;2394.1022116706235;2402.1112188490283;2368.86971216583;2370.7747763962398;2403.2069417092316;2403.435192729707;2407.9157229496973;2380.2264264114233;2381.0832829360647;2386.832921695482;2387.1048356866177;2391.5456063348083;7946.523208607444;9020.14308640678;9053.909460905372;9154.588043538057;9162.175404213585;5164.2770012198325;5420.159875219348;5433.755481003364;5436.537894278951;5437.700926449043;3499.3526197653514;3567.839447224881;3688.354537955847;3713.832877520518;3746.1196618794834;935.911492076146;1053.761829849931;1074.0816601805423;1098.1873413673825;1098.2367254757946;12025.63923082309;12166.026717862638;12174.756504869942;12181.817272740916;12182.573609923698;4588.26587745959;4630.907381852344;4824.155772739757;4845.9757701211265;4846.103470857832;10268.486575671186;10270.743231419274;10280.742981425525;10283.023112804272;10287.588496460057;5316.043112239757;5325.254464374991;5332.226827110047;5332.466753324637;5346.251524786455;4710.952890471051;4799.568038876448;4847.442544107403;4848;4858.198397264482;3965.464662270614;3972.503437070366;4004.2391945530258;4093.0176757577965;4107.753534787922;1111.433169083773;1196.318098683742;1290.2581015915887;1301.1802564384377;1322.6825561865082;738.1216352540459;842.9578521074044;886.7916039730658;892.0410558649348;936.8828896387952;5869.853253668693;6023.578349515492;6094.238220222473;6095.817125486243;6383.808485745435;943.2689665509286;943.3113826906397;961.1493827962304;1041.7238882369188;1049.375621505203;3829.349010668193;3913.5108111486065;3921.8235179416993;3949.782761948063;4034;10917.39954302505;10976;11011.174161937886;11226;11246.775064498828;11185.552577896955;11197.776044479066;11198.944005280084;11203.21577489568;11204.943975280234;6746.628935408599;8275.62759675816;8307.667693292322;8353.457025293337;8372.958135209285;5919.6744179070565;5985.6408615483215;5985.880282394415;6058.303295121117;6090.482309003784;10146.086852183043;10481.004304591052;10496.580136794748;10512.842307365549;10518.263721539419;10102.191824654157;10391.896081039093;10442.216833737348;10594.947025265134;10654.360738355723;7671.462997590115;7856.5678887661725;7865.174156713462;7866.449348545776;7885.250901164381;7991.24083212094;8088.83822323562;8119.675212991414;8217.95891020565;8249.876251856107;6265.373462653698;7605.923940760743;7673.424493162924;7687.308142267223;7714;7452.701891924479;7528.397728181842;7553.055868016498;7571.318581327707;7639.847203056019;6824.181098268041;6913.861722765416;6921.2386637468835;7003.124609423822;7004.264552221944;4978.82997495581;4987.675801072919;4999.400071991385;5044.722540260321;5052.69683818972;4965.4289756677;5012.548870601518;5015.899682006412;5114.130597798308;5134.820281290137 10:13:51 INFO - PROCESS | 1650 | |4;prototype.html;295.7633892885691;297.8049377657634;304.9740772034376;311.26541362384785;312.2178941750914;5280.498352656491;5473.9345966258925;5524.558035357172;5530.281063461749;5571.434282059475;4983.202687569989;5114.386273647158;5404.757025834284;5420.376656684482;5442.619016668835;3645.198056427582;4147.502299724038;4183.288840897055;4195.433616461784;4204.5375008749015;3108.347247078116;3908.7850168240734;4117.17656468706;4213.494380674323;4224.45082139323;4091.6112969267874;4094.160697057096;4100.938485922698;4103.194594378464;4143.19207754488;4067.877963661095;4085.6935729820084;4100.118474527976;4101.815418306153;4122.773247471388;3410.2326976430354;3554.893353199408;3562.590302115238;3575.624559421249;3586.910327241814;5258.99001027989;5267.446918073585;5284.973575132138;5291.603129765283;5321.73391330432;3787.299349620329;4256.382824490463;4639.837605683819;4660.6970546914345;4671.48613652498;4701.9185587315105;5178.792848286102;5701.230333904911;5701.77192912283;5702.401247868997;3405.506201600754;3449.534312867781;3830.3871380578976;3887.7667339959694;3895.5714871364125;4965.751712414365;5547.44525547442;6022.759089636409;6023.006203976295;6023.771204654262;3611.259691763182;3917.7071566383024;3962.841486340572;3978.303796835542;3986.3422535281934;3811.4092315691114;3985.362342025262;4002.897754240487;4008.378701301303;4036.2936486114813;4339.240632889295;4615.776564443564;4630.814767409333;4640.65195110368;4655.976720116378;4737.9052418952115;5669.574781891375;5736.827895163152;5754.367019627837;5832.300123985149;1217.7518044004967;1252.2298786246392;1299.5516546791341;1307.5878051704137;1312.225786785801;720.8450183210634;743.8921356403291;744.3858816476428;758.9734359297398;793.8531371696255;3941.507311586052;4165.708400412002;4287.785610719451;4531.546845315508;4556.134334476439;3986.60133986599;4142.937855932163;4155.293600087993;4660.04469083837;4905.656604037683;3799.905002374963;4081.673466122703;4313.398312409174;4502.3246513023305;4519.661025423106;2234.72065991751;2263.1286954522297;2356.244597774669;2547.4268289634683;2548.566743653583;4922.833953060642;4953.6532442729385;4960.379952505937;4979.307035607911;4993.550580447704;4039.979800100981;4459.327752092965;4900.387451568554;4924.581410580069;5018.411835537609;4846.539578740014;4992.578599379371;5024.899502009939;5038.596912247085;5042.39491261051;4804.639652026042;4808.326834243278;4813;4813.614910807197;4829.7585120744525;4739.691920025188;5490.80367852862;5950.452882250733;5953.434423729739;5984.95263328907;6198.876022479435;6214;6229.470495007975;6230.657313847782;6320.873582528416;3894.1432884765304;3910.0811309342853;3960.861369852041;3989.2819292527624;3999.5400528939545;4649.211312348287;4771.021940502119;5918.171455996078;5948.524118070631;5994.28068631767;5841.591088623755;5855.385184555731;5858.150568167677;5877.353491115889;5907.438793314628;5262.6316157870115;5456.727163641882;5753.453421924911;5791.8552036199435;5820.476157145878;4585.587297143273;5518.971151059829;5558.972205138948;5633.943660563506;5670.376258611467;5263.736813159403;5339.679619222859;5822.311529656352;5824.3593204748295;5833.912491312549;4995.775190116381;5275.920861187162;5334.919976200283;5488.1493368527945;5727.427257274239 10:13:51 INFO - PROCESS | 1650 | |5;yui.html;677.3260605697332;692.2350802363388;696.5472442912106;729.4492658043176;795.4551132474252;13527.256000919946;14685.118892866421;15906.28421721021;15962.840371596281;16088.276027578759;14311.785323220134;14498.492552760656;14502.347394367252;14508.5647430577;14518.709625807478;649.3993056422802;663.5255792108642;668.4318329420003;814.6822739131743;817.5462618246901;810.278851821879;814.3485211830541;814.861473549498;815.604431850552;815.6778072661295;867.280157469299;868.5309932636369;868.9956550217272;869.1048220333067;869.9913000869974;689.9586024838526;707.2997732245092;709.4820780830023;711.7010855440676;862.4738909265343;525.7134861500454;624.7782037376757;638.9648569328685;644.3138057968296;645.5997281685338;14828.332725027292;14868.479603213944;14896.70206595862;15215.847841521665;15253.23733813316;13913.58259252224;14089;14175.574732758034;14195.716085678228;14391.13653180802;12623.431945562472;12724.1729287596;13026.609201723963;13152.605421837361;13548.051636385457;4539.387182730356;4622.6301895848255;4633;4642.489326174118;4717.410323709536;112138;112499.43750281278;115596;115871.68256634905;117546;10724.463776811128;10852.620158294421;10938.945305273422;11002.834957475485;11326.886731132583;22420.775792241868;22788;22872.08511659515;22873.771262287166;22917.54164916726;7611.238876112345;7644.426667999922;7648.847023059508;8006.519608823489;8009.959950200212;4310.590493903137;4310.849120280775;4372.628326592276;4502.482214545304;4518.887027824265;3392.6268110508317;3517.472379143149;3517.8416971236356;3518.138056176253;3525.7708248963736;649.5355820588208;670.4301343857682;677.9118714567074;688.8002479280952;697.9755708550176;491.9434265059564;521.9034478621467;527.493606138104;607.875385545962;627.7865525721277;8325.583720814057;9353.672621458216;9643.517824108767;9871.25965552572;9925.404475731479;555.872149405639;595.8540157661314;601.2994860986902;607.8449995251183;620.6400287833136;4563.794629241692;4798.2802579612635;4800.35195248644;4804.135255654016;4821.951780482221;100669.49665251627;102353.48823255836;163596;172672;178110;141370.2931485336;142284;143971;145053.19677836375;151766;88493.11506884849;106694;107681;114562.99999999833;126281;9111.31665125105;10022.34854734469;10193.694189174337;10206.336588121749;10210;64697.67651161714;65296.7351632426;66012.3496912581;67721.66139169273;69384.65307673429;96488;99628.50185749025;101505;102549.48725256325;104220;12479;12796.61610151697;12833.230006199285;13360.331983400985;13632.93183534076;14232.715345693236;14472.782908256175;14711.516511002661;15050;15373.38506459729;11606.535738570701;13548.119372240773;13566.118202316818;13745.587632371045;13959.302034898417;13005.739885202433;13149.934250328688;13737.587872363845;13967.720645587235;14103.576892693236;12858.871411286142;13377.398017089059;13382.732345353234;13643.795343069663;14331.355089021228;9806.492787730485;10913.781724365626;11003.449827508432;11167.274127181707;11692.590759323382;11444.828327574927;11520.827187592025;11663.941680291544;11776;11828.34944078084 10:13:51 INFO - PROCESS | 1650 | __end_tp_report 10:13:51 INFO - PROCESS | 1650 | __start_cc_report 10:13:51 INFO - PROCESS | 1650 | _x_x_mozilla_cycle_collect,1168 10:13:51 INFO - PROCESS | 1650 | __end_cc_report 10:13:51 INFO - PROCESS | 1650 | __startTimestamp1477674831692__endTimestamp 10:13:51 INFO - PROCESS | 1650 | 10:13:51 INFO - PROCESS | 1650 | ------- Summary: start ------- 10:13:51 INFO - PROCESS | 1650 | Number of tests: 6 10:13:51 INFO - PROCESS | 1650 | 10:13:51 INFO - PROCESS | 1650 | [#0] dojo.html Cycles:165 Average:5808.70 Median:6042.70 stddev:652.59 (10.8%) stddev-sans-first:624.84 10:13:51 INFO - PROCESS | 1650 | Values: 3325.5 3341.4 3364.4 3375.6 3401.6 5393.7 5798.7 5807.2 5821.3 5834.3 5712.3 5786.8 5789.2 5807.9 5828.6 5234.0 5282.6 5307.8 5321.7 5355.9 5222.4 5235.5 5249.3 5332.7 5400.1 5313.7 5331.1 5338.9 5345.4 5345.7 5317.7 5344.4 5346.0 5360.0 5363.0 4490.9 5211.3 5221.6 5279.0 5280.8 5708.1 5765.5 5811.5 5863.9 5901.4 6309.4 6309.7 6318.5 6325.5 6348.0 6160.6 6241.9 6250.2 6266.7 6340.7 5744.8 5767.6 5809.1 5841.5 5850.2 6275.7 6330.5 6339.3 6340.2 6346.6 6023.7 6127.9 6204.6 6250.1 6265.0 6225.6 6262.2 6263.9 6341.3 6354.0 6302.0 6314.3 6319.8 6323.2 6324.4 6104.9 6247.5 6327.2 6340.7 6342.8 4913.6 4962.2 4971.6 4974.7 4976.0 4417.2 4453.9 4470.8 4472.0 4518.3 5796.9 5862.7 5889.2 5903.2 5914.7 6203.2 6283.3 6315.8 6316.9 6341.3 5705.0 5737.5 5824.8 5832.8 5894.3 5437.4 5438.8 5450.1 5456.2 5463.0 6169.8 6365.8 6367.1 6376.7 6379.5 6255.6 6255.9 6307.2 6320.3 6328.9 6333.4 6374.6 6379.0 6381.1 6396.0 6275.7 6286.0 6324.3 6328.6 6329.1 5759.8 6104.0 6126.1 6237.7 6257.5 5405.2 6190.6 6255.0 6266.0 6268.3 6201.8 6230.7 6238.9 6247.0 6274.3 5879.1 5970.9 5974.9 6023.5 6042.7 6222.4 6231.3 6233.8 6241.3 6252.9 6091.0 6102.0 6105.6 6105.8 6110.8 10:13:51 INFO - PROCESS | 1650 | 10:13:51 INFO - PROCESS | 1650 | [#1] ext.html Cycles:180 Average:74037.02 Median:19517.46 stddev:168895.32 (865.4%) stddev-sans-first:169278.76 10:13:51 INFO - PROCESS | 1650 | Values: 455.6 513.7 535.0 535.1 544.8 26768.7 29944.3 31142.8 32408.0 32409.0 32808.9 33619.8 41183.4 42290.6 42416.8 9662.2 9812.2 9818.1 9829.7 9833.6 9704.2 9783.1 9797.2 9799.5 9802.0 7464.4 7801.7 9784.9 11815.3 12087.3 11888.6 11892.6 12201.0 12292.5 12322.3 12064.0 12121.3 12130.5 12151.4 12151.9 31288.7 31705.5 31754.8 32912.5 38811.4 3141.9 3246.4 3404.3 3611.8 3886.2 29307.2 29957.0 31422.9 31866.7 32203.5 3019.5 3233.7 3240.7 3242.7 3253.9 513890.0 518139.4 519261.0 522735.0 523234.0 61911.0 62301.0 62406.7 62457.7 62493.7 54873.5 55826.7 55902.7 58493.0 58633.4 13576.6 14983.4 15383.9 15610.1 16216.6 12027.2 12038.4 12127.0 12231.9 12290.3 15917.5 18756.3 18782.0 18807.6 18918.6 6743.8 6921.4 7016.9 8138.3 8204.9 828.4 888.2 893.7 943.5 957.8 28666.1 29800.0 29950.9 30613.5 30662.2 921.8 1017.0 1024.6 1057.9 1064.2 14722.1 15340.8 15478.8 15740.0 15839.5 721220.4 728578.0 729639.0 730314.0 732761.0 49112.0 50079.0 56755.4 57001.0 57552.7 1353.2 1381.1 1384.4 1385.7 1391.8 29291.7 30530.7 30623.5 30753.2 31507.0 48406.8 48956.0 49066.3 49166.8 49224.5 620094.0 622057.0 624139.0 624151.0 626398.0 25926.5 26319.1 26353.3 26405.0 26471.1 46343.8 46820.5 47196.0 47491.5 47771.3 37740.8 38932.2 38980.6 39265.8 39680.8 31813.0 37175.3 37524.1 38501.8 39350.4 32111.5 37076.6 38258.6 38490.8 38500.8 31515.2 34458.7 34598.5 35423.1 36202.8 22826.5 25020.4 25742.3 25996.2 26342.5 10:13:51 INFO - PROCESS | 1650 | 10:13:51 INFO - PROCESS | 1650 | [#2] jquery.html Cycles:180 Average:35058.21 Median:2834.49 stddev:100945.68 (3561.3%) stddev-sans-first:101195.12 10:13:51 INFO - PROCESS | 1650 | Values: 303.6 331.5 377.4 379.2 400.0 14960.4 15414.7 16273.3 20602.7 21114.2 19543.3 19876.9 20503.6 20644.0 20805.2 5800.5 6098.5 6112.4 6114.7 6116.9 4163.2 4283.7 5966.3 6034.8 6036.0 4275.2 4358.0 6354.2 6675.1 6693.8 6428.9 6576.3 6690.2 6743.3 6766.1 5793.2 5793.9 5798.5 5801.3 5834.2 24298.5 25009.5 25087.4 25239.6 25333.7 2398.7 2493.6 2682.8 2830.7 2838.3 14906.9 15154.5 15319.8 15722.3 15768.6 1709.7 1798.4 1842.7 1852.7 1867.7 114992.4 118935.0 122145.0 124108.4 124303.8 9027.8 10350.1 10428.7 10505.0 10891.0 13545.0 13554.8 13566.2 13566.2 13567.6 7895.9 8153.8 8185.1 8251.2 8295.1 8118.1 8135.1 8174.3 8290.0 8297.9 5435.5 6493.2 6524.0 6539.8 6552.5 1642.5 1771.9 1800.4 1802.1 1803.8 670.4 919.8 939.4 977.6 1019.4 21288.9 21678.7 21725.0 21743.0 21753.9 917.9 936.2 959.9 964.8 967.4 10968.9 11315.5 11506.4 11519.1 11525.7 596112.0 598813.0 609054.0 611258.0 613810.0 119583.0 120019.0 120223.0 125350.0 129338.0 971.5 982.5 999.7 1000.8 1001.3 16767.0 17691.5 19320.9 19331.0 19378.5 51474.5 51578.7 53360.7 55062.4 56480.4 59431.0 75342.0 75409.9 78625.0 78891.0 7771.0 7796.9 7823.6 7824.5 7970.0 12093.7 12180.0 12183.0 12345.3 12404.2 8361.3 8426.5 10986.8 11003.6 11155.0 9433.2 10854.9 11155.3 11288.2 11506.5 9751.9 11078.4 11161.5 11186.6 11242.7 7675.9 7839.7 7953.9 7992.8 8043.6 9131.6 10504.7 10859.5 10861.0 11027.8 10:13:51 INFO - PROCESS | 1650 | 10:13:51 INFO - PROCESS | 1650 | [#3] mootools.html Cycles:180 Average:5819.48 Median:4835.07 stddev:3311.97 (68.5%) stddev-sans-first:3304.92 10:13:51 INFO - PROCESS | 1650 | Values: 1441.4 1493.3 1621.9 1677.3 1884.3 8684.7 9275.2 9278.4 9279.6 9285.6 7980.8 8236.8 8253.8 8719.2 8890.6 2359.1 2385.3 2385.4 2388.5 2393.7 2369.3 2379.7 2413.4 2414.9 2418.2 2122.6 2198.4 2322.2 2394.1 2402.1 2368.9 2370.8 2403.2 2403.4 2407.9 2380.2 2381.1 2386.8 2387.1 2391.5 7946.5 9020.1 9053.9 9154.6 9162.2 5164.3 5420.2 5433.8 5436.5 5437.7 3499.4 3567.8 3688.4 3713.8 3746.1 935.9 1053.8 1074.1 1098.2 1098.2 12025.6 12166.0 12174.8 12181.8 12182.6 4588.3 4630.9 4824.2 4846.0 4846.1 10268.5 10270.7 10280.7 10283.0 10287.6 5316.0 5325.3 5332.2 5332.5 5346.3 4711.0 4799.6 4847.4 4848.0 4858.2 3965.5 3972.5 4004.2 4093.0 4107.8 1111.4 1196.3 1290.3 1301.2 1322.7 738.1 843.0 886.8 892.0 936.9 5869.9 6023.6 6094.2 6095.8 6383.8 943.3 943.3 961.1 1041.7 1049.4 3829.3 3913.5 3921.8 3949.8 4034.0 10917.4 10976.0 11011.2 11226.0 11246.8 11185.6 11197.8 11198.9 11203.2 11204.9 6746.6 8275.6 8307.7 8353.5 8373.0 5919.7 5985.6 5985.9 6058.3 6090.5 10146.1 10481.0 10496.6 10512.8 10518.3 10102.2 10391.9 10442.2 10594.9 10654.4 7671.5 7856.6 7865.2 7866.4 7885.3 7991.2 8088.8 8119.7 8218.0 8249.9 6265.4 7605.9 7673.4 7687.3 7714.0 7452.7 7528.4 7553.1 7571.3 7639.8 6824.2 6913.9 6921.2 7003.1 7004.3 4978.8 4987.7 4999.4 5044.7 5052.7 4965.4 5012.5 5015.9 5114.1 5134.8 10:13:51 INFO - PROCESS | 1650 | 10:13:51 INFO - PROCESS | 1650 | [#4] prototype.html Cycles:180 Average:4420.98 Median:4755.36 stddev:1391.80 (29.3%) stddev-sans-first:1360.83 10:13:51 INFO - PROCESS | 1650 | Values: 295.8 297.8 305.0 311.3 312.2 5280.5 5473.9 5524.6 5530.3 5571.4 4983.2 5114.4 5404.8 5420.4 5442.6 3645.2 4147.5 4183.3 4195.4 4204.5 3108.3 3908.8 4117.2 4213.5 4224.5 4091.6 4094.2 4100.9 4103.2 4143.2 4067.9 4085.7 4100.1 4101.8 4122.8 3410.2 3554.9 3562.6 3575.6 3586.9 5259.0 5267.4 5285.0 5291.6 5321.7 3787.3 4256.4 4639.8 4660.7 4671.5 4701.9 5178.8 5701.2 5701.8 5702.4 3405.5 3449.5 3830.4 3887.8 3895.6 4965.8 5547.4 6022.8 6023.0 6023.8 3611.3 3917.7 3962.8 3978.3 3986.3 3811.4 3985.4 4002.9 4008.4 4036.3 4339.2 4615.8 4630.8 4640.7 4656.0 4737.9 5669.6 5736.8 5754.4 5832.3 1217.8 1252.2 1299.6 1307.6 1312.2 720.8 743.9 744.4 759.0 793.9 3941.5 4165.7 4287.8 4531.5 4556.1 3986.6 4142.9 4155.3 4660.0 4905.7 3799.9 4081.7 4313.4 4502.3 4519.7 2234.7 2263.1 2356.2 2547.4 2548.6 4922.8 4953.7 4960.4 4979.3 4993.6 4040.0 4459.3 4900.4 4924.6 5018.4 4846.5 4992.6 5024.9 5038.6 5042.4 4804.6 4808.3 4813.0 4813.6 4829.8 4739.7 5490.8 5950.5 5953.4 5985.0 6198.9 6214.0 6229.5 6230.7 6320.9 3894.1 3910.1 3960.9 3989.3 3999.5 4649.2 4771.0 5918.2 5948.5 5994.3 5841.6 5855.4 5858.2 5877.4 5907.4 5262.6 5456.7 5753.5 5791.9 5820.5 4585.6 5519.0 5559.0 5633.9 5670.4 5263.7 5339.7 5822.3 5824.4 5833.9 4995.8 5275.9 5334.9 5488.1 5727.4 10:13:51 INFO - PROCESS | 1650 | 10:13:51 INFO - PROCESS | 1650 | [#5] yui.html Cycles:180 Average:25735.14 Median:22604.39 stddev:41584.86 (184.0%) stddev-sans-first:41658.96 10:13:51 INFO - PROCESS | 1650 | Values: 677.3 692.2 696.5 729.4 795.5 13527.3 14685.1 15906.3 15962.8 16088.3 14311.8 14498.5 14502.3 14508.6 14518.7 649.4 663.5 668.4 814.7 817.5 810.3 814.3 814.9 815.6 815.7 867.3 868.5 869.0 869.1 870.0 690.0 707.3 709.5 711.7 862.5 525.7 624.8 639.0 644.3 645.6 14828.3 14868.5 14896.7 15215.8 15253.2 13913.6 14089.0 14175.6 14195.7 14391.1 12623.4 12724.2 13026.6 13152.6 13548.1 4539.4 4622.6 4633.0 4642.5 4717.4 112138.0 112499.4 115596.0 115871.7 117546.0 10724.5 10852.6 10938.9 11002.8 11326.9 22420.8 22788.0 22872.1 22873.8 22917.5 7611.2 7644.4 7648.8 8006.5 8010.0 4310.6 4310.8 4372.6 4502.5 4518.9 3392.6 3517.5 3517.8 3518.1 3525.8 649.5 670.4 677.9 688.8 698.0 491.9 521.9 527.5 607.9 627.8 8325.6 9353.7 9643.5 9871.3 9925.4 555.9 595.9 601.3 607.8 620.6 4563.8 4798.3 4800.4 4804.1 4822.0 100669.5 102353.5 163596.0 172672.0 178110.0 141370.3 142284.0 143971.0 145053.2 151766.0 88493.1 106694.0 107681.0 114563.0 126281.0 9111.3 10022.3 10193.7 10206.3 10210.0 64697.7 65296.7 66012.3 67721.7 69384.7 96488.0 99628.5 101505.0 102549.5 104220.0 12479.0 12796.6 12833.2 13360.3 13632.9 14232.7 14472.8 14711.5 15050.0 15373.4 11606.5 13548.1 13566.1 13745.6 13959.3 13005.7 13149.9 13737.6 13967.7 14103.6 12858.9 13377.4 13382.7 13643.8 14331.4 9806.5 10913.8 11003.4 11167.3 11692.6 11444.8 11520.8 11663.9 11776.0 11828.3 10:13:51 INFO - PROCESS | 1650 | -------- Summary: end -------- 10:13:51 INFO - PROCESS | 1650 | 10:13:52 INFO - TEST-INFO | 1650: exit 0 10:13:52 INFO - TEST-OK | dromaeo_css | took 1118591ms 10:13:52 INFO - TEST-START | kraken 10:13:52 INFO - operating with platform_type : mac_ 10:13:52 INFO - Initialising browser for kraken test... 10:13:52 INFO - TEST-INFO | started process 1659 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/tmpqTl2Ts/profile http://localhost:49272/getInfo.html) 10:13:54 INFO - PROCESS | 1659 | __metrics Screen width/height:1600/1200 10:13:54 INFO - PROCESS | 1659 | colorDepth:24 10:13:54 INFO - PROCESS | 1659 | Browser inner width/height: 1024/689 10:13:54 INFO - PROCESS | 1659 | __metrics 10:13:54 INFO - PROCESS | 1659 | 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" 10:13:54 INFO - PROCESS | 1659 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:13:55 INFO - TEST-INFO | 1659: exit 0 10:13:55 INFO - Browser initialized. 10:13:55 INFO - Running cycle 1/1 for kraken test... 10:13:55 INFO - TEST-INFO | started process 1660 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/tmpqTl2Ts/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:14:07 INFO - PROCESS | 1660 | RSS: Main: 219287552 10:14:07 INFO - PROCESS | 1660 | 10:14:10 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-beat-detection) 10:14:10 INFO - PROCESS | 1660 | RSS: Main: 269680640 10:14:10 INFO - PROCESS | 1660 | 10:14:13 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-dft) 10:14:14 INFO - PROCESS | 1660 | RSS: Main: 280276992 10:14:14 INFO - PROCESS | 1660 | 10:14:17 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-fft) 10:14:18 INFO - PROCESS | 1660 | RSS: Main: 377556992 10:14:18 INFO - PROCESS | 1660 | 10:14:20 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-oscillator) 10:14:20 INFO - PROCESS | 1660 | RSS: Main: 280137728 10:14:20 INFO - PROCESS | 1660 | 10:14:22 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:14:23 INFO - PROCESS | 1660 | RSS: Main: 280928256 10:14:23 INFO - PROCESS | 1660 | 10:14:26 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-darkroom) 10:14:26 INFO - PROCESS | 1660 | RSS: Main: 320258048 10:14:26 INFO - PROCESS | 1660 | 10:14:29 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-desaturate) 10:14:30 INFO - PROCESS | 1660 | RSS: Main: 319488000 10:14:30 INFO - PROCESS | 1660 | 10:14:33 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49272/tests/kraken/driver.html?testName=json-parse-financial) 10:14:33 INFO - PROCESS | 1660 | RSS: Main: 316829696 10:14:33 INFO - PROCESS | 1660 | 10:14:35 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49272/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:14:36 INFO - PROCESS | 1660 | RSS: Main: 290037760 10:14:36 INFO - PROCESS | 1660 | 10:14:37 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:14:38 INFO - PROCESS | 1660 | RSS: Main: 295354368 10:14:38 INFO - PROCESS | 1660 | 10:14:40 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:14:41 INFO - PROCESS | 1660 | RSS: Main: 303452160 10:14:41 INFO - PROCESS | 1660 | 10:14:44 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:14:45 INFO - PROCESS | 1660 | RSS: Main: 308318208 10:14:45 INFO - PROCESS | 1660 | 10:14:47 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:14:48 INFO - PROCESS | 1660 | RSS: Main: 308260864 10:14:48 INFO - PROCESS | 1660 | 10:14:50 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49272/tests/kraken/driver.html?testName=ai-astar) 10:14:50 INFO - PROCESS | 1660 | RSS: Main: 351907840 10:14:50 INFO - PROCESS | 1660 | 10:14:50 INFO - PROCESS | 1660 | __start_tp_report 10:14:50 INFO - PROCESS | 1660 | _x_x_mozilla_page_load 10:14:50 INFO - PROCESS | 1660 | _x_x_mozilla_page_load_details 10:14:50 INFO - PROCESS | 1660 | |i|pagename|runs| 10:14:50 INFO - PROCESS | 1660 | |0;ai-astar;116;115;115;114;115;115;114;115;115;114 10:14:50 INFO - PROCESS | 1660 | |1;audio-beat-detection;136;102;108;132;132;138;136;112;139;116 10:14:50 INFO - PROCESS | 1660 | |2;audio-dft;186;182;183;184;199;260;199;183;184;185 10:14:50 INFO - PROCESS | 1660 | |3;audio-fft;82;59;59;89;73;49;70;73;99;81 10:14:50 INFO - PROCESS | 1660 | |4;audio-oscillator;86;70;95;70;68;69;93;68;68;90 10:14:50 INFO - PROCESS | 1660 | |5;imaging-gaussian-blur;91;88;91;88;90;88;93;130;90;88 10:14:50 INFO - PROCESS | 1660 | |6;imaging-darkroom;95;95;95;96;95;95;96;96;95;95 10:14:50 INFO - PROCESS | 1660 | |7;imaging-desaturate;84;85;86;96;135;142;83;84;86;86 10:14:50 INFO - PROCESS | 1660 | |8;json-parse-financial;56;53;53;52;54;57;56;57;57;56 10:14:50 INFO - PROCESS | 1660 | |9;json-stringify-tinderbox;64;72;69;76;73;70;68;68;69;70 10:14:50 INFO - PROCESS | 1660 | |10;stanford-crypto-aes;82;86;81;85;87;86;82;82;90;84 10:14:50 INFO - PROCESS | 1660 | |11;stanford-crypto-ccm;158;146;155;146;127;151;154;157;172;140 10:14:50 INFO - PROCESS | 1660 | |12;stanford-crypto-pbkdf2;167;166;165;165;166;165;165;165;166;164 10:14:50 INFO - PROCESS | 1660 | |13;stanford-crypto-sha256-iterative;67;67;67;66;67;67;67;67;65;65 10:14:50 INFO - PROCESS | 1660 | __end_tp_report 10:14:50 INFO - PROCESS | 1660 | __start_cc_report 10:14:50 INFO - PROCESS | 1660 | _x_x_mozilla_cycle_collect,2063 10:14:50 INFO - PROCESS | 1660 | __end_cc_report 10:14:50 INFO - PROCESS | 1660 | __startTimestamp1477674890476__endTimestamp 10:14:50 INFO - PROCESS | 1660 | 10:14:50 INFO - PROCESS | 1660 | ------- Summary: start ------- 10:14:50 INFO - PROCESS | 1660 | Number of tests: 14 10:14:50 INFO - PROCESS | 1660 | 10:14:50 INFO - PROCESS | 1660 | [#0] ai-astar Cycles:10 Average:114.80 Median:115.00 stddev:0.63 (0.5%) stddev-sans-first:0.50 10:14:50 INFO - PROCESS | 1660 | Values: 116.0 115.0 115.0 114.0 115.0 115.0 114.0 115.0 115.0 114.0 10:14:50 INFO - PROCESS | 1660 | 10:14:50 INFO - PROCESS | 1660 | [#1] audio-beat-detection Cycles:10 Average:125.10 Median:134.00 stddev:14.04 (10.5%) stddev-sans-first:14.32 10:14:50 INFO - PROCESS | 1660 | Values: 136.0 102.0 108.0 132.0 132.0 138.0 136.0 112.0 139.0 116.0 10:14:50 INFO - PROCESS | 1660 | 10:14:50 INFO - PROCESS | 1660 | [#2] audio-dft Cycles:10 Average:194.50 Median:185.50 stddev:23.89 (12.9%) stddev-sans-first:25.14 10:14:50 INFO - PROCESS | 1660 | Values: 186.0 182.0 183.0 184.0 199.0 260.0 199.0 183.0 184.0 185.0 10:14:50 INFO - PROCESS | 1660 | 10:14:50 INFO - PROCESS | 1660 | [#3] audio-fft Cycles:10 Average:73.40 Median:77.00 stddev:15.10 (19.6%) stddev-sans-first:15.69 10:14:50 INFO - PROCESS | 1660 | Values: 82.0 59.0 59.0 89.0 73.0 49.0 70.0 73.0 99.0 81.0 10:14:50 INFO - PROCESS | 1660 | 10:14:50 INFO - PROCESS | 1660 | [#4] audio-oscillator Cycles:10 Average:77.70 Median:78.00 stddev:11.69 (15.0%) stddev-sans-first:12.01 10:14:50 INFO - PROCESS | 1660 | Values: 86.0 70.0 95.0 70.0 68.0 69.0 93.0 68.0 68.0 90.0 10:14:50 INFO - PROCESS | 1660 | 10:14:50 INFO - PROCESS | 1660 | [#5] imaging-gaussian-blur Cycles:10 Average:93.70 Median:90.00 stddev:12.87 (14.3%) stddev-sans-first:13.61 10:14:50 INFO - PROCESS | 1660 | Values: 91.0 88.0 91.0 88.0 90.0 88.0 93.0 130.0 90.0 88.0 10:14:50 INFO - PROCESS | 1660 | 10:14:50 INFO - PROCESS | 1660 | [#6] imaging-darkroom Cycles:10 Average:95.30 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 10:14:50 INFO - PROCESS | 1660 | Values: 95.0 95.0 95.0 96.0 95.0 95.0 96.0 96.0 95.0 95.0 10:14:50 INFO - PROCESS | 1660 | 10:14:50 INFO - PROCESS | 1660 | [#7] imaging-desaturate Cycles:10 Average:96.70 Median:85.50 stddev:22.39 (26.2%) stddev-sans-first:23.27 10:14:50 INFO - PROCESS | 1660 | Values: 84.0 85.0 86.0 96.0 135.0 142.0 83.0 84.0 86.0 86.0 10:14:50 INFO - PROCESS | 1660 | 10:14:50 INFO - PROCESS | 1660 | [#8] json-parse-financial Cycles:10 Average:55.10 Median:56.00 stddev:1.91 (3.4%) stddev-sans-first:2.00 10:14:50 INFO - PROCESS | 1660 | Values: 56.0 53.0 53.0 52.0 54.0 57.0 56.0 57.0 57.0 56.0 10:14:50 INFO - PROCESS | 1660 | 10:14:50 INFO - PROCESS | 1660 | [#9] json-stringify-tinderbox Cycles:10 Average:69.90 Median:70.00 stddev:3.25 (4.6%) stddev-sans-first:2.65 10:14:50 INFO - PROCESS | 1660 | Values: 64.0 72.0 69.0 76.0 73.0 70.0 68.0 68.0 69.0 70.0 10:14:50 INFO - PROCESS | 1660 | 10:14:50 INFO - PROCESS | 1660 | [#10] stanford-crypto-aes Cycles:10 Average:84.50 Median:85.50 stddev:2.84 (3.3%) stddev-sans-first:2.86 10:14:50 INFO - PROCESS | 1660 | Values: 82.0 86.0 81.0 85.0 87.0 86.0 82.0 82.0 90.0 84.0 10:14:50 INFO - PROCESS | 1660 | 10:14:50 INFO - PROCESS | 1660 | [#11] stanford-crypto-ccm Cycles:10 Average:150.60 Median:154.50 stddev:12.00 (7.8%) stddev-sans-first:12.43 10:14:50 INFO - PROCESS | 1660 | Values: 158.0 146.0 155.0 146.0 127.0 151.0 154.0 157.0 172.0 140.0 10:14:50 INFO - PROCESS | 1660 | 10:14:50 INFO - PROCESS | 1660 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.40 Median:165.50 stddev:0.84 (0.5%) stddev-sans-first:0.67 10:14:50 INFO - PROCESS | 1660 | Values: 167.0 166.0 165.0 165.0 166.0 165.0 165.0 165.0 166.0 164.0 10:14:50 INFO - PROCESS | 1660 | 10:14:50 INFO - PROCESS | 1660 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.50 Median:67.00 stddev:0.85 (1.3%) stddev-sans-first:0.88 10:14:50 INFO - PROCESS | 1660 | Values: 67.0 67.0 67.0 66.0 67.0 67.0 67.0 67.0 65.0 65.0 10:14:50 INFO - PROCESS | 1660 | -------- Summary: end -------- 10:14:50 INFO - PROCESS | 1660 | 10:14:51 INFO - TEST-INFO | 1660: exit 0 10:14:51 INFO - TEST-OK | kraken | took 59025ms 10:14:51 INFO - SUITE-END | took 1177s 10:14:51 INFO - Completed test suite (00:19:37) 10:14:51 INFO - javascript benchmark 10:14:51 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3325.5177999190114, 3341.431956567383, 3364.3607714534237, 3375.6455572164905, 3401.608814986277, 5393.730313484325, 5798.681072541009, 5807.157962095504, 5821.301443826746, 5834.2998840139135, 5712.285964254468, 5786.768529258825, 5789.160571717099, 5807.854803629912, 5828.562857785672, 5233.9738301308535, 5282.630215884889, 5307.840764777063, 5321.73391330432, 5355.866103347428, 5222.4255331913455, 5235.450277720842, 5249.343832020997, 5332.720147164672, 5400.081986062359, 5313.654612450178, 5331.067063263933, 5338.946610533903, 5345.358556973169, 5345.652532585389, 5317.654352467097, 5344.412114667383, 5345.973270133624, 5359.973200133974, 5362.981033603623, 4490.899729566245, 5211.296474975868, 5221.634485586011, 5279.0, 5280.841574752763, 5708.115242137475, 5765.509931655814, 5811.476967072984, 5863.912041319341, 5901.350851406385, 6309.3690630937, 6309.716062777186, 6318.526110541728, 6325.5255855811, 6347.96826015867, 6160.5687601867885, 6241.921692616683, 6250.156228909084, 6266.749330026793, 6340.682965851689, 5744.798932037359, 5767.596268261265, 5809.099589563624, 5841.50347220491, 5850.210221620112, 6275.748970041239, 6330.493560515148, 6339.334369891095, 6340.207474065742, 6346.555741098079, 6023.69881505923, 6127.877442451126, 6204.565680402418, 6250.124982502453, 6265.028920517327, 6225.564210505312, 6262.2172228471445, 6263.906041409383, 6341.334159913143, 6353.96823015882, 6301.96849015752, 6314.336994615591, 6319.778807741707, 6323.20959880015, 6324.430801227912, 6104.938950610437, 6247.500199983991, 6327.209098862642, 6340.682965851781, 6342.8414289642205, 4913.557779799835, 4962.15643340633, 4971.602271818246, 4974.676646017997, 4975.975120124376, 4417.204903117406, 4453.888652783707, 4470.754108524063, 4472.0, 4518.299663552155, 5796.88406231873, 5862.70686465675, 5889.204957330791, 5903.173555702205, 5914.704264786744, 6203.193584834033, 6283.277423096311, 6315.842103947346, 6316.873662526816, 6341.3341599132345, 5704.971475142598, 5737.483626473638, 5824.767009319579, 5832.825015249549, 5894.292684877756, 5437.374701909252, 5438.755256013489, 5450.073487507133, 5456.181572764038, 5462.9726851365485, 6169.81490555284, 6365.809025729235, 6367.108604795239, 6376.744930202833, 6379.521535884827, 6255.56211065221, 6255.9374406257175, 6307.211598550181, 6320.273168585672, 6328.9050664240995, 6333.366663333814, 6374.617522948638, 6378.968105159444, 6381.138546296191, 6396.0, 6275.717592708431, 6286.025666021774, 6324.335944725737, 6328.557001009885, 6329.050642403677, 5759.790444006638, 6103.974138059581, 6126.059675755388, 6237.7193026314835, 6257.499400047895, 5405.189221616789, 6190.597611155261, 6255.0, 6266.0, 6268.27914789805, 6201.844953876189, 6230.657313847782, 6238.937610624017, 6247.031710084944, 6274.341194174728, 5879.088741245114, 5970.880582388241, 5974.940250597612, 6023.524236562071, 6042.697865106639, 6222.439980401605, 6231.345708700521, 6233.812985610439, 6241.251049874044, 6252.906206406817, 6091.02543593023, 6101.969490152521, 6105.641708308169, 6105.786297479567, 6110.847228819137], "value": 5765.882430996878, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [455.599072815922, 513.7302915969117, 534.9598780091494, 535.0663092902882, 544.8147629805865, 26768.732312676868, 29944.25139371514, 31142.844285778567, 32408.027759167235, 32409.0, 32808.85169019085, 33619.831900840465, 41183.38224926629, 42290.57709422913, 42416.78791606038, 9662.227021838253, 9812.165965892907, 9818.067283608047, 9829.65596204133, 9833.557489912972, 9704.175145112638, 9783.0706082922, 9797.167240784542, 9799.461029643368, 9802.0, 7464.402847772192, 7801.687932482694, 9784.90215097847, 11815.291082535032, 12087.335196564185, 11888.58389956356, 11892.643220703392, 12201.0, 12292.508299668047, 12322.260664360077, 12064.034877209802, 12121.272723636523, 12130.514779408813, 12151.392430378446, 12151.878481215252, 31288.687113128806, 31705.52441713376, 31754.841225793953, 32912.506312405334, 38811.41782873259, 3141.905742827696, 3246.4156451838658, 3404.3021180657906, 3611.801350925698, 3886.1839013807135, 29307.168642094395, 29957.0, 31422.900198492942, 31866.681333186603, 32203.51694724581, 3019.5017822059335, 3233.676632336771, 3240.740740740735, 3242.7405807535342, 3253.869845206189, 513890.0, 518139.40930295864, 519260.9999999962, 522735.0, 523234.0, 61911.0, 62301.0, 62406.687966559875, 62457.68771156115, 62493.68753156296, 54873.45126548763, 55826.72086639541, 55902.720486398124, 58493.0, 58633.4136658628, 13576.59270221895, 14983.400663973536, 15383.923080384526, 15610.12678478567, 16216.594585135466, 12027.158098933165, 12038.39808009596, 12126.969207617274, 12231.938840305742, 12290.262584244974, 15917.52247432579, 18756.343527976456, 18781.96699181531, 18807.623847522973, 18918.621627567372, 6743.819831529463, 6921.446284297244, 7016.92983070173, 8138.348932085419, 8204.876926846102, 828.4035494443991, 888.1784349476708, 893.6961433112773, 943.5376665433888, 957.7988622389377, 28666.14001579956, 29800.0, 29950.850245748632, 30613.540796888065, 30662.233444164074, 921.8156368726281, 1016.9542370593341, 1024.5594394410325, 1057.8836328003913, 1064.2443864855884, 14722.11667299944, 15340.846591534166, 15478.767818482731, 15740.0, 15839.52481425559, 721220.3938980376, 728578.0, 729639.0, 730314.0, 732761.0, 49112.0, 50079.0, 56755.43244567502, 57001.0, 57552.71223643855, 1353.2286596640017, 1381.0884816021578, 1384.3977869626744, 1385.736710025092, 1391.7773156294945, 29291.68187431528, 30530.694693052785, 30623.54064688987, 30753.15585551806, 31507.0, 48406.757966209945, 48956.0, 49066.26400604065, 49166.77083072952, 49224.50775492199, 620094.0, 622057.0, 624139.0, 624151.0, 626398.0, 25926.481470370865, 26319.07883224078, 26353.341166470993, 26405.0, 26471.073512426974, 46343.76828115838, 46820.531794681614, 47196.0, 47491.52508474871, 47771.28343074787, 37740.81129594444, 38932.221355573296, 38980.6101938977, 39265.80367098146, 39680.80159599299, 31813.0, 37175.25649487049, 37524.061898452754, 38501.844944651704, 39350.40974385329, 32111.518327225578, 37076.629233708394, 38258.61741382662, 38490.80754596209, 38500.80749596234, 31515.151515151698, 34458.65541344655, 34598.481022785185, 35423.11442213965, 36202.8189859049, 22826.543469130193, 25020.37449063715, 25742.297058809305, 25996.22011339663, 26342.473150537266], "value": 19860.32126434875, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [303.55983823455966, 331.5391605668121, 377.36790875283873, 379.1771855074487, 399.96600288975435, 14960.401583936644, 15414.69170616587, 16273.349066037374, 20602.69095963558, 21114.155433782667, 19543.315983940563, 19876.90061549694, 20503.589928201425, 20644.0, 20805.16779328825, 5800.53595712343, 6098.4511393974535, 6112.358202388752, 6114.663693496856, 6116.938830611703, 4163.188178305217, 4283.721558098714, 5966.2840459144745, 6034.818955431344, 6036.0, 4275.166342563201, 4357.978210108961, 6354.237491501026, 6675.132232809752, 6693.799186024427, 6428.871422571569, 6576.342365763433, 6690.197176338822, 6743.258241593421, 6766.052752614638, 5793.246877905887, 5793.942060579425, 5798.536117110621, 5801.3328467225965, 5834.241548598655, 24298.514029719485, 25009.499810003697, 25087.372815679755, 25239.621405678747, 25333.74666253332, 2398.6761787158857, 2493.551160791057, 2682.8390296582265, 2830.674472435676, 2838.304615369227, 14906.925465372713, 15154.469593564283, 15319.770203446846, 15722.292496837556, 15768.605784855356, 1709.6922553940285, 1798.4065258464675, 1842.677531431994, 1852.657258407199, 1867.7105048717472, 114992.42503787512, 118935.0, 122145.0, 124108.37945810214, 124303.75696243012, 9027.77430564228, 10350.120239779553, 10428.739281517872, 10505.0, 10890.985167743993, 13545.0, 13554.796678049837, 13566.186028838301, 13566.186028838301, 13567.59297221085, 7895.921040789519, 8153.776933460029, 8185.099639039701, 8251.174882511701, 8295.129011453831, 8118.066422361386, 8135.1051384347675, 8174.3051840593025, 8290.046644635944, 8297.917020829835, 5435.456454354612, 6493.155889734304, 6523.967380163163, 6539.836504087436, 6552.541322107407, 1642.5072478256475, 1771.8582513398896, 1800.36087189046, 1802.0539216911227, 1803.819618038212, 670.3698523388, 919.8206349761866, 939.3987847777428, 977.6138425321958, 1019.4494972714651, 21288.893555532122, 21678.674819877713, 21725.0, 21743.0, 21753.891230543744, 917.9173874351341, 936.1901954809177, 959.8769439755503, 964.8118616869783, 967.3712087143413, 10968.890311096788, 11315.490802913888, 11506.424678766029, 11519.078473722082, 11525.711857203636, 596112.0, 598813.0, 609054.0, 611258.0, 613810.0, 119583.0, 120019.0, 120223.0, 125350.0, 129338.0, 971.4851128901694, 982.464556816551, 999.6751055906859, 1000.8498725191134, 1001.2740762946951, 16767.0, 17691.469255922344, 19320.903395483496, 19331.0, 19378.515537111685, 51474.485255148466, 51578.74210628923, 53360.73319633377, 55062.449375507334, 56480.43519564916, 59431.0, 75342.0, 75409.86885196617, 78625.0, 78891.0, 7770.961145194238, 7796.922030779847, 7823.569703666125, 7824.530528168328, 7970.043594768665, 12093.697657558632, 12180.0, 12183.0, 12345.321007344683, 12404.19372740769, 8361.331093512383, 8426.536540490331, 10986.780264394507, 11003.559857605926, 11155.0, 9433.245340372616, 10854.945725271324, 11155.27490713101, 11288.153388495732, 11506.482208300478, 9751.853722194031, 11078.446077696244, 11161.497732602214, 11186.552537898393, 11242.718932026764, 7675.884861727191, 7839.725609603636, 7953.880691789512, 7992.8001799953145, 8043.632582461113, 9131.634734610541, 10504.737381565215, 10859.51132199037, 10861.0, 11027.83458248143], "value": 9591.059965245578, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1441.4378392426956, 1493.313075985047, 1621.878359123066, 1677.2955358749325, 1884.3122260374967, 8684.73945781626, 9275.211607013403, 9278.396904201221, 9279.582418791153, 9285.628574857006, 7980.760577182679, 8236.83526329473, 8253.79365515861, 8719.17167869053, 8890.555472226395, 2359.09174967637, 2385.296337580418, 2385.3917251101034, 2388.5103553771523, 2393.7247216570145, 2369.2892132360307, 2379.7263314718857, 2413.4087148648605, 2414.8671823049726, 2418.1899063813557, 2122.628540005501, 2198.373463562885, 2322.2104484475276, 2394.1022116706235, 2402.1112188490283, 2368.86971216583, 2370.7747763962398, 2403.2069417092316, 2403.435192729707, 2407.9157229496973, 2380.2264264114233, 2381.0832829360647, 2386.832921695482, 2387.1048356866177, 2391.5456063348083, 7946.523208607444, 9020.14308640678, 9053.909460905372, 9154.588043538057, 9162.175404213585, 5164.2770012198325, 5420.159875219348, 5433.755481003364, 5436.537894278951, 5437.700926449043, 3499.3526197653514, 3567.839447224881, 3688.354537955847, 3713.832877520518, 3746.1196618794834, 935.911492076146, 1053.761829849931, 1074.0816601805423, 1098.1873413673825, 1098.2367254757946, 12025.63923082309, 12166.026717862638, 12174.756504869942, 12181.817272740916, 12182.573609923698, 4588.26587745959, 4630.907381852344, 4824.155772739757, 4845.9757701211265, 4846.103470857832, 10268.486575671186, 10270.743231419274, 10280.742981425525, 10283.023112804272, 10287.588496460057, 5316.043112239757, 5325.254464374991, 5332.226827110047, 5332.466753324637, 5346.251524786455, 4710.952890471051, 4799.568038876448, 4847.442544107403, 4848.0, 4858.198397264482, 3965.464662270614, 3972.503437070366, 4004.2391945530258, 4093.0176757577965, 4107.753534787922, 1111.433169083773, 1196.318098683742, 1290.2581015915887, 1301.1802564384377, 1322.6825561865082, 738.1216352540459, 842.9578521074044, 886.7916039730658, 892.0410558649348, 936.8828896387952, 5869.853253668693, 6023.578349515492, 6094.238220222473, 6095.817125486243, 6383.808485745435, 943.2689665509286, 943.3113826906397, 961.1493827962304, 1041.7238882369188, 1049.375621505203, 3829.349010668193, 3913.5108111486065, 3921.8235179416993, 3949.782761948063, 4034.0, 10917.39954302505, 10976.0, 11011.174161937886, 11226.0, 11246.775064498828, 11185.552577896955, 11197.776044479066, 11198.944005280084, 11203.21577489568, 11204.943975280234, 6746.628935408599, 8275.62759675816, 8307.667693292322, 8353.457025293337, 8372.958135209285, 5919.6744179070565, 5985.6408615483215, 5985.880282394415, 6058.303295121117, 6090.482309003784, 10146.086852183043, 10481.004304591052, 10496.580136794748, 10512.842307365549, 10518.263721539419, 10102.191824654157, 10391.896081039093, 10442.216833737348, 10594.947025265134, 10654.360738355723, 7671.462997590115, 7856.5678887661725, 7865.174156713462, 7866.449348545776, 7885.250901164381, 7991.24083212094, 8088.83822323562, 8119.675212991414, 8217.95891020565, 8249.876251856107, 6265.373462653698, 7605.923940760743, 7673.424493162924, 7687.308142267223, 7714.0, 7452.701891924479, 7528.397728181842, 7553.055868016498, 7571.318581327707, 7639.847203056019, 6824.181098268041, 6913.861722765416, 6921.2386637468835, 7003.124609423822, 7004.264552221944, 4978.82997495581, 4987.675801072919, 4999.400071991385, 5044.722540260321, 5052.69683818972, 4965.4289756677, 5012.548870601518, 5015.899682006412, 5114.130597798308, 5134.820281290137], "value": 4650.786743755402, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [295.7633892885691, 297.8049377657634, 304.9740772034376, 311.26541362384785, 312.2178941750914, 5280.498352656491, 5473.9345966258925, 5524.558035357172, 5530.281063461749, 5571.434282059475, 4983.202687569989, 5114.386273647158, 5404.757025834284, 5420.376656684482, 5442.619016668835, 3645.198056427582, 4147.502299724038, 4183.288840897055, 4195.433616461784, 4204.5375008749015, 3108.347247078116, 3908.7850168240734, 4117.17656468706, 4213.494380674323, 4224.45082139323, 4091.6112969267874, 4094.160697057096, 4100.938485922698, 4103.194594378464, 4143.19207754488, 4067.877963661095, 4085.6935729820084, 4100.118474527976, 4101.815418306153, 4122.773247471388, 3410.2326976430354, 3554.893353199408, 3562.590302115238, 3575.624559421249, 3586.910327241814, 5258.99001027989, 5267.446918073585, 5284.973575132138, 5291.603129765283, 5321.73391330432, 3787.299349620329, 4256.382824490463, 4639.837605683819, 4660.6970546914345, 4671.48613652498, 4701.9185587315105, 5178.792848286102, 5701.230333904911, 5701.77192912283, 5702.401247868997, 3405.506201600754, 3449.534312867781, 3830.3871380578976, 3887.7667339959694, 3895.5714871364125, 4965.751712414365, 5547.44525547442, 6022.759089636409, 6023.006203976295, 6023.771204654262, 3611.259691763182, 3917.7071566383024, 3962.841486340572, 3978.303796835542, 3986.3422535281934, 3811.4092315691114, 3985.362342025262, 4002.897754240487, 4008.378701301303, 4036.2936486114813, 4339.240632889295, 4615.776564443564, 4630.814767409333, 4640.65195110368, 4655.976720116378, 4737.9052418952115, 5669.574781891375, 5736.827895163152, 5754.367019627837, 5832.300123985149, 1217.7518044004967, 1252.2298786246392, 1299.5516546791341, 1307.5878051704137, 1312.225786785801, 720.8450183210634, 743.8921356403291, 744.3858816476428, 758.9734359297398, 793.8531371696255, 3941.507311586052, 4165.708400412002, 4287.785610719451, 4531.546845315508, 4556.134334476439, 3986.60133986599, 4142.937855932163, 4155.293600087993, 4660.04469083837, 4905.656604037683, 3799.905002374963, 4081.673466122703, 4313.398312409174, 4502.3246513023305, 4519.661025423106, 2234.72065991751, 2263.1286954522297, 2356.244597774669, 2547.4268289634683, 2548.566743653583, 4922.833953060642, 4953.6532442729385, 4960.379952505937, 4979.307035607911, 4993.550580447704, 4039.979800100981, 4459.327752092965, 4900.387451568554, 4924.581410580069, 5018.411835537609, 4846.539578740014, 4992.578599379371, 5024.899502009939, 5038.596912247085, 5042.39491261051, 4804.639652026042, 4808.326834243278, 4813.0, 4813.614910807197, 4829.7585120744525, 4739.691920025188, 5490.80367852862, 5950.452882250733, 5953.434423729739, 5984.95263328907, 6198.876022479435, 6214.0, 6229.470495007975, 6230.657313847782, 6320.873582528416, 3894.1432884765304, 3910.0811309342853, 3960.861369852041, 3989.2819292527624, 3999.5400528939545, 4649.211312348287, 4771.021940502119, 5918.171455996078, 5948.524118070631, 5994.28068631767, 5841.591088623755, 5855.385184555731, 5858.150568167677, 5877.353491115889, 5907.438793314628, 5262.6316157870115, 5456.727163641882, 5753.453421924911, 5791.8552036199435, 5820.476157145878, 4585.587297143273, 5518.971151059829, 5558.972205138948, 5633.943660563506, 5670.376258611467, 5263.736813159403, 5339.679619222859, 5822.311529656352, 5824.3593204748295, 5833.912491312549, 4995.775190116381, 5275.920861187162, 5334.919976200283, 5488.1493368527945, 5727.427257274239], "value": 3969.7236168465406, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [677.3260605697332, 692.2350802363388, 696.5472442912106, 729.4492658043176, 795.4551132474252, 13527.256000919946, 14685.118892866421, 15906.28421721021, 15962.840371596281, 16088.276027578759, 14311.785323220134, 14498.492552760656, 14502.347394367252, 14508.5647430577, 14518.709625807478, 649.3993056422802, 663.5255792108642, 668.4318329420003, 814.6822739131743, 817.5462618246901, 810.278851821879, 814.3485211830541, 814.861473549498, 815.604431850552, 815.6778072661295, 867.280157469299, 868.5309932636369, 868.9956550217272, 869.1048220333067, 869.9913000869974, 689.9586024838526, 707.2997732245092, 709.4820780830023, 711.7010855440676, 862.4738909265343, 525.7134861500454, 624.7782037376757, 638.9648569328685, 644.3138057968296, 645.5997281685338, 14828.332725027292, 14868.479603213944, 14896.70206595862, 15215.847841521665, 15253.23733813316, 13913.58259252224, 14089.0, 14175.574732758034, 14195.716085678228, 14391.13653180802, 12623.431945562472, 12724.1729287596, 13026.609201723963, 13152.605421837361, 13548.051636385457, 4539.387182730356, 4622.6301895848255, 4633.0, 4642.489326174118, 4717.410323709536, 112138.0, 112499.43750281278, 115596.0, 115871.68256634905, 117546.0, 10724.463776811128, 10852.620158294421, 10938.945305273422, 11002.834957475485, 11326.886731132583, 22420.775792241868, 22788.0, 22872.08511659515, 22873.771262287166, 22917.54164916726, 7611.238876112345, 7644.426667999922, 7648.847023059508, 8006.519608823489, 8009.959950200212, 4310.590493903137, 4310.849120280775, 4372.628326592276, 4502.482214545304, 4518.887027824265, 3392.6268110508317, 3517.472379143149, 3517.8416971236356, 3518.138056176253, 3525.7708248963736, 649.5355820588208, 670.4301343857682, 677.9118714567074, 688.8002479280952, 697.9755708550176, 491.9434265059564, 521.9034478621467, 527.493606138104, 607.875385545962, 627.7865525721277, 8325.583720814057, 9353.672621458216, 9643.517824108767, 9871.25965552572, 9925.404475731479, 555.872149405639, 595.8540157661314, 601.2994860986902, 607.8449995251183, 620.6400287833136, 4563.794629241692, 4798.2802579612635, 4800.35195248644, 4804.135255654016, 4821.951780482221, 100669.49665251627, 102353.48823255836, 163596.0, 172672.0, 178110.0, 141370.2931485336, 142284.0, 143971.0, 145053.19677836375, 151766.0, 88493.11506884849, 106694.0, 107681.0, 114562.99999999833, 126281.0, 9111.31665125105, 10022.34854734469, 10193.694189174337, 10206.336588121749, 10210.0, 64697.67651161714, 65296.7351632426, 66012.3496912581, 67721.66139169273, 69384.65307673429, 96488.0, 99628.50185749025, 101505.0, 102549.48725256325, 104220.0, 12479.0, 12796.61610151697, 12833.230006199285, 13360.331983400985, 13632.93183534076, 14232.715345693236, 14472.782908256175, 14711.516511002661, 15050.0, 15373.38506459729, 11606.535738570701, 13548.119372240773, 13566.118202316818, 13745.587632371045, 13959.302034898417, 13005.739885202433, 13149.934250328688, 13737.587872363845, 13967.720645587235, 14103.576892693236, 12858.871411286142, 13377.398017089059, 13382.732345353234, 13643.795343069663, 14331.355089021228, 9806.492787730485, 10913.781724365626, 11003.449827508432, 11167.274127181707, 11692.590759323382, 11444.828327574927, 11520.827187592025, 11663.941680291544, 11776.0, 11828.34944078084], "value": 7827.193699647656, "unit": "score"}], "name": "dromaeo_css", "value": 7358.280498116689, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 115.0, 115.0, 114.0, 115.0, 115.0, 114.0, 115.0, 115.0, 114.0], "value": 114.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 102.0, 108.0, 132.0, 132.0, 138.0, 136.0, 112.0, 139.0, 116.0], "value": 125.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 182.0, 183.0, 184.0, 199.0, 260.0, 199.0, 183.0, 184.0, 185.0], "value": 194.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 59.0, 59.0, 89.0, 73.0, 49.0, 70.0, 73.0, 99.0, 81.0], "value": 73.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 70.0, 95.0, 70.0, 68.0, 69.0, 93.0, 68.0, 68.0, 90.0], "value": 77.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 88.0, 91.0, 88.0, 90.0, 88.0, 93.0, 130.0, 90.0, 88.0], "value": 93.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 96.0, 96.0, 95.0, 95.0], "value": 95.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 86.0, 96.0, 135.0, 142.0, 83.0, 84.0, 86.0, 86.0], "value": 96.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 53.0, 53.0, 52.0, 54.0, 57.0, 56.0, 57.0, 57.0, 56.0], "value": 55.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 72.0, 69.0, 76.0, 73.0, 70.0, 68.0, 68.0, 69.0, 70.0], "value": 69.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 86.0, 81.0, 85.0, 87.0, 86.0, 82.0, 82.0, 90.0, 84.0], "value": 84.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 146.0, 155.0, 146.0, 127.0, 151.0, 154.0, 157.0, 172.0, 140.0], "value": 150.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 166.0, 165.0, 165.0, 166.0, 165.0, 165.0, 165.0, 166.0, 164.0], "value": 165.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 67.0, 66.0, 67.0, 67.0, 67.0, 67.0, 65.0, 65.0], "value": 66.5, "unit": "score"}], "name": "kraken", "value": 1463.2, "alertThreshold": 2.0}]} 10:14:51 INFO - Return code: 0 10:14:51 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:14:51 INFO - # TBPL SUCCESS # 10:14:51 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:14:51 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:14:51 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:14:51 INFO - 2016-10-28 10:14:51.798 screenresolution[1664:10230] starting screenresolution argv=screenresolution get 10:14:51 INFO - 2016-10-28 10:14:51.800 screenresolution[1664:10230] Display 0: 1600x1200x32@60 10:14:51 INFO - 2016-10-28 10:14:51.806 screenresolution[1665:10234] starting screenresolution argv=screenresolution list 10:14:51 INFO - Available Modes on Display 0 10:14:51 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:14:51 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:14:51 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:14:51 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:14:52 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:14:52 INFO - Intel Iris: 10:14:52 INFO - Chipset Model: Intel Iris 10:14:52 INFO - Type: GPU 10:14:52 INFO - Bus: Built-In 10:14:52 INFO - VRAM (Dynamic, Max): 1536 MB 10:14:52 INFO - Vendor: Intel (0x8086) 10:14:52 INFO - Device ID: 0x0a2e 10:14:52 INFO - Revision ID: 0x0009 10:14:52 INFO - Displays: 10:14:52 INFO - Display: 10:14:52 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:14:52 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:14:52 INFO - Display Serial Number: 1600x1200 60 10:14:52 INFO - Main Display: Yes 10:14:52 INFO - Mirror: Off 10:14:52 INFO - Online: Yes 10:14:52 INFO - Rotation: Supported 10:14:52 INFO - Return code: 0 10:14:52 INFO - Running post-action listener: _resource_record_post_action 10:14:52 INFO - [mozharness: 2016-10-28 17:14:52.045003Z] Finished run-tests step (success) 10:14:52 INFO - Running post-run listener: _resource_record_post_run 10:14:52 INFO - Total resource usage - Wall time: 1211s; CPU: 53.0%; Read bytes: 38593536; Write bytes: 663953408; Read time: 382; Write time: 1908 10:14:52 INFO - TinderboxPrint: CPU usage
53.4% 10:14:52 INFO - TinderboxPrint: I/O read bytes / time
38,593,536 / 382 10:14:52 INFO - TinderboxPrint: I/O write bytes / time
663,953,408 / 1,908 10:14:52 INFO - TinderboxPrint: CPU idle
2,257.6 (46.6%) 10:14:52 INFO - TinderboxPrint: CPU system
969.0 (20.0%) 10:14:52 INFO - TinderboxPrint: CPU user
1,619.1 (33.4%) 10:14:52 INFO - TinderboxPrint: Swap in / out
401,862,656 / 0 10:14:52 INFO - install - Wall time: 33s; CPU: 54.0%; Read bytes: 354054656; Write bytes: 348387328; Read time: 27481; Write time: 775 10:14:52 INFO - run-tests - Wall time: 1179s; CPU: 53.0%; Read bytes: 37626880; Write bytes: 296564736; Read time: 367; Write time: 1076 10:14:52 INFO - Running post-run listener: _upload_blobber_files 10:14:52 INFO - Blob upload gear active. 10:14:52 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:14:52 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 10:14:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:14:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:14:52 INFO - (blobuploader) - INFO - Open directory for files ... 10:14:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:14:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:14:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:14:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:14:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:14:53 INFO - (blobuploader) - INFO - Done attempting. 10:14:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:14:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:14:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:14:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:14:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:14:54 INFO - (blobuploader) - INFO - Done attempting. 10:14:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:14:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:14:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:14:57 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:14:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:14:57 INFO - (blobuploader) - INFO - Done attempting. 10:14:57 INFO - (blobuploader) - INFO - Iteration through files over. 10:14:57 INFO - Return code: 0 10:14:57 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:14:57 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:14:57 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a526236d8c4e99ae5c0e4de3d6776a6e1a11c3765e7850935666e9a1961a93c2aa50858ef63a0b74dd3706ac6f8a55698eb138fb58266580af5667a77868471f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ad6c37a44c2c915cbef48b88ced009001697628b682a3b63723976c9ae07e689befad2385b2facdde3ec2fb1ef7aa9c374b8f7607414f38c4357dc507b2bd825", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/79ffc402282479128bbf8482be21b6296fd2089121ca5231dc018cc2d0d3ac8a4c0f42c797c45a1ec565c8ad0ca68c9fb9f668116e3c617e8bdce5b646f3e5d7"} 10:14:57 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:14:57 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:14:57 INFO - Contents: 10:14:57 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a526236d8c4e99ae5c0e4de3d6776a6e1a11c3765e7850935666e9a1961a93c2aa50858ef63a0b74dd3706ac6f8a55698eb138fb58266580af5667a77868471f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ad6c37a44c2c915cbef48b88ced009001697628b682a3b63723976c9ae07e689befad2385b2facdde3ec2fb1ef7aa9c374b8f7607414f38c4357dc507b2bd825", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/79ffc402282479128bbf8482be21b6296fd2089121ca5231dc018cc2d0d3ac8a4c0f42c797c45a1ec565c8ad0ca68c9fb9f668116e3c617e8bdce5b646f3e5d7"} 10:14:57 INFO - Running post-run listener: copy_logs_to_upload_dir 10:14:57 INFO - Copying logs to upload dir... 10:14:57 INFO - mkdir: /builds/slave/test/build/upload/logs 10:14:57 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1271.170631 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-10-28 10:14:57.456609) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-28 10:14:57.460398) ========= 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.7A89hmbq5J/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.j4ipFywaKg/Listeners TMPDIR=/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a526236d8c4e99ae5c0e4de3d6776a6e1a11c3765e7850935666e9a1961a93c2aa50858ef63a0b74dd3706ac6f8a55698eb138fb58266580af5667a77868471f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ad6c37a44c2c915cbef48b88ced009001697628b682a3b63723976c9ae07e689befad2385b2facdde3ec2fb1ef7aa9c374b8f7607414f38c4357dc507b2bd825", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/79ffc402282479128bbf8482be21b6296fd2089121ca5231dc018cc2d0d3ac8a4c0f42c797c45a1ec565c8ad0ca68c9fb9f668116e3c617e8bdce5b646f3e5d7"} build_url:https://queue.taskcluster.net/v1/task/IRur0sm6SxKg_kCPoZLeuQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011105 build_url: 'https://queue.taskcluster.net/v1/task/IRur0sm6SxKg_kCPoZLeuQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a526236d8c4e99ae5c0e4de3d6776a6e1a11c3765e7850935666e9a1961a93c2aa50858ef63a0b74dd3706ac6f8a55698eb138fb58266580af5667a77868471f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ad6c37a44c2c915cbef48b88ced009001697628b682a3b63723976c9ae07e689befad2385b2facdde3ec2fb1ef7aa9c374b8f7607414f38c4357dc507b2bd825", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/79ffc402282479128bbf8482be21b6296fd2089121ca5231dc018cc2d0d3ac8a4c0f42c797c45a1ec565c8ad0ca68c9fb9f668116e3c617e8bdce5b646f3e5d7"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-28 10:14:57.493133) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-28 10:14:57.493448) ========= 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.7A89hmbq5J/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.j4ipFywaKg/Listeners TMPDIR=/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/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.005303 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-28 10:14:57.541823) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-28 10:14:57.542140) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-28 10:14:57.542437) ========= ========= Total master_lag: 0.17 =========