builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0239 starttime: 1479904448.63 results: success (0) buildid: 20161123030736 builduid: f3c3e72a72dc4eafb4b498fdcf64c0bc revision: c118a37f4527b8f5dad2a9acfb46973b9017f187 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-23 04:34:08.632598) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-23 04:34:08.633140) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-23 04:34:08.633487) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-23 04:34:08.661057) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-23 04:34:08.661508) ========= 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.v6imJRwm8z/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.EYM9NlmkIj/Listeners TMPDIR=/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-11-23 04:34:08-- 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% 164M=0s 2016-11-23 04:34:08 (164 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.088083 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-23 04:34:08.773876) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-23 04:34:08.774191) ========= 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.v6imJRwm8z/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.EYM9NlmkIj/Listeners TMPDIR=/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/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.026357 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-23 04:34:08.822501) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-23 04:34:08.822905) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev c118a37f4527b8f5dad2a9acfb46973b9017f187 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev c118a37f4527b8f5dad2a9acfb46973b9017f187 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.v6imJRwm8z/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.EYM9NlmkIj/Listeners TMPDIR=/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-11-23 04:34:08,925 truncating revision to first 12 chars 2016-11-23 04:34:08,925 Setting DEBUG logging. 2016-11-23 04:34:08,925 attempt 1/10 2016-11-23 04:34:08,925 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/c118a37f4527?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-23 04:34:09,761 unpacking tar archive at: mozilla-beta-c118a37f4527/testing/mozharness/ program finished with exit code 0 elapsedTime=1.121763 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-23 04:34:09.968117) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-23 04:34:09.971443) ========= script_repo_revision: c118a37f4527b8f5dad2a9acfb46973b9017f187 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-23 04:34:09.971880) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-23 04:34:09.972147) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-23 04:34:10.000917) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2016-11-23 04:34:10.001283) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.v6imJRwm8z/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.EYM9NlmkIj/Listeners TMPDIR=/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/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 04:34:10 INFO - MultiFileLogger online at 20161123 04:34:10 in /builds/slave/test 04:34:10 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 04:34:10 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:34:10 INFO - {'append_to_log': False, 04:34:10 INFO - 'base_work_dir': '/builds/slave/test', 04:34:10 INFO - 'blob_upload_branch': 'Mozilla-Beta', 04:34:10 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:34:10 INFO - 'branch': 'Mozilla-Beta', 04:34:10 INFO - 'buildbot_json_path': 'buildprops.json', 04:34:10 INFO - 'config_files': ('talos/mac_config.py',), 04:34:10 INFO - 'default_actions': ('clobber', 04:34:10 INFO - 'read-buildbot-config', 04:34:10 INFO - 'download-and-extract', 04:34:10 INFO - 'populate-webroot', 04:34:10 INFO - 'create-virtualenv', 04:34:10 INFO - 'install', 04:34:10 INFO - 'run-tests'), 04:34:10 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:34:10 INFO - 'download_minidump_stackwalk': True, 04:34:10 INFO - 'download_symbols': 'ondemand', 04:34:10 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:34:10 INFO - 'tooltool.py': '/tools/tooltool.py', 04:34:10 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:34:10 INFO - '/tools/misc-python/virtualenv.py')}, 04:34:10 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:34:10 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:34:10 INFO - 'installer_path': 'installer.exe', 04:34:10 INFO - 'log_level': 'info', 04:34:10 INFO - 'log_name': 'talos', 04:34:10 INFO - 'log_to_console': True, 04:34:10 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:34:10 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:34:10 INFO - 'opt_config_files': (), 04:34:10 INFO - 'pip_index': False, 04:34:10 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:34:10 INFO - 'cmd': ('bash', 04:34:10 INFO - '-c', 04:34:10 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:34:10 INFO - 'enabled': True, 04:34:10 INFO - 'halt_on_failure': False, 04:34:10 INFO - 'name': 'check_screen_resolution'},), 04:34:10 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:34:10 INFO - 'cmd': ('bash', 04:34:10 INFO - '-c', 04:34:10 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:34:10 INFO - 'enabled': True, 04:34:10 INFO - 'halt_on_failure': False, 04:34:10 INFO - 'name': 'check_screen_resolution'},), 04:34:10 INFO - 'run_cmd_checks_enabled': True, 04:34:10 INFO - 'sps_profile': False, 04:34:10 INFO - 'sps_profile_interval': 0, 04:34:10 INFO - 'suite': 'dromaeojs', 04:34:10 INFO - 'system_bits': '32', 04:34:10 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:34:10 INFO - 'title': 't-yosemite-r7-0239', 04:34:10 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:34:10 INFO - 'use_talos_json': True, 04:34:10 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:34:10 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:34:10 INFO - 'work_dir': 'build'} 04:34:10 INFO - [mozharness: 2016-11-23 12:34:10.197754Z] Running clobber step. 04:34:10 INFO - Running pre-action listener: _resource_record_pre_action 04:34:10 INFO - Running main action method: clobber 04:34:10 INFO - rmtree: /builds/slave/test/build 04:34:10 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:34:12 INFO - Running post-action listener: _resource_record_post_action 04:34:12 INFO - [mozharness: 2016-11-23 12:34:12.332265Z] Finished clobber step (success) 04:34:12 INFO - [mozharness: 2016-11-23 12:34:12.332451Z] Running read-buildbot-config step. 04:34:12 INFO - Running pre-action listener: _resource_record_pre_action 04:34:12 INFO - Running main action method: read_buildbot_config 04:34:12 INFO - Using buildbot properties: 04:34:12 INFO - { 04:34:12 INFO - "project": "", 04:34:12 INFO - "product": "firefox", 04:34:12 INFO - "script_repo_revision": "production", 04:34:12 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 04:34:12 INFO - "repository": "", 04:34:12 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 04:34:12 INFO - "buildid": "20161123030736", 04:34:12 INFO - "pgo_build": "False", 04:34:12 INFO - "basedir": "/builds/slave/test", 04:34:12 INFO - "buildnumber": 0, 04:34:12 INFO - "slavename": "t-yosemite-r7-0239", 04:34:12 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 04:34:12 INFO - "platform": "yosemite_r7", 04:34:12 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 04:34:12 INFO - "branch": "mozilla-beta", 04:34:12 INFO - "repo_path": "releases/mozilla-beta", 04:34:12 INFO - "revision": "c118a37f4527b8f5dad2a9acfb46973b9017f187", 04:34:12 INFO - "stage_platform": "macosx64", 04:34:12 INFO - "builduid": "f3c3e72a72dc4eafb4b498fdcf64c0bc", 04:34:12 INFO - "slavebuilddir": "test" 04:34:12 INFO - } 04:34:12 INFO - Found installer url https://queue.taskcluster.net/v1/task/BqfqjsLyRHaeQstCWBwxnA/artifacts/public/build/firefox-51.0.en-US.mac.dmg. 04:34:12 INFO - Running post-action listener: _resource_record_post_action 04:34:12 INFO - [mozharness: 2016-11-23 12:34:12.338057Z] Finished read-buildbot-config step (success) 04:34:12 INFO - [mozharness: 2016-11-23 12:34:12.338277Z] Running download-and-extract step. 04:34:12 INFO - Running pre-action listener: _resource_record_pre_action 04:34:12 INFO - Running main action method: download_and_extract 04:34:12 INFO - mkdir: /builds/slave/test/build/tests 04:34:12 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')]} 04:34:12 INFO - trying https://queue.taskcluster.net/v1/task/BqfqjsLyRHaeQstCWBwxnA/artifacts/public/build/firefox-51.0.en-US.mac.test_packages.json 04:34:12 INFO - Downloading https://queue.taskcluster.net/v1/task/BqfqjsLyRHaeQstCWBwxnA/artifacts/public/build/firefox-51.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0.en-US.mac.test_packages.json 04:34:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BqfqjsLyRHaeQstCWBwxnA/artifacts/public/build/firefox-51.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0.en-US.mac.test_packages.json'}, attempt #1 04:34:13 INFO - Downloaded 1165 bytes. 04:34:13 INFO - Reading from file /builds/slave/test/build/firefox-51.0.en-US.mac.test_packages.json 04:34:13 INFO - Using the following test package requirements: 04:34:13 INFO - {u'common': [u'firefox-51.0.en-US.mac.common.tests.zip'], 04:34:13 INFO - u'cppunittest': [u'firefox-51.0.en-US.mac.common.tests.zip', 04:34:13 INFO - u'firefox-51.0.en-US.mac.cppunittest.tests.zip'], 04:34:13 INFO - u'gtest': [u'firefox-51.0.en-US.mac.common.tests.zip', 04:34:13 INFO - u'firefox-51.0.en-US.mac.gtest.tests.zip'], 04:34:13 INFO - u'jittest': [u'firefox-51.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 04:34:13 INFO - u'mochitest': [u'firefox-51.0.en-US.mac.common.tests.zip', 04:34:13 INFO - u'firefox-51.0.en-US.mac.mochitest.tests.zip'], 04:34:13 INFO - u'mozbase': [u'firefox-51.0.en-US.mac.common.tests.zip'], 04:34:13 INFO - u'reftest': [u'firefox-51.0.en-US.mac.common.tests.zip', 04:34:13 INFO - u'firefox-51.0.en-US.mac.reftest.tests.zip'], 04:34:13 INFO - u'talos': [u'firefox-51.0.en-US.mac.common.tests.zip', 04:34:13 INFO - u'firefox-51.0.en-US.mac.talos.tests.zip'], 04:34:13 INFO - u'web-platform': [u'firefox-51.0.en-US.mac.common.tests.zip', 04:34:13 INFO - u'firefox-51.0.en-US.mac.web-platform.tests.zip'], 04:34:13 INFO - u'xpcshell': [u'firefox-51.0.en-US.mac.common.tests.zip', 04:34:13 INFO - u'firefox-51.0.en-US.mac.xpcshell.tests.zip']} 04:34:13 INFO - Downloading packages: [u'firefox-51.0.en-US.mac.common.tests.zip'] for test suite category: common 04:34:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BqfqjsLyRHaeQstCWBwxnA/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip 04:34:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BqfqjsLyRHaeQstCWBwxnA/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip'}, attempt #1 04:34:13 INFO - Fetch https://queue.taskcluster.net/v1/task/BqfqjsLyRHaeQstCWBwxnA/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip into memory 04:34:14 INFO - Expected file size: 16231761 04:34:22 INFO - Downloading packages: [u'firefox-51.0.en-US.mac.common.tests.zip', u'firefox-51.0.en-US.mac.talos.tests.zip'] for test suite category: talos 04:34:22 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BqfqjsLyRHaeQstCWBwxnA/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip 04:34:22 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BqfqjsLyRHaeQstCWBwxnA/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip'}, attempt #1 04:34:22 INFO - Fetch https://queue.taskcluster.net/v1/task/BqfqjsLyRHaeQstCWBwxnA/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip into memory 04:34:22 INFO - Expected file size: 16231761 04:34:29 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BqfqjsLyRHaeQstCWBwxnA/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip 04:34:29 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BqfqjsLyRHaeQstCWBwxnA/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip'}, attempt #1 04:34:29 INFO - Fetch https://queue.taskcluster.net/v1/task/BqfqjsLyRHaeQstCWBwxnA/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip into memory 04:34:29 INFO - Expected file size: 14414089 04:34:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:34:30 INFO - trying https://queue.taskcluster.net/v1/task/BqfqjsLyRHaeQstCWBwxnA/artifacts/public/build/firefox-51.0.en-US.mac.dmg 04:34:30 INFO - Downloading https://queue.taskcluster.net/v1/task/BqfqjsLyRHaeQstCWBwxnA/artifacts/public/build/firefox-51.0.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0.en-US.mac.dmg 04:34:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BqfqjsLyRHaeQstCWBwxnA/artifacts/public/build/firefox-51.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0.en-US.mac.dmg'}, attempt #1 04:34:34 INFO - Downloaded 86035275 bytes. 04:34:34 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/BqfqjsLyRHaeQstCWBwxnA/artifacts/public/build/firefox-51.0.en-US.mac.dmg 04:34:34 INFO - mkdir: /builds/slave/test/properties 04:34:34 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:34:34 INFO - Writing to file /builds/slave/test/properties/build_url 04:34:34 INFO - Contents: 04:34:34 INFO - build_url:https://queue.taskcluster.net/v1/task/BqfqjsLyRHaeQstCWBwxnA/artifacts/public/build/firefox-51.0.en-US.mac.dmg 04:34:34 INFO - Running post-action listener: _resource_record_post_action 04:34:34 INFO - Running post-action listener: set_extra_try_arguments 04:34:34 INFO - [mozharness: 2016-11-23 12:34:34.822602Z] Finished download-and-extract step (success) 04:34:34 INFO - [mozharness: 2016-11-23 12:34:34.822736Z] Running populate-webroot step. 04:34:34 INFO - Running pre-action listener: _resource_record_pre_action 04:34:34 INFO - Running main action method: populate_webroot 04:34:34 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:34:34 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:34:34 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:34:34 INFO - '--tppagecycles', 04:34:34 INFO - '7'], 04:34:34 INFO - 'tests': ['tsvgm']}}, 04:34:34 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:34:34 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:34:34 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:34:34 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:34:34 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:34:34 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:34:34 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:34:34 INFO - 'talos_options': ['--disable-e10s'], 04:34:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:34:34 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:34:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:34:34 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:34:34 INFO - 'talos_options': ['--disable-e10s'], 04:34:34 INFO - 'tests': ['damp', 'tps']}, 04:34:34 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:34:34 INFO - 'tests': ['damp', 'tps']}, 04:34:34 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:34:34 INFO - 'tests': ['dromaeo_dom']}, 04:34:34 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:34:34 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:34:34 INFO - 'tests': ['basic_compositor_video']}, 04:34:34 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:34:34 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:34:34 INFO - 'tests': ['a11yr', 04:34:34 INFO - 'ts_paint', 04:34:34 INFO - 'tpaint', 04:34:34 INFO - 'sessionrestore', 04:34:34 INFO - 'sessionrestore_no_auto_restore', 04:34:34 INFO - 'tabpaint']}, 04:34:34 INFO - 'other-e10s': {'tests': ['a11yr', 04:34:34 INFO - 'ts_paint', 04:34:34 INFO - 'tpaint', 04:34:34 INFO - 'sessionrestore', 04:34:34 INFO - 'sessionrestore_no_auto_restore', 04:34:34 INFO - 'tabpaint']}, 04:34:34 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:34:34 INFO - 'ts_paint', 04:34:34 INFO - 'tpaint', 04:34:34 INFO - 'sessionrestore', 04:34:34 INFO - 'sessionrestore_no_auto_restore', 04:34:34 INFO - 'tabpaint']}, 04:34:34 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:34:34 INFO - 'ts_paint', 04:34:34 INFO - 'tpaint', 04:34:34 INFO - 'sessionrestore', 04:34:34 INFO - 'sessionrestore_no_auto_restore', 04:34:34 INFO - 'tabpaint']}, 04:34:34 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:34:34 INFO - 'tests': ['a11yr', 04:34:34 INFO - 'ts_paint', 04:34:34 INFO - 'tpaint', 04:34:34 INFO - 'sessionrestore', 04:34:34 INFO - 'sessionrestore_no_auto_restore', 04:34:34 INFO - 'tabpaint']}, 04:34:34 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:34:34 INFO - 'tests': ['a11yr', 04:34:34 INFO - 'ts_paint', 04:34:34 INFO - 'tpaint', 04:34:34 INFO - 'sessionrestore', 04:34:34 INFO - 'sessionrestore_no_auto_restore', 04:34:34 INFO - 'tabpaint']}, 04:34:34 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:34:34 INFO - 'tests': ['tsvgx', 04:34:34 INFO - 'tsvgr_opacity', 04:34:34 INFO - 'tart', 04:34:34 INFO - 'tscrollx', 04:34:34 INFO - 'cart']}, 04:34:34 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:34:34 INFO - 'tsvgr_opacity', 04:34:34 INFO - 'tart', 04:34:34 INFO - 'tscrollx', 04:34:34 INFO - 'cart']}, 04:34:34 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:34:34 INFO - 'talos_options': ['--disable-e10s'], 04:34:34 INFO - 'tests': ['tp5o']}, 04:34:34 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:34:34 INFO - 'tests': ['tp5o']}, 04:34:34 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:34:34 INFO - 'talos_options': ['--disable-e10s', 04:34:34 INFO - '--xperf_path', 04:34:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:34:34 INFO - 'tests': ['tp5n']}, 04:34:34 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:34:34 INFO - 'talos_options': ['--xperf_path', 04:34:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:34:34 INFO - 'tests': ['tp5n']}}, 04:34:34 INFO - 'talos.zip': {'path': '', 04:34:34 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:34:34 INFO - Running post-action listener: _resource_record_post_action 04:34:34 INFO - [mozharness: 2016-11-23 12:34:34.841128Z] Finished populate-webroot step (success) 04:34:34 INFO - [mozharness: 2016-11-23 12:34:34.841265Z] Running create-virtualenv step. 04:34:34 INFO - Running pre-action listener: _resource_record_pre_action 04:34:34 INFO - Running main action method: create_virtualenv 04:34:34 INFO - Creating virtualenv /builds/slave/test/build/venv 04:34:34 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 04:34:34 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:34:34 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:34:34 INFO - Using real prefix '/tools/python27' 04:34:34 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:34:35 INFO - Installing distribute.............................................................................................................................................................................................done. 04:34:38 INFO - Installing pip.................done. 04:34:38 INFO - Return code: 0 04:34:38 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:34:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:34:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:34:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:34:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:34:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104ae6490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104a5c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa4995ad140>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1048fad30>, '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 0x104760db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1048f2b20>, '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.v6imJRwm8z/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.EYM9NlmkIj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/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 04:34:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:34:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:34:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.v6imJRwm8z/Render', 04:34:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:34:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:34:38 INFO - 'HOME': '/Users/cltbld', 04:34:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:34:38 INFO - 'LOGNAME': 'cltbld', 04:34:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:34:38 INFO - 'MOZ_NO_REMOTE': '1', 04:34:38 INFO - 'NO_EM_RESTART': '1', 04:34:38 INFO - 'PAGER': '/bin/cat', 04:34:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:34:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:34:38 INFO - 'PWD': '/builds/slave/test', 04:34:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:34:38 INFO - 'SHELL': '/bin/bash', 04:34:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EYM9NlmkIj/Listeners', 04:34:38 INFO - 'TMPDIR': '/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/', 04:34:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:34:38 INFO - 'USER': 'cltbld', 04:34:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:34:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:34:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:34:38 INFO - 'XPC_FLAGS': '0x0', 04:34:38 INFO - 'XPC_SERVICE_NAME': '0', 04:34:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:34:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:34:38 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 04:34:38 INFO - Cleaning up... 04:34:38 INFO - Return code: 0 04:34:38 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:34:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:34:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:34:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:34:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:34:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x104ae6490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104a5c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa4995ad140>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1048fad30>, '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 0x104760db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1048f2b20>, '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.v6imJRwm8z/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.EYM9NlmkIj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/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 04:34:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 04:34:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 04:34:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.v6imJRwm8z/Render', 04:34:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:34:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:34:38 INFO - 'HOME': '/Users/cltbld', 04:34:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:34:38 INFO - 'LOGNAME': 'cltbld', 04:34:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:34:38 INFO - 'MOZ_NO_REMOTE': '1', 04:34:38 INFO - 'NO_EM_RESTART': '1', 04:34:38 INFO - 'PAGER': '/bin/cat', 04:34:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:34:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:34:38 INFO - 'PWD': '/builds/slave/test', 04:34:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:34:38 INFO - 'SHELL': '/bin/bash', 04:34:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EYM9NlmkIj/Listeners', 04:34:38 INFO - 'TMPDIR': '/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/', 04:34:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:34:38 INFO - 'USER': 'cltbld', 04:34:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:34:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:34:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:34:38 INFO - 'XPC_FLAGS': '0x0', 04:34:38 INFO - 'XPC_SERVICE_NAME': '0', 04:34:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:34:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:34:39 INFO - Downloading/unpacking psutil>=3.1.1 04:34:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:34:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:34:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:34:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:34:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:34:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:34:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:34:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:34:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:34:42 INFO - Installing collected packages: psutil 04:34:42 INFO - Running setup.py install for psutil 04:34:42 INFO - building 'psutil._psutil_osx' extension 04:34:42 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 04:34:42 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 04:34:42 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 04:34:42 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 04:34:42 INFO - building 'psutil._psutil_posix' extension 04:34:42 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 04:34:42 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:34:42 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:34:42 INFO - ^ 04:34:43 INFO - 1 warning generated. 04:34:43 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 04:34:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:34:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:34:43 INFO - Successfully installed psutil 04:34:43 INFO - Cleaning up... 04:34:43 INFO - Return code: 0 04:34:43 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:34:43 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')]} 04:34:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:34:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:43 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')]} 04:34:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:34:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:43 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 0x104ae6490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104a5c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa4995ad140>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1048fad30>, '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 0x104760db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1048f2b20>, '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.v6imJRwm8z/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.EYM9NlmkIj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/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 04:34:43 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 04:34:43 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 04:34:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.v6imJRwm8z/Render', 04:34:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:34:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:34:43 INFO - 'HOME': '/Users/cltbld', 04:34:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:34:43 INFO - 'LOGNAME': 'cltbld', 04:34:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:34:43 INFO - 'MOZ_NO_REMOTE': '1', 04:34:43 INFO - 'NO_EM_RESTART': '1', 04:34:43 INFO - 'PAGER': '/bin/cat', 04:34:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:34:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:34:43 INFO - 'PWD': '/builds/slave/test', 04:34:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:34:43 INFO - 'SHELL': '/bin/bash', 04:34:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EYM9NlmkIj/Listeners', 04:34:43 INFO - 'TMPDIR': '/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/', 04:34:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:34:43 INFO - 'USER': 'cltbld', 04:34:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:34:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:34:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:34:43 INFO - 'XPC_FLAGS': '0x0', 04:34:43 INFO - 'XPC_SERVICE_NAME': '0', 04:34:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:34:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:34:43 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:34:43 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 04:34:43 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 04:34:43 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 04:34:43 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 04:34:43 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 04:34:43 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 04:34:45 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:34:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:34:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:34:46 INFO - Installing collected packages: mozsystemmonitor 04:34:46 INFO - Running setup.py install for mozsystemmonitor 04:34:46 INFO - Successfully installed mozsystemmonitor 04:34:46 INFO - Cleaning up... 04:34:46 INFO - Return code: 0 04:34:46 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:34:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:34:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:34:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:34:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:34:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:46 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 0x104ae6490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104a5c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa4995ad140>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1048fad30>, '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 0x104760db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1048f2b20>, '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.v6imJRwm8z/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.EYM9NlmkIj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/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 04:34:46 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 04:34:46 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 04:34:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.v6imJRwm8z/Render', 04:34:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:34:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:34:46 INFO - 'HOME': '/Users/cltbld', 04:34:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:34:46 INFO - 'LOGNAME': 'cltbld', 04:34:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:34:46 INFO - 'MOZ_NO_REMOTE': '1', 04:34:46 INFO - 'NO_EM_RESTART': '1', 04:34:46 INFO - 'PAGER': '/bin/cat', 04:34:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:34:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:34:46 INFO - 'PWD': '/builds/slave/test', 04:34:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:34:46 INFO - 'SHELL': '/bin/bash', 04:34:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EYM9NlmkIj/Listeners', 04:34:46 INFO - 'TMPDIR': '/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/', 04:34:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:34:46 INFO - 'USER': 'cltbld', 04:34:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:34:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:34:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:34:46 INFO - 'XPC_FLAGS': '0x0', 04:34:46 INFO - 'XPC_SERVICE_NAME': '0', 04:34:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:34:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:34:46 INFO - Downloading/unpacking jsonschema==2.5.1 04:34:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:34:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:34:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:34:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:34:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:34:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:34:48 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:34:48 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:34:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:34:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:34:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:34:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:34:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:34:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:34:49 INFO - Downloading functools32-3.2.3-2.tar.gz 04:34:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:34:49 INFO - warning: no files found matching '*.txt' 04:34:49 INFO - no previously-included directories found matching 'build' 04:34:49 INFO - no previously-included directories found matching 'dist' 04:34:49 INFO - no previously-included directories found matching '.git*' 04:34:49 INFO - Installing collected packages: jsonschema, functools32 04:34:49 INFO - Running setup.py install for functools32 04:34:49 INFO - warning: no files found matching '*.txt' 04:34:49 INFO - no previously-included directories found matching 'build' 04:34:49 INFO - no previously-included directories found matching 'dist' 04:34:49 INFO - no previously-included directories found matching '.git*' 04:34:49 INFO - Successfully installed jsonschema functools32 04:34:49 INFO - Cleaning up... 04:34:49 INFO - Return code: 0 04:34:49 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:34:49 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')]} 04:34:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:34:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:49 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')]} 04:34:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:34:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:49 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 0x104ae6490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104a5c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa4995ad140>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1048fad30>, '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 0x104760db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1048f2b20>, '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.v6imJRwm8z/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.EYM9NlmkIj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/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 04:34:49 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 04:34:49 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 04:34:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.v6imJRwm8z/Render', 04:34:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:34:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:34:49 INFO - 'HOME': '/Users/cltbld', 04:34:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:34:49 INFO - 'LOGNAME': 'cltbld', 04:34:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:34:49 INFO - 'MOZ_NO_REMOTE': '1', 04:34:49 INFO - 'NO_EM_RESTART': '1', 04:34:49 INFO - 'PAGER': '/bin/cat', 04:34:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:34:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:34:49 INFO - 'PWD': '/builds/slave/test', 04:34:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:34:49 INFO - 'SHELL': '/bin/bash', 04:34:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EYM9NlmkIj/Listeners', 04:34:49 INFO - 'TMPDIR': '/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/', 04:34:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:34:49 INFO - 'USER': 'cltbld', 04:34:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:34:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:34:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:34:49 INFO - 'XPC_FLAGS': '0x0', 04:34:49 INFO - 'XPC_SERVICE_NAME': '0', 04:34:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:34:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:34:50 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:34:50 INFO - Cleaning up... 04:34:50 INFO - Return code: 0 04:34:50 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:34:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:34:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:34:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:34:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:34:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:50 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 0x104ae6490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104a5c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa4995ad140>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1048fad30>, '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 0x104760db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1048f2b20>, '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.v6imJRwm8z/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.EYM9NlmkIj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/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 04:34:50 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 04:34:50 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 04:34:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.v6imJRwm8z/Render', 04:34:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:34:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:34:50 INFO - 'HOME': '/Users/cltbld', 04:34:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:34:50 INFO - 'LOGNAME': 'cltbld', 04:34:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:34:50 INFO - 'MOZ_NO_REMOTE': '1', 04:34:50 INFO - 'NO_EM_RESTART': '1', 04:34:50 INFO - 'PAGER': '/bin/cat', 04:34:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:34:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:34:50 INFO - 'PWD': '/builds/slave/test', 04:34:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:34:50 INFO - 'SHELL': '/bin/bash', 04:34:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EYM9NlmkIj/Listeners', 04:34:50 INFO - 'TMPDIR': '/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/', 04:34:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:34:50 INFO - 'USER': 'cltbld', 04:34:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:34:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:34:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:34:50 INFO - 'XPC_FLAGS': '0x0', 04:34:50 INFO - 'XPC_SERVICE_NAME': '0', 04:34:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:34:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:34:50 INFO - Downloading/unpacking blobuploader==1.2.4 04:34:50 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 04:34:50 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 04:34:50 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 04:34:50 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 04:34:50 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 04:34:50 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 04:34:52 INFO - Downloading blobuploader-1.2.4.tar.gz 04:34:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:34:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:34:52 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 04:34:52 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 04:34:52 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 04:34:52 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 04:34:52 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 04:34:52 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 04:34:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:34:53 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:34:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:34:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:34:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:34:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:34:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:34:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:34:53 INFO - Downloading docopt-0.6.1.tar.gz 04:34:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:34:54 INFO - Installing collected packages: blobuploader, requests, docopt 04:34:54 INFO - Running setup.py install for blobuploader 04:34:54 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:34:54 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:34:54 INFO - Running setup.py install for requests 04:34:54 INFO - Running setup.py install for docopt 04:34:54 INFO - Successfully installed blobuploader requests docopt 04:34:54 INFO - Cleaning up... 04:34:54 INFO - Return code: 0 04:34:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:34:54 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')]} 04:34:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:34:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:54 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')]} 04:34:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:34:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:54 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 0x104ae6490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104a5c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa4995ad140>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1048fad30>, '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 0x104760db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1048f2b20>, '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.v6imJRwm8z/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.EYM9NlmkIj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/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 04:34:54 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 04:34:54 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 04:34:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.v6imJRwm8z/Render', 04:34:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:34:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:34:54 INFO - 'HOME': '/Users/cltbld', 04:34:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:34:54 INFO - 'LOGNAME': 'cltbld', 04:34:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:34:54 INFO - 'MOZ_NO_REMOTE': '1', 04:34:54 INFO - 'NO_EM_RESTART': '1', 04:34:54 INFO - 'PAGER': '/bin/cat', 04:34:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:34:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:34:54 INFO - 'PWD': '/builds/slave/test', 04:34:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:34:54 INFO - 'SHELL': '/bin/bash', 04:34:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EYM9NlmkIj/Listeners', 04:34:54 INFO - 'TMPDIR': '/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/', 04:34:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:34:54 INFO - 'USER': 'cltbld', 04:34:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:34:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:34:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:34:54 INFO - 'XPC_FLAGS': '0x0', 04:34:54 INFO - 'XPC_SERVICE_NAME': '0', 04:34:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:34:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:34:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:34:55 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-R5WeSG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:34:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:34:55 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-XQ9vqR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:34:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:34:55 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-keTW6p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:34:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:34:55 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-tMcHbg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:34:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:34:55 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-RDosZ0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:34:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:34:55 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-6honBc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:34:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:34:55 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-PibokO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:34:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:34:55 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-19atgm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:34:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:34:56 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-Xu8QXE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:34:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:34:56 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-nhXJ3N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:34:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:34:56 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-wD66ux-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:34:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:34:56 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-fICzKW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:34:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:34:56 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-QDp7k2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:34:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:34:56 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-9q_Lkt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:34:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:34:56 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-8zfmSp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:34:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:34:56 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-23vNWk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:34:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:34:56 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-bN2Vl4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:34:56 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:34:56 INFO - Running setup.py install for manifestparser 04:34:57 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:34:57 INFO - Running setup.py install for mozcrash 04:34:57 INFO - Running setup.py install for mozdebug 04:34:57 INFO - Running setup.py install for mozdevice 04:34:57 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:34:57 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:34:57 INFO - Running setup.py install for mozfile 04:34:57 INFO - Running setup.py install for mozhttpd 04:34:57 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:34:57 INFO - Running setup.py install for mozinfo 04:34:57 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:34:58 INFO - Running setup.py install for mozInstall 04:34:58 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:34:58 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:34:58 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:34:58 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:34:58 INFO - Running setup.py install for mozleak 04:34:58 INFO - Running setup.py install for mozlog 04:34:58 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:34:58 INFO - Running setup.py install for moznetwork 04:34:58 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:34:58 INFO - Running setup.py install for mozprocess 04:34:58 INFO - Running setup.py install for mozprofile 04:34:58 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:34:58 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:34:58 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:34:58 INFO - Running setup.py install for mozrunner 04:34:59 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:34:59 INFO - Running setup.py install for mozscreenshot 04:34:59 INFO - Running setup.py install for moztest 04:34:59 INFO - Running setup.py install for mozversion 04:34:59 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:34:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:34:59 INFO - Cleaning up... 04:34:59 INFO - Return code: 0 04:34:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:34:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:34:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:34:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:34:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:34:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:59 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 0x104ae6490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104a5c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa4995ad140>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1048fad30>, '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 0x104760db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1048f2b20>, '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.v6imJRwm8z/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.EYM9NlmkIj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/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 04:34:59 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 04:34:59 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 04:34:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.v6imJRwm8z/Render', 04:34:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:34:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:34:59 INFO - 'HOME': '/Users/cltbld', 04:34:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:34:59 INFO - 'LOGNAME': 'cltbld', 04:34:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:34:59 INFO - 'MOZ_NO_REMOTE': '1', 04:34:59 INFO - 'NO_EM_RESTART': '1', 04:34:59 INFO - 'PAGER': '/bin/cat', 04:34:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:34:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:34:59 INFO - 'PWD': '/builds/slave/test', 04:34:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:34:59 INFO - 'SHELL': '/bin/bash', 04:34:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EYM9NlmkIj/Listeners', 04:34:59 INFO - 'TMPDIR': '/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/', 04:34:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:34:59 INFO - 'USER': 'cltbld', 04:34:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:34:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:34:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:34:59 INFO - 'XPC_FLAGS': '0x0', 04:34:59 INFO - 'XPC_SERVICE_NAME': '0', 04:34:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:34:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:34:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:34:59 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-ODIb3D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:34:59 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)) 04:34:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:34:59 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-0PhvUR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:35:00 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)) 04:35:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:35:00 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-1jQ0yt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:35:00 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)) 04:35:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:35:00 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-EqgDNQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:35:00 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)) 04:35:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:35:00 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-H7kEu_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:35:00 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)) 04:35:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:35:00 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-sMkJhS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:35:00 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)) 04:35:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:35:00 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-zJsC4H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:35:00 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)) 04:35:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:35:00 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-sNje5k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:35:00 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)) 04:35:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:35:00 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-ZoaAzE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:35:00 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)) 04:35:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:35:00 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-uKcNvn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:35:00 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)) 04:35:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:35:00 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-omE2Mk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:35:00 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)) 04:35:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:35:01 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-TN7A_4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:35:01 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)) 04:35:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:35:01 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-NQmF2o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:35:01 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)) 04:35:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:35:01 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-IiCyZ_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:35:01 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)) 04:35:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:35:01 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-56ggpf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:35:01 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)) 04:35:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:35:01 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-OnqFnO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:35:01 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)) 04:35:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:35:01 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-bzJCB4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:35:01 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)) 04:35:01 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)) 04:35:01 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)) 04:35:01 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)) 04:35:01 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)) 04:35:01 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)) 04:35:01 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:35:01 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 04:35:01 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 04:35:01 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 04:35:01 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 04:35:01 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 04:35:01 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 04:35:04 INFO - Downloading blessings-1.6.tar.gz 04:35:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:35:04 INFO - Installing collected packages: blessings 04:35:04 INFO - Running setup.py install for blessings 04:35:04 INFO - Successfully installed blessings 04:35:04 INFO - Cleaning up... 04:35:04 INFO - Return code: 0 04:35:04 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:35:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:35:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:35:04 INFO - Reading from file tmpfile_stdout 04:35:04 INFO - Current package versions: 04:35:04 INFO - blessings == 1.6 04:35:04 INFO - blobuploader == 1.2.4 04:35:04 INFO - docopt == 0.6.1 04:35:04 INFO - functools32 == 3.2.3-2 04:35:04 INFO - jsonschema == 2.5.1 04:35:04 INFO - manifestparser == 1.1 04:35:04 INFO - mozInstall == 1.12 04:35:04 INFO - mozcrash == 0.17 04:35:04 INFO - mozdebug == 0.1 04:35:04 INFO - mozdevice == 0.48 04:35:04 INFO - mozfile == 1.2 04:35:04 INFO - mozhttpd == 0.7 04:35:04 INFO - mozinfo == 0.9 04:35:04 INFO - mozleak == 0.1 04:35:04 INFO - mozlog == 3.4 04:35:04 INFO - moznetwork == 0.27 04:35:04 INFO - mozprocess == 0.23 04:35:04 INFO - mozprofile == 0.28 04:35:04 INFO - mozrunner == 6.12 04:35:04 INFO - mozscreenshot == 0.1 04:35:04 INFO - mozsystemmonitor == 0.3 04:35:04 INFO - moztest == 0.7 04:35:04 INFO - mozversion == 1.4 04:35:04 INFO - psutil == 3.1.1 04:35:04 INFO - requests == 1.2.3 04:35:04 INFO - wsgiref == 0.1.2 04:35:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:35:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:35:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:35:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:35:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:35:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:35:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:35:04 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 0x104ae6490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104a5c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa4995ad140>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1048fad30>, '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 0x104760db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1048f2b20>, '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.v6imJRwm8z/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.EYM9NlmkIj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/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 04:35:04 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 04:35:04 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 04:35:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.v6imJRwm8z/Render', 04:35:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:35:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:35:04 INFO - 'HOME': '/Users/cltbld', 04:35:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:35:04 INFO - 'LOGNAME': 'cltbld', 04:35:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:35:04 INFO - 'MOZ_NO_REMOTE': '1', 04:35:04 INFO - 'NO_EM_RESTART': '1', 04:35:04 INFO - 'PAGER': '/bin/cat', 04:35:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:35:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:35:04 INFO - 'PWD': '/builds/slave/test', 04:35:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:35:04 INFO - 'SHELL': '/bin/bash', 04:35:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EYM9NlmkIj/Listeners', 04:35:04 INFO - 'TMPDIR': '/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/', 04:35:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:35:04 INFO - 'USER': 'cltbld', 04:35:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:35:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:35:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:35:04 INFO - 'XPC_FLAGS': '0x0', 04:35:04 INFO - 'XPC_SERVICE_NAME': '0', 04:35:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:35:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:35:05 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)) 04:35:05 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)) 04:35:05 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)) 04:35:05 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)) 04:35:05 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)) 04:35:05 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)) 04:35:05 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)) 04:35:05 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)) 04:35:05 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)) 04:35:05 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)) 04:35:05 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)) 04:35:05 INFO - Cleaning up... 04:35:05 INFO - Return code: 0 04:35:05 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:35: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')]} 04:35:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:35:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:35: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')]} 04:35:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:35:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:35:05 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 0x104ae6490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104a5c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa4995ad140>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1048fad30>, '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 0x104760db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1048f2b20>, '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.v6imJRwm8z/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.EYM9NlmkIj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/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 04:35:05 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 04:35:05 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 04:35:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.v6imJRwm8z/Render', 04:35:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:35:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:35:05 INFO - 'HOME': '/Users/cltbld', 04:35:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:35:05 INFO - 'LOGNAME': 'cltbld', 04:35:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:35:05 INFO - 'MOZ_NO_REMOTE': '1', 04:35:05 INFO - 'NO_EM_RESTART': '1', 04:35:05 INFO - 'PAGER': '/bin/cat', 04:35:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:35:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:35:05 INFO - 'PWD': '/builds/slave/test', 04:35:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:35:05 INFO - 'SHELL': '/bin/bash', 04:35:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EYM9NlmkIj/Listeners', 04:35:05 INFO - 'TMPDIR': '/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/', 04:35:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:35:05 INFO - 'USER': 'cltbld', 04:35:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:35:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:35:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:35:05 INFO - 'XPC_FLAGS': '0x0', 04:35:05 INFO - 'XPC_SERVICE_NAME': '0', 04:35:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:35:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:35:05 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:35:05 INFO - Cleaning up... 04:35:05 INFO - Return code: 0 04:35:05 INFO - Running post-action listener: _resource_record_post_action 04:35:05 INFO - Running post-action listener: _start_resource_monitoring 04:35:05 INFO - Starting resource monitoring. 04:35:05 INFO - [mozharness: 2016-11-23 12:35:05.321336Z] Finished create-virtualenv step (success) 04:35:05 INFO - [mozharness: 2016-11-23 12:35:05.322263Z] Running install step. 04:35:05 INFO - Running pre-action listener: _resource_record_pre_action 04:35:05 INFO - Running main action method: install 04:35:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:35:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:35:05 INFO - Reading from file tmpfile_stdout 04:35:05 INFO - Detecting whether we're running mozinstall >=1.0... 04:35:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:35:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:35:05 INFO - Reading from file tmpfile_stdout 04:35:05 INFO - Output received: 04:35:05 INFO - Usage: mozinstall [options] installer 04:35:05 INFO - Options: 04:35:05 INFO - -h, --help show this help message and exit 04:35:05 INFO - -d DEST, --destination=DEST 04:35:05 INFO - Directory to install application into. [default: 04:35:05 INFO - "/builds/slave/test"] 04:35:05 INFO - --app=APP Application being installed. [default: firefox] 04:35:05 INFO - mkdir: /builds/slave/test/build/application 04:35:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 04:35:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0.en-US.mac.dmg --destination /builds/slave/test/build/application 04:35:27 INFO - Reading from file tmpfile_stdout 04:35:27 INFO - Output received: 04:35:27 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 04:35:27 INFO - Running post-action listener: _resource_record_post_action 04:35:27 INFO - [mozharness: 2016-11-23 12:35:27.352916Z] Finished install step (success) 04:35:27 INFO - [mozharness: 2016-11-23 12:35:27.353045Z] Running run-tests step. 04:35:27 INFO - Running pre-action listener: _resource_record_pre_action 04:35:27 INFO - Running main action method: run_tests 04:35:27 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:35:27 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:35:27 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:35:27 INFO - 2016-11-23 04:35:27.367 screenresolution[1645:7341] starting screenresolution argv=screenresolution get 04:35:27 INFO - 2016-11-23 04:35:27.369 screenresolution[1645:7341] Display 0: 1600x1200x32@60 04:35:27 INFO - 2016-11-23 04:35:27.375 screenresolution[1646:7343] starting screenresolution argv=screenresolution list 04:35:27 INFO - Available Modes on Display 0 04:35:27 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:35:27 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:35:27 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:35:27 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:35:27 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:35:27 INFO - Intel Iris: 04:35:27 INFO - Chipset Model: Intel Iris 04:35:27 INFO - Type: GPU 04:35:27 INFO - Bus: Built-In 04:35:27 INFO - VRAM (Dynamic, Max): 1536 MB 04:35:27 INFO - Vendor: Intel (0x8086) 04:35:27 INFO - Device ID: 0x0a2e 04:35:27 INFO - Revision ID: 0x0009 04:35:27 INFO - Displays: 04:35:27 INFO - Display: 04:35:27 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:35:27 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:35:27 INFO - Display Serial Number: 1600x1200 60 04:35:27 INFO - Main Display: Yes 04:35:27 INFO - Mirror: Off 04:35:27 INFO - Online: Yes 04:35:27 INFO - Rotation: Supported 04:35:27 INFO - Return code: 0 04:35:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:35:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:35:27 INFO - Python 2.7.3 04:35:27 INFO - Return code: 0 04:35:27 INFO - grabbing minidump binary from tooltool 04:35:27 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')]} 04:35:27 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 0x1048fad30>, '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 0x104760db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1048f2b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:35:27 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 04:35:27 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 04:35:27 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 04:35:27 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:35:27 INFO - Return code: 0 04:35:27 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:35:27 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:35:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:35:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:35:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:35:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BqfqjsLyRHaeQstCWBwxnA/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0239', '--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 04:35:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/BqfqjsLyRHaeQstCWBwxnA/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0239 --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 04:35:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.v6imJRwm8z/Render', 04:35:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:35:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:35:27 INFO - 'HOME': '/Users/cltbld', 04:35:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:35:27 INFO - 'LOGNAME': 'cltbld', 04:35:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:35:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:35:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:35:27 INFO - 'MOZ_NO_REMOTE': '1', 04:35:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:35:27 INFO - 'NO_EM_RESTART': '1', 04:35:27 INFO - 'PAGER': '/bin/cat', 04:35:27 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:35:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:35:27 INFO - 'PWD': '/builds/slave/test', 04:35:27 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:35:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:35:27 INFO - 'SHELL': '/bin/bash', 04:35:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EYM9NlmkIj/Listeners', 04:35:27 INFO - 'TMPDIR': '/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/', 04:35:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:35:27 INFO - 'USER': 'cltbld', 04:35:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:35:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:35:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:35:27 INFO - 'XPC_FLAGS': '0x0', 04:35:27 INFO - 'XPC_SERVICE_NAME': '0', 04:35:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:35:27 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BqfqjsLyRHaeQstCWBwxnA/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0239', '--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 04:35:27 INFO - mozversion application_buildid: 20161123030736 04:35:27 INFO - mozversion application_changeset: c118a37f4527b8f5dad2a9acfb46973b9017f187 04:35:27 INFO - mozversion application_display_name: Firefox 04:35:27 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:35:27 INFO - mozversion application_name: Firefox 04:35:27 INFO - mozversion application_remotingname: firefox 04:35:27 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 04:35:27 INFO - mozversion application_vendor: Mozilla 04:35:27 INFO - mozversion application_version: 51.0 04:35:27 INFO - mozversion platform_buildid: 20161123030736 04:35:27 INFO - mozversion platform_changeset: c118a37f4527b8f5dad2a9acfb46973b9017f187 04:35:27 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 04:35:27 INFO - mozversion platform_version: 51.0 04:35:27 INFO - using testdate: 1479904527 04:35:27 INFO - actual date: 1479904527 04:35:27 INFO - starting webserver on 'localhost:49243' 04:35:27 INFO - SUITE-START | Running 2 tests 04:35:27 INFO - TEST-START | dromaeo_css 04:35:27 INFO - operating with platform_type : mac_ 04:35:27 INFO - Initialising browser for dromaeo_css test... 04:35:28 INFO - TEST-INFO | started process 1656 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/tmpaIOVIr/profile http://localhost:49243/getInfo.html) 04:35:30 INFO - PROCESS | 1656 | __metrics Screen width/height:1600/1200 04:35:30 INFO - PROCESS | 1656 | colorDepth:24 04:35:30 INFO - PROCESS | 1656 | Browser inner width/height: 1024/689 04:35:30 INFO - PROCESS | 1656 | __metrics 04:35:30 INFO - PROCESS | 1656 | 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" 04:35:30 INFO - PROCESS | 1656 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:35:31 INFO - TEST-INFO | 1656: exit 0 04:35:31 INFO - Browser initialized. 04:35:31 INFO - Running cycle 1/1 for dromaeo_css test... 04:35:31 INFO - TEST-INFO | started process 1660 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/tmpaIOVIr/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:35:43 INFO - PROCESS | 1660 | RSS: Main: 168722432 04:35:43 INFO - PROCESS | 1660 | 04:36:34 INFO - PROCESS | 1660 | 1479904594782 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] 04:38:44 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49243/tests/dromaeo/cssquery-ext.html) 04:38:46 INFO - PROCESS | 1660 | RSS: Main: 320724992 04:38:46 INFO - PROCESS | 1660 | 04:41:49 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-ext.html (next: http://localhost:49243/tests/dromaeo/cssquery-jquery.html) 04:41:49 INFO - PROCESS | 1660 | RSS: Main: 302891008 04:41:49 INFO - PROCESS | 1660 | 04:44:51 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49243/tests/dromaeo/cssquery-mootools.html) 04:44:52 INFO - PROCESS | 1660 | RSS: Main: 299388928 04:44:52 INFO - PROCESS | 1660 | 04:47:54 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49243/tests/dromaeo/cssquery-prototype.html) 04:47:55 INFO - PROCESS | 1660 | RSS: Main: 270622720 04:47:55 INFO - PROCESS | 1660 | 04:50:58 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49243/tests/dromaeo/cssquery-yui.html) 04:50:59 INFO - PROCESS | 1660 | RSS: Main: 262279168 04:50:59 INFO - PROCESS | 1660 | 04:54:01 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-yui.html (next: http://localhost:49243/tests/dromaeo/cssquery-dojo.html) 04:54:02 INFO - PROCESS | 1660 | RSS: Main: 347459584 04:54:02 INFO - PROCESS | 1660 | 04:54:02 INFO - PROCESS | 1660 | __start_tp_report 04:54:02 INFO - PROCESS | 1660 | _x_x_mozilla_page_load 04:54:02 INFO - PROCESS | 1660 | _x_x_mozilla_page_load_details 04:54:02 INFO - PROCESS | 1660 | |i|pagename|runs| 04:54:02 INFO - PROCESS | 1660 | |0;dojo.html;3475.8957231283052;3487.232808782068;3502.176988407722;3533.73496987726;3572.8213589320526;4888.8288909888115;5813.186153938446;5876.177335173079;5926.674032928187;5957.553183511238;5871.76512939483;5897.911531327033;5924.822255332336;5953.493953013999;5958.49352805011;5259.737013149356;5282.894342113174;5363.839084827461;5364.839054828341;5365.114756065244;4261.701680882339;4872.683275587093;5212.400573933989;5213.973930130344;5369.704666243355;5249.081410753122;5277.947220527784;5286.154215325549;5304.124819404813;5312.73436328184;5290.867728306785;5317.308749862532;5332.066888294572;5388.191771234347;5392.352917649868;5248.265242866002;5305.734713264322;5314.654547454403;5326.360836699582;5341.519263266286;5697.373288938214;5740.54075673945;5743.54051675865;5747.511461525775;5774.797882074107;6336.936630633681;6361.395667411589;6367.61794292344;6374.171357723512;6391.296957334689;6303.936960630381;6344.936550634481;6352.587081839665;6352.841178970517;6386.201724784402;5807.128930660392;5860.09168578871;5872.031114865999;5967.6121052131475;5969.134475501071;6284.340144284875;6315.179026726496;6334.714937827809;6350.237971443364;6372.776952806629;6035.064564992434;6136.815895523141;6151.046587778901;6154;6169.413905678954;6182.381761823872;6295.5907865988565;6298.937010629927;6301.432871041537;6310.9368906311265;6175.320714721377;6221.564490485623;6290.24517057956;6312.021636646327;6370.394812492806;6366.076918846741;6366.26787919386;6373.904391434132;6382.776602818879;6404.807855764335;5021.4978502150225;5060.974695126574;5085.389753229636;5092.9745351273;5108.438071812172;4485.372047913294;4511.571400716926;4518.254488009442;4536.79584418702;4555.749433781174;5869.589128760946;5878.323992740804;5903.0555111182;5940.79207227745;5959.344472108065;6305.500447251819;6322.71547780351;6335.271443784024;6341.651209183447;6362.300146983828;5729.197912292282;5739.512141468022;5790.044642634002;5878.794242201588;5919.437653422918;5461.2627295315415;5518.255035570227;5524.944750552523;5528.723563821793;5565.499105080562;5593.888122237532;6326.304106548276;6366.236051673922;6368.586041907354;6390.13733146038;6236;6248.5313601479165;6274.278457977209;6310.684465776784;6333;6259.78090766821;6262.3111457738705;6330.841728956813;6334.3665633436285;6409.230892292768;6307.274663413767;6317.526185536195;6323.494120470444;6334.429901308904;6361.3956674117735;6255.437010669061;6333;6334.271558770801;6335.1130841683125;6346.746130154742;6094.786682466092;6117.857853872152;6139.6009259398;6156.292026416841;6231.065340199007;6174.228221472316;6258.906116408349;6268.059791031382;6271.96864015677;6298.496120310456;4723.763811809327;6144.41628045335;6156.384361563808;6158.476529494864;6194.938050619436;5195.246689229964;6116.449519543263;6122.957850431897;6124.106319906264;6150.138980542817;6106.816795496142;6112.022076467744;6131.621347939075;6135.539834512519;6172.938270617416 04:54:02 INFO - PROCESS | 1660 | |1;ext.html;492.98521044368636;528.3316604495313;542.2516926641234;552.2627292564426;563.1215304125566;32822;41860.95347616311;42777.35833962493;43071.13857722848;45313.546864531425;44808;45157.54842451574;45176.774116129454;45302.54697453025;45316.77341613296;9899.010098990097;10071.043250891154;10079.748006299827;10096.596136154545;10097.24270679702;9297.535123243812;9483.668071617494;12179.878201217964;12340.197887137307;12465.626031219077;12401;12503.499860005635;12518.874811251908;12519;12521.373931303398;12417.875821241762;12489.812652810215;12515.874841251562;12526.185797923106;12558.74882502354;12226.510939562408;12311.322877241748;12311.384430778426;12311.630651080392;12317.630471085882;42345.364819527735;42555.9361015974;42619.786901065294;42755.14489710188;42792.786036069934;3434.7767395119486;3673.742838001341;3988;4144.564820693814;4147.688923330762;28207;32261.193470163198;32384;32723.50914736257;33400.83299583511;3384.4754063120254;3393.6267010628812;3410.3520331137006;3419.230673098533;3458.6714262145056;496932;504183;504970;505179.4741026308;505765;61856;62158.37841621526;62203.377966219756;62383;62390.68804655947;35816.64183358185;36875.81562092226;36909.630903691155;37871.431928521095;37872;17806.91096544509;17962.371317003843;17980.9100954497;18013;18015.18931648079;12548;12760.234385936874;13523.729525409437;13639.454421823215;13687.384067716977;19655.803441965396;20036;20070.498237543885;20597.382078537667;20610.07254673543;6971.675381677465;8071.919280807234;8078.7172448964;8088.716894908767;8100.473469224482;905.6332185464897;1000.9549570269355;1030.0111892583204;1088.820344643125;1103.862017247844;22536.436589085402;24486.14298499544;31106;31332;31426.21434464111;971.0726256425097;1022.4938655365493;1106.5186643809807;1165.114512970132;1222.718774681828;13161.53934612284;16269.51191464258;16319.265633046542;16349.836501635069;16550;681263;686204;688473;688583;689194;60485.69757151186;61359.772804544555;61371.77256454846;61450.38549614536;61465;1304.3282709404664;1347.528365072217;1426.0374247383184;1441.128117488925;1459.2776575595149;29978.610103376646;32316.83841580777;32544.674553254164;32651.510227346134;32895.67104329022;51147.97704045973;51593;51715;51825.740871295406;51983;551920.365574422;556374;557670;559039;560263;23539.764602353756;27359;27523.587146193222;28028.159155225378;28107.297317566405;48818.75590622024;49286.75356623194;49537.75231123821;49553.75223123861;50125.74937125291;40475;43999.12001759883;44473.777631112935;45706;46292.30561541512;36180.45729314115;40890.79554602208;42286.57713422826;44337;45406.31890521579;42865.57134428616;42928.78535607302;43431.39411635312;43740.56259437365;43765.34351984659;35369.11577210487;35884;41892.1621567573;42689.786551067045;42762.57237427586;27408.725912740618;28256.434871302048;28310.433791323645;28375.006874759285;28405.715942840307 04:54:02 INFO - PROCESS | 1660 | |2;jquery.html;327.89671253555133;377.38297882961365;378.8143809533329;393.6339204539777;407.25472385534476;20123.698144527825;20823.27118550851;22612.8869355653;22621.77378226217;22713.99999999996;12177.208481448723;12374;15961;18742;18854.868707877504;5170.431252562215;5400.324959380067;5645.830625081254;5646.858828529299;5659.745311460994;5498.972505137469;5611.494965453108;5663.716814159276;5665.036943719578;5666.858328541778;5650.773969041234;5651.208830763697;5660.235868157787;5695.601307908448;5914.645121292736;6114.388561143895;6270.96529072707;6273.05904114382;6277.089821975788;6277.623342599436;5939.821805345847;6098.512119030467;6156.8768624627255;6162.414570615784;6180.443760061616;13672.31638418075;13938.233397163254;13940.95442841791;22256.777432225794;26337.341566460993;2192.550527141948;2226.031676220849;2278.1001504405667;2373.905043798246;2493.463711817909;9853.408795472295;10442.686719398354;10591;10608.840867386996;10789.514471848786;1842.3920106364867;1936.4242087729085;1973.3290681168328;1987.681970884666;2014.9697754533693;127565;128876;136020.31989839987;136884.84018219204;137803.31098344544;11311;11559.190856639954;11686.649400517997;11732.296062236293;11879.703007424883;12467.376631168587;15150.696986060217;15182.924085379502;15197.316120774592;15197.468088616846;8632.050474447806;8851.734447966572;8861.025287218401;8976.326775491863;8978.551072446351;8841.071687472722;8862.335324850663;8868.379213455126;8880.422772519765;9016.684416045407;4607.493175750665;4634.884127896829;4636.768161591907;4637.469635020435;4725.787339569728;1799.2443173867007;1802.0989505247376;1888.4334699590067;1920.836728878033;1925.3357591630865;874.3267683883374;942.4204114469552;986.7681094942683;996.4071377530358;1032.8605638238892;20573.382798516068;21948.34154975353;21972.230971915906;22025.449363766034;22143;911.7902882337099;998.5706146356991;1007.7581380468781;1026.8049070676698;1033.4729288062993;9179.95410022959;11104.389258590854;11459.885401146048;11462.48418821155;11649.41752912351;614822;617779;618133.9093304505;629978;633251;83872.58063709643;110407.44796276127;110687;125573.37213314058;133594;1012.7721262715977;1023.8720159980003;1066.088494337346;1070.764431825013;1071.2019545438698;19562.51093722668;20133.6979945298;20469.488262793548;20505.589888201856;20565.280215192397;55154.72422637861;55532.72233638968;56057.15914261371;56690.14964775449;57565.136522951354;73096.6345168292;80558;81696.59151704203;83918.58040709757;84686.7296990558;4822.42130944289;5344.545713614386;7882.605869706606;7926.762197134095;8228.670853165806;12916.418761155583;12966.416511256828;12980.805287920877;13050.54323098687;13384.464621415034;11219.214654974074;11402;11419.31484110956;11723.003544698797;11852.348120853436;11082.778344432905;11180.832287515856;11274.069639828525;11653;11726.88273117258;11208.27146235492;11264.09887209005;11448.255863368855;11671.066314694634;11675.3578553177;8030.317423018875;8031.678732850854;8044.798880028046;8300.086990430927;8315.875261871197;8392.748217553482;10940.070094042096;10962.397068161328;11131.888681113409;11649.359285239394 04:54:02 INFO - PROCESS | 1660 | |3;mootools.html;1330.7870740681492;1560.6488540078483;1722.9052402117886;1865.5056410051347;1910.0163415840843;8829.955850220747;9436.71689849304;9443.858342124866;9444.300025995319;9458.385204961673;8221.91778082219;8467.703630372938;8757.737267881974;9043.638254469814;9058.456492610432;2384.153625462962;2439.902403903842;2442.218490083174;2443.7434069422634;2446.571849926265;2402.0752010476003;2426.7987346263626;2439.902403903842;2445.254197469771;2450.963235551468;2414.2153800015067;2426.648136020276;2428.1501474483875;2454.8895299711558;2458.4345600511892;2408.6025805742206;2420.0198919437657;2427.5751743444825;2429.9635505467522;2443.8900249488815;2401.3156250468705;2407.1454633604994;2413.8672373019476;2416.359664688859;2418.044872275459;9080.954595226982;9088.04575519574;9126.17864392208;9129.726108216764;9190.080991900822;4605.907881842378;5602.971985140089;5604.691741954191;5605.635633683797;5608.6073974821775;3628.455731640249;3744.5319335083113;3782.5082739244;3794.6964242860504;3810.12367155553;1097.5006372100675;1115.2583531951243;1118.5637601335486;1144;1145.6276710069178;12198.573049943298;12486.875131248662;12495.625131246077;12503.624891253277;12527.185732927423;4785.712857228577;4861.319415281863;4950.975245123751;4981.875453113628;4982.853943592994;10570.995755403379;10571.894281057244;10579.206559508068;10583.523741431654;10585.84121238182;5424.240606315119;5521.834344969658;5527.944720552823;5528.612997090165;5622.662640241599;4598.724076555351;4757.762111894392;4950.975245123751;5038.370203724535;5069.797208111708;4074.4703188585295;4113.6297733203555;4164.167166566699;4219.050713589418;4242.427272318259;1286.852012018611;1303.7131830997166;1304.693397051692;1307.6469353274563;1315.375196781521;905.6151135767273;946.5835032585641;946.9005754395827;956.4261443134203;996.9152622027209;5924.259467566554;6012.579119461683;6015.729292181863;6090.543209259324;6224.62652240867;394.838116372286;444.4799584486159;458.3903408466731;458.84857996860956;461.7552697070558;4061.898452538651;4072.1041370898356;4086.81609327575;4106.3840423936645;4191.1827193697545;10720.892791072145;11234.7191320216;11241.100711943025;11248.887511124783;11253.662390128145;11149.888501114885;11153.498092585853;11155.219134660658;11156.888431115747;11165.106791456665;8078.959605201936;8415.789605259795;8471.152884711479;8543.35924805642;8558.78603034929;6062.787442511603;6066.484348830399;6103;6120.785772497941;6224.439800417803;8748.737537873874;10184.847227291448;10486.370817750654;10487.213458990454;10575.682729518127;9287.582058807235;10256.07695307426;10616.734581635521;10668.733281668021;10774.838377424188;6949.131358580177;7064.717411303491;7158.821029474305;7418.295261950106;7638.770836874903;8648.82702345937;8869.97995230531;8874.023857375812;8883.022867484442;8886.155815197546;7774.989251397282;7899.68401263943;7932.246436588515;7983.960080199562;8063.959680201796;6629.204495460575;7360.300771426706;7699.538027718355;7744.7676569703;7751.573663448565;7220.783376498714;7317.67070481819;7319.414446844133;7325.706971721284;7336.303051210127;5072.416672082758;5109.386873575195;5167.379914410295;5291.76187071575;5417.295751552273;5192.766325515437;5220.791168353223;5300.257963884982;5348.5186333230195;5467.58993075513 04:54:02 INFO - PROCESS | 1660 | |4;prototype.html;300.6107091316746;300.77291644808173;309.08202638164653;312.1369413571475;312.4344935666445;5143.8456846294575;5335.706536140511;5379.757910894009;5415.860735009674;5448.45515448455;5276.551493123089;5277.076511610462;5289.603279754024;5294.682319060859;5305.920411193835;3167.9366412671734;3353.547271118392;4059.289624315748;4077.347624380085;4135.8966025849295;3953.308171070066;4102.835886564534;4103.6252855293515;4109.9178016439655;4115.650169735561;3573.9099574629727;3732.682721968636;3912.43269725891;3963.564007959122;4032.7700051484285;3841.8271177797064;3898.9805050974564;4018.819153138116;4033.8184781684895;4053.716239863196;3514.5782506099176;3528.7353448491467;3544.85820567177;3550.7692000020174;3555.6977656898935;4493.955060449386;4949.851504454872;5184.248283998799;5197.818076367309;5262.578993680497;3849.595792441781;4124.443200167969;4333.328334108187;4632.65652960641;4664.790084446174;4563.744970133207;4858.854234372974;5481.75332110056;5529.972350138264;5621.662700237958;3044.5128779395413;3779.622037796226;3851.6340947609933;3891.1439483313625;3904.7852368119743;5374.301340825707;5555.8888822223325;5824.301083869963;5847.970760146172;5862.098261360611;3859.6912247020173;3859.9421008684894;3874.748141370802;3888.2612303662213;3926.7447615904875;3143.3713257348622;3493.4410494320787;3650.5619325681087;3947.822347994347;3964.365701487748;3825.483559719458;4555.385023021916;4568.474625418053;4572.88567785808;4574.702644328175;5548.667079975134;5573.832785016456;5584.93886161628;5596.888062238732;5660.311352107716;1260.5966090850839;1266.9049821263443;1304.584525789529;1330.2284674888542;1348.730253949214;752.27405553641;872.3021582733787;879.2262808728278;897.228383590112;917.2386918857466;4683.8360657376825;5261.421243663194;5277.736113194325;5309.787608495617;5337.733113344395;4963.60291176705;5311.335178726744;5741.048043665174;5773.422657734277;5821.330546987066;4185.016521117535;4560.635149188057;5261.421243663194;5269.262303277545;5294.205869119663;2358.5282943411385;2429.757024297556;2504.461540768707;2520.987395063013;2537.4037101281183;4613.3771940787565;4918.319515863863;4930.408350997904;5156.793728250828;5953.226080609493;4735.526447355237;5194.68831870089;5977.742130538867;5979.133025711334;5979.730912108966;5635.534760962098;6034.39656034393;6045.425684559959;6053.182820319201;6103.633781973007;5351.357837059578;5627.915581266202;5764.250647415809;5823.854403639943;5832.445917637818;4336.959129808886;5674.546036317167;5729.942700572941;5737.713114344183;5758.337791154071;4782.928256076092;5748.281464816898;5985.910211346921;5986.820395388146;6115.449609534985;3840.7695538267794;3852.056246219694;3891.8248678808955;3900.317444447267;3904.863329783444;5836.445537673914;5851.239338885917;5867.882642347044;5879.942429936324;5893.2044174035955;4325.205039908403;4738.644601654959;5672.631278967019;5682.516986056232;5717.628354156966;5002.149634562206;5691.7438715257085;5713.771449141987;5713.8285851424525;5718.911787634631;4787.952120478751;5141.485851414828;5343.599230057839;5419.485148910847;5543.8891222176135;4705.858824235278;5626.718664066699;5661.377248502579;5669.744861481161;5670.5180059695385;4936.4569897311985;5247.89504209906;5517.2275881377445;5544.112941929272;5556.305461817273 04:54:02 INFO - PROCESS | 1660 | |5;yui.html;751.5227830327743;779.1118125337117;801.6271240383708;816.7182322098876;848.7368915636154;15883.920580397096;16778.41275555356;16906.492805215865;16928.57678558035;16939.491815245532;13994.020418570704;14985.325660345283;15259.694806103871;15270.541883743506;15968.840311596881;872.2411501993274;876.1457578860624;878.7715194049529;879.7360791762445;881.5636260051284;737.72704099483;762.5386641082149;886.3485338276394;910.7723069232692;912.338554547954;968.9951550242274;972.1445128287097;973.5862258540128;973.897740737223;977.6773664690635;962.3311798300114;963.4460185393392;965.4303960663173;967.632299726103;969.8739163908717;705.9929400705979;708.7554793596202;710.7761055267574;711.4592909388901;714.9918614753173;15238.923805380902;15324;15455.61360965985;15741.370345186293;15778.368865245377;13737.313134343343;15001.249937503191;15173.013754106058;15173.089614623048;15335.539933802003;13431.597052088453;13502.662433439144;13604;13800;13812.930935345259;4700.623950084019;4758.2624693172265;4811.278308253755;4819.927701084486;4940.827071052532;124982.75017249893;125351;130496;134217;134797;9617.278704097082;11204.103671706243;11322.337572843187;11512.30926144434;11796.646100616996;21816.781832181794;22055.779442205694;22057.669134962987;22079.558408831734;22096.88951555232;7918.406119541058;7936.722214722457;7947.880781788278;8009.399295052895;8465.28045116172;4548.522405147478;4615.607673347736;4674.462436819809;4736.526347365305;4770.522947705202;3462.1690794209208;3535.2752685699884;3539.681428671432;3545.911352216164;3564.0733409313766;577.3014652270799;654.0483596367275;657.7796438193163;658.5324419661998;659.1661548141604;564.0833645326345;628.4972022382167;645.4771634975684;647.4108561209277;657.4083325007532;8441.915580844236;9472.95263523678;9498.477583732962;9529.714108576754;9602.711918642452;537.9435159308294;590.9349971503132;631.3875540725489;660.893004217933;675.321302091395;4242;4608.585227329557;4618.745968971739;4641.118187544355;4761;120170;162266.18866905826;167323;169943;175839;117984;117988.41005795088;118848;132314;146914.26542867217;76309;87735.68396474059;104064;117456;119680;9799.902000979899;10059.19526437898;10112.191024718151;10113.69658910234;10123.848142278019;64661;64840.675796620715;66482;66832.66583667051;68712;76957;97486;98754;102216;103711;13489.797653035408;13510.392032358372;13575.932120339336;13760.518381856587;13839.723205536035;14851.17099966276;14854.33155507983;15237.085774853544;15348.155851427831;15835.604109897346;14595.85404145945;14713.411463541339;14744.410223590936;15327.540173794803;15389.076655400711;14478.855211447752;14627.488037919047;14638.560843174722;14756.114633122046;15273.465428709942;11352.318860868374;12060.216085954386;13736.862631373559;13765.38055787512;14847.480338188112;11555.364454955059;11828.76342473163;12014.279143251433;12181.208221465577;12279.140460167702;11998.340091295062;12079.879201208227;12242.510299587917;12286.447109880255;12375.69060773488 04:54:02 INFO - PROCESS | 1660 | __end_tp_report 04:54:02 INFO - PROCESS | 1660 | __start_cc_report 04:54:02 INFO - PROCESS | 1660 | _x_x_mozilla_cycle_collect,1350 04:54:02 INFO - PROCESS | 1660 | __end_cc_report 04:54:02 INFO - PROCESS | 1660 | __startTimestamp1479905642161__endTimestamp 04:54:02 INFO - PROCESS | 1660 | 04:54:02 INFO - PROCESS | 1660 | ------- Summary: start ------- 04:54:02 INFO - PROCESS | 1660 | Number of tests: 6 04:54:02 INFO - PROCESS | 1660 | 04:54:02 INFO - PROCESS | 1660 | [#0] dojo.html Cycles:165 Average:5821.24 Median:6116.45 stddev:648.63 (10.6%) stddev-sans-first:623.98 04:54:02 INFO - PROCESS | 1660 | Values: 3475.9 3487.2 3502.2 3533.7 3572.8 4888.8 5813.2 5876.2 5926.7 5957.6 5871.8 5897.9 5924.8 5953.5 5958.5 5259.7 5282.9 5363.8 5364.8 5365.1 4261.7 4872.7 5212.4 5214.0 5369.7 5249.1 5277.9 5286.2 5304.1 5312.7 5290.9 5317.3 5332.1 5388.2 5392.4 5248.3 5305.7 5314.7 5326.4 5341.5 5697.4 5740.5 5743.5 5747.5 5774.8 6336.9 6361.4 6367.6 6374.2 6391.3 6303.9 6344.9 6352.6 6352.8 6386.2 5807.1 5860.1 5872.0 5967.6 5969.1 6284.3 6315.2 6334.7 6350.2 6372.8 6035.1 6136.8 6151.0 6154.0 6169.4 6182.4 6295.6 6298.9 6301.4 6310.9 6175.3 6221.6 6290.2 6312.0 6370.4 6366.1 6366.3 6373.9 6382.8 6404.8 5021.5 5061.0 5085.4 5093.0 5108.4 4485.4 4511.6 4518.3 4536.8 4555.7 5869.6 5878.3 5903.1 5940.8 5959.3 6305.5 6322.7 6335.3 6341.7 6362.3 5729.2 5739.5 5790.0 5878.8 5919.4 5461.3 5518.3 5524.9 5528.7 5565.5 5593.9 6326.3 6366.2 6368.6 6390.1 6236.0 6248.5 6274.3 6310.7 6333.0 6259.8 6262.3 6330.8 6334.4 6409.2 6307.3 6317.5 6323.5 6334.4 6361.4 6255.4 6333.0 6334.3 6335.1 6346.7 6094.8 6117.9 6139.6 6156.3 6231.1 6174.2 6258.9 6268.1 6272.0 6298.5 4723.8 6144.4 6156.4 6158.5 6194.9 5195.2 6116.4 6123.0 6124.1 6150.1 6106.8 6112.0 6131.6 6135.5 6172.9 04:54:02 INFO - PROCESS | 1660 | 04:54:02 INFO - PROCESS | 1660 | [#1] ext.html Cycles:180 Average:72187.48 Median:19927.10 stddev:156867.43 (787.2%) stddev-sans-first:157215.12 04:54:02 INFO - PROCESS | 1660 | Values: 493.0 528.3 542.3 552.3 563.1 32822.0 41861.0 42777.4 43071.1 45313.5 44808.0 45157.5 45176.8 45302.5 45316.8 9899.0 10071.0 10079.7 10096.6 10097.2 9297.5 9483.7 12179.9 12340.2 12465.6 12401.0 12503.5 12518.9 12519.0 12521.4 12417.9 12489.8 12515.9 12526.2 12558.7 12226.5 12311.3 12311.4 12311.6 12317.6 42345.4 42555.9 42619.8 42755.1 42792.8 3434.8 3673.7 3988.0 4144.6 4147.7 28207.0 32261.2 32384.0 32723.5 33400.8 3384.5 3393.6 3410.4 3419.2 3458.7 496932.0 504183.0 504970.0 505179.5 505765.0 61856.0 62158.4 62203.4 62383.0 62390.7 35816.6 36875.8 36909.6 37871.4 37872.0 17806.9 17962.4 17980.9 18013.0 18015.2 12548.0 12760.2 13523.7 13639.5 13687.4 19655.8 20036.0 20070.5 20597.4 20610.1 6971.7 8071.9 8078.7 8088.7 8100.5 905.6 1001.0 1030.0 1088.8 1103.9 22536.4 24486.1 31106.0 31332.0 31426.2 971.1 1022.5 1106.5 1165.1 1222.7 13161.5 16269.5 16319.3 16349.8 16550.0 681263.0 686204.0 688473.0 688583.0 689194.0 60485.7 61359.8 61371.8 61450.4 61465.0 1304.3 1347.5 1426.0 1441.1 1459.3 29978.6 32316.8 32544.7 32651.5 32895.7 51148.0 51593.0 51715.0 51825.7 51983.0 551920.4 556374.0 557670.0 559039.0 560263.0 23539.8 27359.0 27523.6 28028.2 28107.3 48818.8 49286.8 49537.8 49553.8 50125.7 40475.0 43999.1 44473.8 45706.0 46292.3 36180.5 40890.8 42286.6 44337.0 45406.3 42865.6 42928.8 43431.4 43740.6 43765.3 35369.1 35884.0 41892.2 42689.8 42762.6 27408.7 28256.4 28310.4 28375.0 28405.7 04:54:02 INFO - PROCESS | 1660 | 04:54:02 INFO - PROCESS | 1660 | [#2] jquery.html Cycles:180 Average:35702.35 Median:22199.89 stddev:103875.48 (467.9%) stddev-sans-first:104132.92 04:54:02 INFO - PROCESS | 1660 | Values: 327.9 377.4 378.8 393.6 407.3 20123.7 20823.3 22612.9 22621.8 22714.0 12177.2 12374.0 15961.0 18742.0 18854.9 5170.4 5400.3 5645.8 5646.9 5659.7 5499.0 5611.5 5663.7 5665.0 5666.9 5650.8 5651.2 5660.2 5695.6 5914.6 6114.4 6271.0 6273.1 6277.1 6277.6 5939.8 6098.5 6156.9 6162.4 6180.4 13672.3 13938.2 13941.0 22256.8 26337.3 2192.6 2226.0 2278.1 2373.9 2493.5 9853.4 10442.7 10591.0 10608.8 10789.5 1842.4 1936.4 1973.3 1987.7 2015.0 127565.0 128876.0 136020.3 136884.8 137803.3 11311.0 11559.2 11686.6 11732.3 11879.7 12467.4 15150.7 15182.9 15197.3 15197.5 8632.1 8851.7 8861.0 8976.3 8978.6 8841.1 8862.3 8868.4 8880.4 9016.7 4607.5 4634.9 4636.8 4637.5 4725.8 1799.2 1802.1 1888.4 1920.8 1925.3 874.3 942.4 986.8 996.4 1032.9 20573.4 21948.3 21972.2 22025.4 22143.0 911.8 998.6 1007.8 1026.8 1033.5 9180.0 11104.4 11459.9 11462.5 11649.4 614822.0 617779.0 618133.9 629978.0 633251.0 83872.6 110407.4 110687.0 125573.4 133594.0 1012.8 1023.9 1066.1 1070.8 1071.2 19562.5 20133.7 20469.5 20505.6 20565.3 55154.7 55532.7 56057.2 56690.1 57565.1 73096.6 80558.0 81696.6 83918.6 84686.7 4822.4 5344.5 7882.6 7926.8 8228.7 12916.4 12966.4 12980.8 13050.5 13384.5 11219.2 11402.0 11419.3 11723.0 11852.3 11082.8 11180.8 11274.1 11653.0 11726.9 11208.3 11264.1 11448.3 11671.1 11675.4 8030.3 8031.7 8044.8 8300.1 8315.9 8392.7 10940.1 10962.4 11131.9 11649.4 04:54:02 INFO - PROCESS | 1660 | 04:54:02 INFO - PROCESS | 1660 | [#3] mootools.html Cycles:180 Average:5920.09 Median:4771.74 stddev:3359.95 (70.4%) stddev-sans-first:3351.67 04:54:02 INFO - PROCESS | 1660 | Values: 1330.8 1560.6 1722.9 1865.5 1910.0 8830.0 9436.7 9443.9 9444.3 9458.4 8221.9 8467.7 8757.7 9043.6 9058.5 2384.2 2439.9 2442.2 2443.7 2446.6 2402.1 2426.8 2439.9 2445.3 2451.0 2414.2 2426.6 2428.2 2454.9 2458.4 2408.6 2420.0 2427.6 2430.0 2443.9 2401.3 2407.1 2413.9 2416.4 2418.0 9081.0 9088.0 9126.2 9129.7 9190.1 4605.9 5603.0 5604.7 5605.6 5608.6 3628.5 3744.5 3782.5 3794.7 3810.1 1097.5 1115.3 1118.6 1144.0 1145.6 12198.6 12486.9 12495.6 12503.6 12527.2 4785.7 4861.3 4951.0 4981.9 4982.9 10571.0 10571.9 10579.2 10583.5 10585.8 5424.2 5521.8 5527.9 5528.6 5622.7 4598.7 4757.8 4951.0 5038.4 5069.8 4074.5 4113.6 4164.2 4219.1 4242.4 1286.9 1303.7 1304.7 1307.6 1315.4 905.6 946.6 946.9 956.4 996.9 5924.3 6012.6 6015.7 6090.5 6224.6 394.8 444.5 458.4 458.8 461.8 4061.9 4072.1 4086.8 4106.4 4191.2 10720.9 11234.7 11241.1 11248.9 11253.7 11149.9 11153.5 11155.2 11156.9 11165.1 8079.0 8415.8 8471.2 8543.4 8558.8 6062.8 6066.5 6103.0 6120.8 6224.4 8748.7 10184.8 10486.4 10487.2 10575.7 9287.6 10256.1 10616.7 10668.7 10774.8 6949.1 7064.7 7158.8 7418.3 7638.8 8648.8 8870.0 8874.0 8883.0 8886.2 7775.0 7899.7 7932.2 7984.0 8064.0 6629.2 7360.3 7699.5 7744.8 7751.6 7220.8 7317.7 7319.4 7325.7 7336.3 5072.4 5109.4 5167.4 5291.8 5417.3 5192.8 5220.8 5300.3 5348.5 5467.6 04:54:02 INFO - PROCESS | 1660 | 04:54:02 INFO - PROCESS | 1660 | [#4] prototype.html Cycles:180 Average:4499.24 Median:5142.67 stddev:1422.44 (27.7%) stddev-sans-first:1391.08 04:54:02 INFO - PROCESS | 1660 | Values: 300.6 300.8 309.1 312.1 312.4 5143.8 5335.7 5379.8 5415.9 5448.5 5276.6 5277.1 5289.6 5294.7 5305.9 3167.9 3353.5 4059.3 4077.3 4135.9 3953.3 4102.8 4103.6 4109.9 4115.7 3573.9 3732.7 3912.4 3963.6 4032.8 3841.8 3899.0 4018.8 4033.8 4053.7 3514.6 3528.7 3544.9 3550.8 3555.7 4494.0 4949.9 5184.2 5197.8 5262.6 3849.6 4124.4 4333.3 4632.7 4664.8 4563.7 4858.9 5481.8 5530.0 5621.7 3044.5 3779.6 3851.6 3891.1 3904.8 5374.3 5555.9 5824.3 5848.0 5862.1 3859.7 3859.9 3874.7 3888.3 3926.7 3143.4 3493.4 3650.6 3947.8 3964.4 3825.5 4555.4 4568.5 4572.9 4574.7 5548.7 5573.8 5584.9 5596.9 5660.3 1260.6 1266.9 1304.6 1330.2 1348.7 752.3 872.3 879.2 897.2 917.2 4683.8 5261.4 5277.7 5309.8 5337.7 4963.6 5311.3 5741.0 5773.4 5821.3 4185.0 4560.6 5261.4 5269.3 5294.2 2358.5 2429.8 2504.5 2521.0 2537.4 4613.4 4918.3 4930.4 5156.8 5953.2 4735.5 5194.7 5977.7 5979.1 5979.7 5635.5 6034.4 6045.4 6053.2 6103.6 5351.4 5627.9 5764.3 5823.9 5832.4 4337.0 5674.5 5729.9 5737.7 5758.3 4782.9 5748.3 5985.9 5986.8 6115.4 3840.8 3852.1 3891.8 3900.3 3904.9 5836.4 5851.2 5867.9 5879.9 5893.2 4325.2 4738.6 5672.6 5682.5 5717.6 5002.1 5691.7 5713.8 5713.8 5718.9 4788.0 5141.5 5343.6 5419.5 5543.9 4705.9 5626.7 5661.4 5669.7 5670.5 4936.5 5247.9 5517.2 5544.1 5556.3 04:54:02 INFO - PROCESS | 1660 | 04:54:02 INFO - PROCESS | 1660 | [#5] yui.html Cycles:180 Average:25997.68 Median:22068.61 stddev:41648.38 (188.7%) stddev-sans-first:41722.08 04:54:02 INFO - PROCESS | 1660 | Values: 751.5 779.1 801.6 816.7 848.7 15883.9 16778.4 16906.5 16928.6 16939.5 13994.0 14985.3 15259.7 15270.5 15968.8 872.2 876.1 878.8 879.7 881.6 737.7 762.5 886.3 910.8 912.3 969.0 972.1 973.6 973.9 977.7 962.3 963.4 965.4 967.6 969.9 706.0 708.8 710.8 711.5 715.0 15238.9 15324.0 15455.6 15741.4 15778.4 13737.3 15001.2 15173.0 15173.1 15335.5 13431.6 13502.7 13604.0 13800.0 13812.9 4700.6 4758.3 4811.3 4819.9 4940.8 124982.8 125351.0 130496.0 134217.0 134797.0 9617.3 11204.1 11322.3 11512.3 11796.6 21816.8 22055.8 22057.7 22079.6 22096.9 7918.4 7936.7 7947.9 8009.4 8465.3 4548.5 4615.6 4674.5 4736.5 4770.5 3462.2 3535.3 3539.7 3545.9 3564.1 577.3 654.0 657.8 658.5 659.2 564.1 628.5 645.5 647.4 657.4 8441.9 9473.0 9498.5 9529.7 9602.7 537.9 590.9 631.4 660.9 675.3 4242.0 4608.6 4618.7 4641.1 4761.0 120170.0 162266.2 167323.0 169943.0 175839.0 117984.0 117988.4 118848.0 132314.0 146914.3 76309.0 87735.7 104064.0 117456.0 119680.0 9799.9 10059.2 10112.2 10113.7 10123.8 64661.0 64840.7 66482.0 66832.7 68712.0 76957.0 97486.0 98754.0 102216.0 103711.0 13489.8 13510.4 13575.9 13760.5 13839.7 14851.2 14854.3 15237.1 15348.2 15835.6 14595.9 14713.4 14744.4 15327.5 15389.1 14478.9 14627.5 14638.6 14756.1 15273.5 11352.3 12060.2 13736.9 13765.4 14847.5 11555.4 11828.8 12014.3 12181.2 12279.1 11998.3 12079.9 12242.5 12286.4 12375.7 04:54:02 INFO - PROCESS | 1660 | -------- Summary: end -------- 04:54:02 INFO - PROCESS | 1660 | 04:54:02 INFO - TEST-INFO | 1660: exit 0 04:54:02 INFO - TEST-OK | dromaeo_css | took 1114765ms 04:54:02 INFO - TEST-START | kraken 04:54:02 INFO - operating with platform_type : mac_ 04:54:02 INFO - Initialising browser for kraken test... 04:54:02 INFO - TEST-INFO | started process 1781 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/tmpMYAEw4/profile http://localhost:49243/getInfo.html) 04:54:04 INFO - PROCESS | 1781 | __metrics Screen width/height:1600/1200 04:54:04 INFO - PROCESS | 1781 | colorDepth:24 04:54:04 INFO - PROCESS | 1781 | Browser inner width/height: 1024/689 04:54:04 INFO - PROCESS | 1781 | __metrics 04:54:04 INFO - PROCESS | 1781 | 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" 04:54:04 INFO - PROCESS | 1781 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:54:05 INFO - TEST-INFO | 1781: exit 0 04:54:05 INFO - Browser initialized. 04:54:05 INFO - Running cycle 1/1 for kraken test... 04:54:05 INFO - TEST-INFO | started process 1783 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/tmpMYAEw4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:54:17 INFO - PROCESS | 1783 | RSS: Main: 168161280 04:54:17 INFO - PROCESS | 1783 | 04:54:20 INFO - PROCESS | 1783 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-beat-detection) 04:54:20 INFO - PROCESS | 1783 | RSS: Main: 219406336 04:54:20 INFO - PROCESS | 1783 | 04:54:23 INFO - PROCESS | 1783 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-dft) 04:54:24 INFO - PROCESS | 1783 | RSS: Main: 228442112 04:54:24 INFO - PROCESS | 1783 | 04:54:27 INFO - PROCESS | 1783 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-fft) 04:54:27 INFO - PROCESS | 1783 | RSS: Main: 325857280 04:54:27 INFO - PROCESS | 1783 | 04:54:29 INFO - PROCESS | 1783 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-oscillator) 04:54:30 INFO - PROCESS | 1783 | RSS: Main: 228868096 04:54:30 INFO - PROCESS | 1783 | 04:54:32 INFO - PROCESS | 1783 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:54:33 INFO - PROCESS | 1783 | RSS: Main: 229388288 04:54:33 INFO - PROCESS | 1783 | 04:54:35 INFO - PROCESS | 1783 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-darkroom) 04:54:36 INFO - PROCESS | 1783 | RSS: Main: 267808768 04:54:36 INFO - PROCESS | 1783 | 04:54:39 INFO - PROCESS | 1783 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-desaturate) 04:54:39 INFO - PROCESS | 1783 | RSS: Main: 266809344 04:54:39 INFO - PROCESS | 1783 | 04:54:42 INFO - PROCESS | 1783 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49243/tests/kraken/driver.html?testName=json-parse-financial) 04:54:43 INFO - PROCESS | 1783 | RSS: Main: 266346496 04:54:43 INFO - PROCESS | 1783 | 04:54:44 INFO - PROCESS | 1783 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49243/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:54:45 INFO - PROCESS | 1783 | RSS: Main: 240496640 04:54:45 INFO - PROCESS | 1783 | 04:54:47 INFO - PROCESS | 1783 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:54:47 INFO - PROCESS | 1783 | RSS: Main: 243953664 04:54:47 INFO - PROCESS | 1783 | 04:54:49 INFO - PROCESS | 1783 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:54:50 INFO - PROCESS | 1783 | RSS: Main: 256561152 04:54:50 INFO - PROCESS | 1783 | 04:54:53 INFO - PROCESS | 1783 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:54:54 INFO - PROCESS | 1783 | RSS: Main: 266428416 04:54:54 INFO - PROCESS | 1783 | 04:54:56 INFO - PROCESS | 1783 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:54:57 INFO - PROCESS | 1783 | RSS: Main: 259297280 04:54:57 INFO - PROCESS | 1783 | 04:54:59 INFO - PROCESS | 1783 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49243/tests/kraken/driver.html?testName=ai-astar) 04:54:59 INFO - PROCESS | 1783 | RSS: Main: 303910912 04:54:59 INFO - PROCESS | 1783 | 04:54:59 INFO - PROCESS | 1783 | __start_tp_report 04:54:59 INFO - PROCESS | 1783 | _x_x_mozilla_page_load 04:54:59 INFO - PROCESS | 1783 | _x_x_mozilla_page_load_details 04:54:59 INFO - PROCESS | 1783 | |i|pagename|runs| 04:54:59 INFO - PROCESS | 1783 | |0;ai-astar;115;112;111;111;112;112;111;113;112;112 04:54:59 INFO - PROCESS | 1783 | |1;audio-beat-detection;143;109;110;167;138;109;108;106;133;108 04:54:59 INFO - PROCESS | 1783 | |2;audio-dft;182;181;184;183;179;181;180;180;183;183 04:54:59 INFO - PROCESS | 1783 | |3;audio-fft;92;59;58;87;60;58;58;76;101;82 04:54:59 INFO - PROCESS | 1783 | |4;audio-oscillator;87;65;94;70;68;68;91;67;66;90 04:54:59 INFO - PROCESS | 1783 | |5;imaging-gaussian-blur;87;84;90;125;87;84;89;86;87;85 04:54:59 INFO - PROCESS | 1783 | |6;imaging-darkroom;93;102;140;93;92;92;93;94;92;93 04:54:59 INFO - PROCESS | 1783 | |7;imaging-desaturate;86;83;82;83;84;84;83;86;83;86 04:54:59 INFO - PROCESS | 1783 | |8;json-parse-financial;56;54;55;53;54;54;56;54;55;55 04:54:59 INFO - PROCESS | 1783 | |9;json-stringify-tinderbox;65;71;69;70;70;68;69;68;68;69 04:54:59 INFO - PROCESS | 1783 | |10;stanford-crypto-aes;84;82;80;83;82;80;81;87;88;81 04:54:59 INFO - PROCESS | 1783 | |11;stanford-crypto-ccm;137;142;152;146;153;147;152;151;164;130 04:54:59 INFO - PROCESS | 1783 | |12;stanford-crypto-pbkdf2;159;163;160;162;222;195;158;162;161;160 04:54:59 INFO - PROCESS | 1783 | |13;stanford-crypto-sha256-iterative;68;73;66;66;67;66;63;63;66;64 04:54:59 INFO - PROCESS | 1783 | __end_tp_report 04:54:59 INFO - PROCESS | 1783 | __start_cc_report 04:54:59 INFO - PROCESS | 1783 | _x_x_mozilla_cycle_collect,1882 04:54:59 INFO - PROCESS | 1783 | __end_cc_report 04:54:59 INFO - PROCESS | 1783 | __startTimestamp1479905699521__endTimestamp 04:54:59 INFO - PROCESS | 1783 | 04:54:59 INFO - PROCESS | 1783 | ------- Summary: start ------- 04:54:59 INFO - PROCESS | 1783 | Number of tests: 14 04:54:59 INFO - PROCESS | 1783 | 04:54:59 INFO - PROCESS | 1783 | [#0] ai-astar Cycles:10 Average:112.10 Median:112.00 stddev:1.20 (1.1%) stddev-sans-first:0.67 04:54:59 INFO - PROCESS | 1783 | Values: 115.0 112.0 111.0 111.0 112.0 112.0 111.0 113.0 112.0 112.0 04:54:59 INFO - PROCESS | 1783 | 04:54:59 INFO - PROCESS | 1783 | [#1] audio-beat-detection Cycles:10 Average:123.10 Median:121.50 stddev:20.98 (17.3%) stddev-sans-first:20.98 04:54:59 INFO - PROCESS | 1783 | Values: 143.0 109.0 110.0 167.0 138.0 109.0 108.0 106.0 133.0 108.0 04:54:59 INFO - PROCESS | 1783 | 04:54:59 INFO - PROCESS | 1783 | [#2] audio-dft Cycles:10 Average:181.60 Median:182.50 stddev:1.65 (0.9%) stddev-sans-first:1.74 04:54:59 INFO - PROCESS | 1783 | Values: 182.0 181.0 184.0 183.0 179.0 181.0 180.0 180.0 183.0 183.0 04:54:59 INFO - PROCESS | 1783 | 04:54:59 INFO - PROCESS | 1783 | [#3] audio-fft Cycles:10 Average:73.10 Median:68.00 stddev:16.57 (24.4%) stddev-sans-first:16.10 04:54:59 INFO - PROCESS | 1783 | Values: 92.0 59.0 58.0 87.0 60.0 58.0 58.0 76.0 101.0 82.0 04:54:59 INFO - PROCESS | 1783 | 04:54:59 INFO - PROCESS | 1783 | [#4] audio-oscillator Cycles:10 Average:76.60 Median:78.50 stddev:12.15 (15.5%) stddev-sans-first:12.29 04:54:59 INFO - PROCESS | 1783 | Values: 87.0 65.0 94.0 70.0 68.0 68.0 91.0 67.0 66.0 90.0 04:54:59 INFO - PROCESS | 1783 | 04:54:59 INFO - PROCESS | 1783 | [#5] imaging-gaussian-blur Cycles:10 Average:90.40 Median:87.00 stddev:12.31 (14.2%) stddev-sans-first:13.00 04:54:59 INFO - PROCESS | 1783 | Values: 87.0 84.0 90.0 125.0 87.0 84.0 89.0 86.0 87.0 85.0 04:54:59 INFO - PROCESS | 1783 | 04:54:59 INFO - PROCESS | 1783 | [#6] imaging-darkroom Cycles:10 Average:98.40 Median:93.00 stddev:14.92 (16.0%) stddev-sans-first:15.69 04:54:59 INFO - PROCESS | 1783 | Values: 93.0 102.0 140.0 93.0 92.0 92.0 93.0 94.0 92.0 93.0 04:54:59 INFO - PROCESS | 1783 | 04:54:59 INFO - PROCESS | 1783 | [#7] imaging-desaturate Cycles:10 Average:84.00 Median:84.00 stddev:1.49 (1.8%) stddev-sans-first:1.39 04:54:59 INFO - PROCESS | 1783 | Values: 86.0 83.0 82.0 83.0 84.0 84.0 83.0 86.0 83.0 86.0 04:54:59 INFO - PROCESS | 1783 | 04:54:59 INFO - PROCESS | 1783 | [#8] json-parse-financial Cycles:10 Average:54.60 Median:55.00 stddev:0.97 (1.8%) stddev-sans-first:0.88 04:54:59 INFO - PROCESS | 1783 | Values: 56.0 54.0 55.0 53.0 54.0 54.0 56.0 54.0 55.0 55.0 04:54:59 INFO - PROCESS | 1783 | 04:54:59 INFO - PROCESS | 1783 | [#9] json-stringify-tinderbox Cycles:10 Average:68.70 Median:69.00 stddev:1.64 (2.4%) stddev-sans-first:1.05 04:54:59 INFO - PROCESS | 1783 | Values: 65.0 71.0 69.0 70.0 70.0 68.0 69.0 68.0 68.0 69.0 04:54:59 INFO - PROCESS | 1783 | 04:54:59 INFO - PROCESS | 1783 | [#10] stanford-crypto-aes Cycles:10 Average:82.80 Median:82.50 stddev:2.78 (3.4%) stddev-sans-first:2.92 04:54:59 INFO - PROCESS | 1783 | Values: 84.0 82.0 80.0 83.0 82.0 80.0 81.0 87.0 88.0 81.0 04:54:59 INFO - PROCESS | 1783 | 04:54:59 INFO - PROCESS | 1783 | [#11] stanford-crypto-ccm Cycles:10 Average:147.40 Median:151.50 stddev:9.45 (6.2%) stddev-sans-first:9.25 04:54:59 INFO - PROCESS | 1783 | Values: 137.0 142.0 152.0 146.0 153.0 147.0 152.0 151.0 164.0 130.0 04:54:59 INFO - PROCESS | 1783 | 04:54:59 INFO - PROCESS | 1783 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.20 Median:162.00 stddev:21.22 (13.1%) stddev-sans-first:22.11 04:54:59 INFO - PROCESS | 1783 | Values: 159.0 163.0 160.0 162.0 222.0 195.0 158.0 162.0 161.0 160.0 04:54:59 INFO - PROCESS | 1783 | 04:54:59 INFO - PROCESS | 1783 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.20 Median:66.00 stddev:2.90 (4.4%) stddev-sans-first:3.00 04:54:59 INFO - PROCESS | 1783 | Values: 68.0 73.0 66.0 66.0 67.0 66.0 63.0 63.0 66.0 64.0 04:54:59 INFO - PROCESS | 1783 | -------- Summary: end -------- 04:54:59 INFO - PROCESS | 1783 | 04:55:00 INFO - TEST-INFO | 1783: exit 0 04:55:00 INFO - TEST-OK | kraken | took 57615ms 04:55:00 INFO - SUITE-END | took 1172s 04:55:00 INFO - Completed test suite (00:19:32) 04:55:00 INFO - javascript benchmark 04:55:00 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3475.8957231283052, 3487.232808782068, 3502.176988407722, 3533.73496987726, 3572.8213589320526, 4888.8288909888115, 5813.186153938446, 5876.177335173079, 5926.674032928187, 5957.553183511238, 5871.76512939483, 5897.911531327033, 5924.822255332336, 5953.493953013999, 5958.49352805011, 5259.737013149356, 5282.894342113174, 5363.839084827461, 5364.839054828341, 5365.114756065244, 4261.701680882339, 4872.683275587093, 5212.400573933989, 5213.973930130344, 5369.704666243355, 5249.081410753122, 5277.947220527784, 5286.154215325549, 5304.124819404813, 5312.73436328184, 5290.867728306785, 5317.308749862532, 5332.066888294572, 5388.191771234347, 5392.352917649868, 5248.265242866002, 5305.734713264322, 5314.654547454403, 5326.360836699582, 5341.519263266286, 5697.373288938214, 5740.54075673945, 5743.54051675865, 5747.511461525775, 5774.797882074107, 6336.936630633681, 6361.395667411589, 6367.61794292344, 6374.171357723512, 6391.296957334689, 6303.936960630381, 6344.936550634481, 6352.587081839665, 6352.841178970517, 6386.201724784402, 5807.128930660392, 5860.09168578871, 5872.031114865999, 5967.6121052131475, 5969.134475501071, 6284.340144284875, 6315.179026726496, 6334.714937827809, 6350.237971443364, 6372.776952806629, 6035.064564992434, 6136.815895523141, 6151.046587778901, 6154.0, 6169.413905678954, 6182.381761823872, 6295.5907865988565, 6298.937010629927, 6301.432871041537, 6310.9368906311265, 6175.320714721377, 6221.564490485623, 6290.24517057956, 6312.021636646327, 6370.394812492806, 6366.076918846741, 6366.26787919386, 6373.904391434132, 6382.776602818879, 6404.807855764335, 5021.4978502150225, 5060.974695126574, 5085.389753229636, 5092.9745351273, 5108.438071812172, 4485.372047913294, 4511.571400716926, 4518.254488009442, 4536.79584418702, 4555.749433781174, 5869.589128760946, 5878.323992740804, 5903.0555111182, 5940.79207227745, 5959.344472108065, 6305.500447251819, 6322.71547780351, 6335.271443784024, 6341.651209183447, 6362.300146983828, 5729.197912292282, 5739.512141468022, 5790.044642634002, 5878.794242201588, 5919.437653422918, 5461.2627295315415, 5518.255035570227, 5524.944750552523, 5528.723563821793, 5565.499105080562, 5593.888122237532, 6326.304106548276, 6366.236051673922, 6368.586041907354, 6390.13733146038, 6236.0, 6248.5313601479165, 6274.278457977209, 6310.684465776784, 6333.0, 6259.78090766821, 6262.3111457738705, 6330.841728956813, 6334.3665633436285, 6409.230892292768, 6307.274663413767, 6317.526185536195, 6323.494120470444, 6334.429901308904, 6361.3956674117735, 6255.437010669061, 6333.0, 6334.271558770801, 6335.1130841683125, 6346.746130154742, 6094.786682466092, 6117.857853872152, 6139.6009259398, 6156.292026416841, 6231.065340199007, 6174.228221472316, 6258.906116408349, 6268.059791031382, 6271.96864015677, 6298.496120310456, 4723.763811809327, 6144.41628045335, 6156.384361563808, 6158.476529494864, 6194.938050619436, 5195.246689229964, 6116.449519543263, 6122.957850431897, 6124.106319906264, 6150.138980542817, 6106.816795496142, 6112.022076467744, 6131.621347939075, 6135.539834512519, 6172.938270617416], "value": 5781.7896513945825, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [492.98521044368636, 528.3316604495313, 542.2516926641234, 552.2627292564426, 563.1215304125566, 32822.0, 41860.95347616311, 42777.35833962493, 43071.13857722848, 45313.546864531425, 44808.0, 45157.54842451574, 45176.774116129454, 45302.54697453025, 45316.77341613296, 9899.010098990097, 10071.043250891154, 10079.748006299827, 10096.596136154545, 10097.24270679702, 9297.535123243812, 9483.668071617494, 12179.878201217964, 12340.197887137307, 12465.626031219077, 12401.0, 12503.499860005635, 12518.874811251908, 12519.0, 12521.373931303398, 12417.875821241762, 12489.812652810215, 12515.874841251562, 12526.185797923106, 12558.74882502354, 12226.510939562408, 12311.322877241748, 12311.384430778426, 12311.630651080392, 12317.630471085882, 42345.364819527735, 42555.9361015974, 42619.786901065294, 42755.14489710188, 42792.786036069934, 3434.7767395119486, 3673.742838001341, 3988.0, 4144.564820693814, 4147.688923330762, 28207.0, 32261.193470163198, 32384.0, 32723.50914736257, 33400.83299583511, 3384.4754063120254, 3393.6267010628812, 3410.3520331137006, 3419.230673098533, 3458.6714262145056, 496932.0, 504183.0, 504970.0, 505179.4741026308, 505765.0, 61856.0, 62158.37841621526, 62203.377966219756, 62383.0, 62390.68804655947, 35816.64183358185, 36875.81562092226, 36909.630903691155, 37871.431928521095, 37872.0, 17806.91096544509, 17962.371317003843, 17980.9100954497, 18013.0, 18015.18931648079, 12548.0, 12760.234385936874, 13523.729525409437, 13639.454421823215, 13687.384067716977, 19655.803441965396, 20036.0, 20070.498237543885, 20597.382078537667, 20610.07254673543, 6971.675381677465, 8071.919280807234, 8078.7172448964, 8088.716894908767, 8100.473469224482, 905.6332185464897, 1000.9549570269355, 1030.0111892583204, 1088.820344643125, 1103.862017247844, 22536.436589085402, 24486.14298499544, 31106.0, 31332.0, 31426.21434464111, 971.0726256425097, 1022.4938655365493, 1106.5186643809807, 1165.114512970132, 1222.718774681828, 13161.53934612284, 16269.51191464258, 16319.265633046542, 16349.836501635069, 16550.0, 681263.0, 686204.0, 688473.0, 688583.0, 689194.0, 60485.69757151186, 61359.772804544555, 61371.77256454846, 61450.38549614536, 61465.0, 1304.3282709404664, 1347.528365072217, 1426.0374247383184, 1441.128117488925, 1459.2776575595149, 29978.610103376646, 32316.83841580777, 32544.674553254164, 32651.510227346134, 32895.67104329022, 51147.97704045973, 51593.0, 51715.0, 51825.740871295406, 51983.0, 551920.365574422, 556374.0, 557670.0, 559039.0, 560263.0, 23539.764602353756, 27359.0, 27523.587146193222, 28028.159155225378, 28107.297317566405, 48818.75590622024, 49286.75356623194, 49537.75231123821, 49553.75223123861, 50125.74937125291, 40475.0, 43999.12001759883, 44473.777631112935, 45706.0, 46292.30561541512, 36180.45729314115, 40890.79554602208, 42286.57713422826, 44337.0, 45406.31890521579, 42865.57134428616, 42928.78535607302, 43431.39411635312, 43740.56259437365, 43765.34351984659, 35369.11577210487, 35884.0, 41892.1621567573, 42689.786551067045, 42762.57237427586, 27408.725912740618, 28256.434871302048, 28310.433791323645, 28375.006874759285, 28405.715942840307], "value": 21184.06767835319, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [327.89671253555133, 377.38297882961365, 378.8143809533329, 393.6339204539777, 407.25472385534476, 20123.698144527825, 20823.27118550851, 22612.8869355653, 22621.77378226217, 22713.99999999996, 12177.208481448723, 12374.0, 15961.0, 18742.0, 18854.868707877504, 5170.431252562215, 5400.324959380067, 5645.830625081254, 5646.858828529299, 5659.745311460994, 5498.972505137469, 5611.494965453108, 5663.716814159276, 5665.036943719578, 5666.858328541778, 5650.773969041234, 5651.208830763697, 5660.235868157787, 5695.601307908448, 5914.645121292736, 6114.388561143895, 6270.96529072707, 6273.05904114382, 6277.089821975788, 6277.623342599436, 5939.821805345847, 6098.512119030467, 6156.8768624627255, 6162.414570615784, 6180.443760061616, 13672.31638418075, 13938.233397163254, 13940.95442841791, 22256.777432225794, 26337.341566460993, 2192.550527141948, 2226.031676220849, 2278.1001504405667, 2373.905043798246, 2493.463711817909, 9853.408795472295, 10442.686719398354, 10591.0, 10608.840867386996, 10789.514471848786, 1842.3920106364867, 1936.4242087729085, 1973.3290681168328, 1987.681970884666, 2014.9697754533693, 127565.0, 128876.0, 136020.31989839987, 136884.84018219204, 137803.31098344544, 11311.0, 11559.190856639954, 11686.649400517997, 11732.296062236293, 11879.703007424883, 12467.376631168587, 15150.696986060217, 15182.924085379502, 15197.316120774592, 15197.468088616846, 8632.050474447806, 8851.734447966572, 8861.025287218401, 8976.326775491863, 8978.551072446351, 8841.071687472722, 8862.335324850663, 8868.379213455126, 8880.422772519765, 9016.684416045407, 4607.493175750665, 4634.884127896829, 4636.768161591907, 4637.469635020435, 4725.787339569728, 1799.2443173867007, 1802.0989505247376, 1888.4334699590067, 1920.836728878033, 1925.3357591630865, 874.3267683883374, 942.4204114469552, 986.7681094942683, 996.4071377530358, 1032.8605638238892, 20573.382798516068, 21948.34154975353, 21972.230971915906, 22025.449363766034, 22143.0, 911.7902882337099, 998.5706146356991, 1007.7581380468781, 1026.8049070676698, 1033.4729288062993, 9179.95410022959, 11104.389258590854, 11459.885401146048, 11462.48418821155, 11649.41752912351, 614822.0, 617779.0, 618133.9093304505, 629978.0, 633251.0, 83872.58063709643, 110407.44796276127, 110687.0, 125573.37213314058, 133594.0, 1012.7721262715977, 1023.8720159980003, 1066.088494337346, 1070.764431825013, 1071.2019545438698, 19562.51093722668, 20133.6979945298, 20469.488262793548, 20505.589888201856, 20565.280215192397, 55154.72422637861, 55532.72233638968, 56057.15914261371, 56690.14964775449, 57565.136522951354, 73096.6345168292, 80558.0, 81696.59151704203, 83918.58040709757, 84686.7296990558, 4822.42130944289, 5344.545713614386, 7882.605869706606, 7926.762197134095, 8228.670853165806, 12916.418761155583, 12966.416511256828, 12980.805287920877, 13050.54323098687, 13384.464621415034, 11219.214654974074, 11402.0, 11419.31484110956, 11723.003544698797, 11852.348120853436, 11082.778344432905, 11180.832287515856, 11274.069639828525, 11653.0, 11726.88273117258, 11208.27146235492, 11264.09887209005, 11448.255863368855, 11671.066314694634, 11675.3578553177, 8030.317423018875, 8031.678732850854, 8044.798880028046, 8300.086990430927, 8315.875261871197, 8392.748217553482, 10940.070094042096, 10962.397068161328, 11131.888681113409, 11649.359285239394], "value": 9572.612471311764, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1330.7870740681492, 1560.6488540078483, 1722.9052402117886, 1865.5056410051347, 1910.0163415840843, 8829.955850220747, 9436.71689849304, 9443.858342124866, 9444.300025995319, 9458.385204961673, 8221.91778082219, 8467.703630372938, 8757.737267881974, 9043.638254469814, 9058.456492610432, 2384.153625462962, 2439.902403903842, 2442.218490083174, 2443.7434069422634, 2446.571849926265, 2402.0752010476003, 2426.7987346263626, 2439.902403903842, 2445.254197469771, 2450.963235551468, 2414.2153800015067, 2426.648136020276, 2428.1501474483875, 2454.8895299711558, 2458.4345600511892, 2408.6025805742206, 2420.0198919437657, 2427.5751743444825, 2429.9635505467522, 2443.8900249488815, 2401.3156250468705, 2407.1454633604994, 2413.8672373019476, 2416.359664688859, 2418.044872275459, 9080.954595226982, 9088.04575519574, 9126.17864392208, 9129.726108216764, 9190.080991900822, 4605.907881842378, 5602.971985140089, 5604.691741954191, 5605.635633683797, 5608.6073974821775, 3628.455731640249, 3744.5319335083113, 3782.5082739244, 3794.6964242860504, 3810.12367155553, 1097.5006372100675, 1115.2583531951243, 1118.5637601335486, 1144.0, 1145.6276710069178, 12198.573049943298, 12486.875131248662, 12495.625131246077, 12503.624891253277, 12527.185732927423, 4785.712857228577, 4861.319415281863, 4950.975245123751, 4981.875453113628, 4982.853943592994, 10570.995755403379, 10571.894281057244, 10579.206559508068, 10583.523741431654, 10585.84121238182, 5424.240606315119, 5521.834344969658, 5527.944720552823, 5528.612997090165, 5622.662640241599, 4598.724076555351, 4757.762111894392, 4950.975245123751, 5038.370203724535, 5069.797208111708, 4074.4703188585295, 4113.6297733203555, 4164.167166566699, 4219.050713589418, 4242.427272318259, 1286.852012018611, 1303.7131830997166, 1304.693397051692, 1307.6469353274563, 1315.375196781521, 905.6151135767273, 946.5835032585641, 946.9005754395827, 956.4261443134203, 996.9152622027209, 5924.259467566554, 6012.579119461683, 6015.729292181863, 6090.543209259324, 6224.62652240867, 394.838116372286, 444.4799584486159, 458.3903408466731, 458.84857996860956, 461.7552697070558, 4061.898452538651, 4072.1041370898356, 4086.81609327575, 4106.3840423936645, 4191.1827193697545, 10720.892791072145, 11234.7191320216, 11241.100711943025, 11248.887511124783, 11253.662390128145, 11149.888501114885, 11153.498092585853, 11155.219134660658, 11156.888431115747, 11165.106791456665, 8078.959605201936, 8415.789605259795, 8471.152884711479, 8543.35924805642, 8558.78603034929, 6062.787442511603, 6066.484348830399, 6103.0, 6120.785772497941, 6224.439800417803, 8748.737537873874, 10184.847227291448, 10486.370817750654, 10487.213458990454, 10575.682729518127, 9287.582058807235, 10256.07695307426, 10616.734581635521, 10668.733281668021, 10774.838377424188, 6949.131358580177, 7064.717411303491, 7158.821029474305, 7418.295261950106, 7638.770836874903, 8648.82702345937, 8869.97995230531, 8874.023857375812, 8883.022867484442, 8886.155815197546, 7774.989251397282, 7899.68401263943, 7932.246436588515, 7983.960080199562, 8063.959680201796, 6629.204495460575, 7360.300771426706, 7699.538027718355, 7744.7676569703, 7751.573663448565, 7220.783376498714, 7317.67070481819, 7319.414446844133, 7325.706971721284, 7336.303051210127, 5072.416672082758, 5109.386873575195, 5167.379914410295, 5291.76187071575, 5417.295751552273, 5192.766325515437, 5220.791168353223, 5300.257963884982, 5348.5186333230195, 5467.58993075513], "value": 4666.070672363954, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [300.6107091316746, 300.77291644808173, 309.08202638164653, 312.1369413571475, 312.4344935666445, 5143.8456846294575, 5335.706536140511, 5379.757910894009, 5415.860735009674, 5448.45515448455, 5276.551493123089, 5277.076511610462, 5289.603279754024, 5294.682319060859, 5305.920411193835, 3167.9366412671734, 3353.547271118392, 4059.289624315748, 4077.347624380085, 4135.8966025849295, 3953.308171070066, 4102.835886564534, 4103.6252855293515, 4109.9178016439655, 4115.650169735561, 3573.9099574629727, 3732.682721968636, 3912.43269725891, 3963.564007959122, 4032.7700051484285, 3841.8271177797064, 3898.9805050974564, 4018.819153138116, 4033.8184781684895, 4053.716239863196, 3514.5782506099176, 3528.7353448491467, 3544.85820567177, 3550.7692000020174, 3555.6977656898935, 4493.955060449386, 4949.851504454872, 5184.248283998799, 5197.818076367309, 5262.578993680497, 3849.595792441781, 4124.443200167969, 4333.328334108187, 4632.65652960641, 4664.790084446174, 4563.744970133207, 4858.854234372974, 5481.75332110056, 5529.972350138264, 5621.662700237958, 3044.5128779395413, 3779.622037796226, 3851.6340947609933, 3891.1439483313625, 3904.7852368119743, 5374.301340825707, 5555.8888822223325, 5824.301083869963, 5847.970760146172, 5862.098261360611, 3859.6912247020173, 3859.9421008684894, 3874.748141370802, 3888.2612303662213, 3926.7447615904875, 3143.3713257348622, 3493.4410494320787, 3650.5619325681087, 3947.822347994347, 3964.365701487748, 3825.483559719458, 4555.385023021916, 4568.474625418053, 4572.88567785808, 4574.702644328175, 5548.667079975134, 5573.832785016456, 5584.93886161628, 5596.888062238732, 5660.311352107716, 1260.5966090850839, 1266.9049821263443, 1304.584525789529, 1330.2284674888542, 1348.730253949214, 752.27405553641, 872.3021582733787, 879.2262808728278, 897.228383590112, 917.2386918857466, 4683.8360657376825, 5261.421243663194, 5277.736113194325, 5309.787608495617, 5337.733113344395, 4963.60291176705, 5311.335178726744, 5741.048043665174, 5773.422657734277, 5821.330546987066, 4185.016521117535, 4560.635149188057, 5261.421243663194, 5269.262303277545, 5294.205869119663, 2358.5282943411385, 2429.757024297556, 2504.461540768707, 2520.987395063013, 2537.4037101281183, 4613.3771940787565, 4918.319515863863, 4930.408350997904, 5156.793728250828, 5953.226080609493, 4735.526447355237, 5194.68831870089, 5977.742130538867, 5979.133025711334, 5979.730912108966, 5635.534760962098, 6034.39656034393, 6045.425684559959, 6053.182820319201, 6103.633781973007, 5351.357837059578, 5627.915581266202, 5764.250647415809, 5823.854403639943, 5832.445917637818, 4336.959129808886, 5674.546036317167, 5729.942700572941, 5737.713114344183, 5758.337791154071, 4782.928256076092, 5748.281464816898, 5985.910211346921, 5986.820395388146, 6115.449609534985, 3840.7695538267794, 3852.056246219694, 3891.8248678808955, 3900.317444447267, 3904.863329783444, 5836.445537673914, 5851.239338885917, 5867.882642347044, 5879.942429936324, 5893.2044174035955, 4325.205039908403, 4738.644601654959, 5672.631278967019, 5682.516986056232, 5717.628354156966, 5002.149634562206, 5691.7438715257085, 5713.771449141987, 5713.8285851424525, 5718.911787634631, 4787.952120478751, 5141.485851414828, 5343.599230057839, 5419.485148910847, 5543.8891222176135, 4705.858824235278, 5626.718664066699, 5661.377248502579, 5669.744861481161, 5670.5180059695385, 4936.4569897311985, 5247.89504209906, 5517.2275881377445, 5544.112941929272, 5556.305461817273], "value": 4046.5283352905617, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [751.5227830327743, 779.1118125337117, 801.6271240383708, 816.7182322098876, 848.7368915636154, 15883.920580397096, 16778.41275555356, 16906.492805215865, 16928.57678558035, 16939.491815245532, 13994.020418570704, 14985.325660345283, 15259.694806103871, 15270.541883743506, 15968.840311596881, 872.2411501993274, 876.1457578860624, 878.7715194049529, 879.7360791762445, 881.5636260051284, 737.72704099483, 762.5386641082149, 886.3485338276394, 910.7723069232692, 912.338554547954, 968.9951550242274, 972.1445128287097, 973.5862258540128, 973.897740737223, 977.6773664690635, 962.3311798300114, 963.4460185393392, 965.4303960663173, 967.632299726103, 969.8739163908717, 705.9929400705979, 708.7554793596202, 710.7761055267574, 711.4592909388901, 714.9918614753173, 15238.923805380902, 15324.0, 15455.61360965985, 15741.370345186293, 15778.368865245377, 13737.313134343343, 15001.249937503191, 15173.013754106058, 15173.089614623048, 15335.539933802003, 13431.597052088453, 13502.662433439144, 13604.0, 13800.0, 13812.930935345259, 4700.623950084019, 4758.2624693172265, 4811.278308253755, 4819.927701084486, 4940.827071052532, 124982.75017249893, 125351.0, 130496.0, 134217.0, 134797.0, 9617.278704097082, 11204.103671706243, 11322.337572843187, 11512.30926144434, 11796.646100616996, 21816.781832181794, 22055.779442205694, 22057.669134962987, 22079.558408831734, 22096.88951555232, 7918.406119541058, 7936.722214722457, 7947.880781788278, 8009.399295052895, 8465.28045116172, 4548.522405147478, 4615.607673347736, 4674.462436819809, 4736.526347365305, 4770.522947705202, 3462.1690794209208, 3535.2752685699884, 3539.681428671432, 3545.911352216164, 3564.0733409313766, 577.3014652270799, 654.0483596367275, 657.7796438193163, 658.5324419661998, 659.1661548141604, 564.0833645326345, 628.4972022382167, 645.4771634975684, 647.4108561209277, 657.4083325007532, 8441.915580844236, 9472.95263523678, 9498.477583732962, 9529.714108576754, 9602.711918642452, 537.9435159308294, 590.9349971503132, 631.3875540725489, 660.893004217933, 675.321302091395, 4242.0, 4608.585227329557, 4618.745968971739, 4641.118187544355, 4761.0, 120170.0, 162266.18866905826, 167323.0, 169943.0, 175839.0, 117984.0, 117988.41005795088, 118848.0, 132314.0, 146914.26542867217, 76309.0, 87735.68396474059, 104064.0, 117456.0, 119680.0, 9799.902000979899, 10059.19526437898, 10112.191024718151, 10113.69658910234, 10123.848142278019, 64661.0, 64840.675796620715, 66482.0, 66832.66583667051, 68712.0, 76957.0, 97486.0, 98754.0, 102216.0, 103711.0, 13489.797653035408, 13510.392032358372, 13575.932120339336, 13760.518381856587, 13839.723205536035, 14851.17099966276, 14854.33155507983, 15237.085774853544, 15348.155851427831, 15835.604109897346, 14595.85404145945, 14713.411463541339, 14744.410223590936, 15327.540173794803, 15389.076655400711, 14478.855211447752, 14627.488037919047, 14638.560843174722, 14756.114633122046, 15273.465428709942, 11352.318860868374, 12060.216085954386, 13736.862631373559, 13765.38055787512, 14847.480338188112, 11555.364454955059, 11828.76342473163, 12014.279143251433, 12181.208221465577, 12279.140460167702, 11998.340091295062, 12079.879201208227, 12242.510299587917, 12286.447109880255, 12375.69060773488], "value": 8196.640699764625, "unit": "score"}], "name": "dromaeo_css", "value": 7524.367408526006, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 112.0, 111.0, 111.0, 112.0, 112.0, 111.0, 113.0, 112.0, 112.0], "value": 112.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 109.0, 110.0, 167.0, 138.0, 109.0, 108.0, 106.0, 133.0, 108.0], "value": 123.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 181.0, 184.0, 183.0, 179.0, 181.0, 180.0, 180.0, 183.0, 183.0], "value": 181.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 59.0, 58.0, 87.0, 60.0, 58.0, 58.0, 76.0, 101.0, 82.0], "value": 73.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 65.0, 94.0, 70.0, 68.0, 68.0, 91.0, 67.0, 66.0, 90.0], "value": 76.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 84.0, 90.0, 125.0, 87.0, 84.0, 89.0, 86.0, 87.0, 85.0], "value": 90.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 102.0, 140.0, 93.0, 92.0, 92.0, 93.0, 94.0, 92.0, 93.0], "value": 98.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 83.0, 82.0, 83.0, 84.0, 84.0, 83.0, 86.0, 83.0, 86.0], "value": 84.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 54.0, 55.0, 53.0, 54.0, 54.0, 56.0, 54.0, 55.0, 55.0], "value": 54.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 71.0, 69.0, 70.0, 70.0, 68.0, 69.0, 68.0, 68.0, 69.0], "value": 68.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 82.0, 80.0, 83.0, 82.0, 80.0, 81.0, 87.0, 88.0, 81.0], "value": 82.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 142.0, 152.0, 146.0, 153.0, 147.0, 152.0, 151.0, 164.0, 130.0], "value": 147.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 163.0, 160.0, 162.0, 222.0, 195.0, 158.0, 162.0, 161.0, 160.0], "value": 170.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 73.0, 66.0, 66.0, 67.0, 66.0, 63.0, 63.0, 66.0, 64.0], "value": 66.2, "unit": "score"}], "name": "kraken", "value": 1429.2000000000003, "alertThreshold": 2.0}]} 04:55:00 INFO - Return code: 0 04:55:00 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:55:00 INFO - # TBPL SUCCESS # 04:55:00 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:55:00 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:55:00 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:55:00 INFO - 2016-11-23 04:55:00.835 screenresolution[1793:9900] starting screenresolution argv=screenresolution get 04:55:00 INFO - 2016-11-23 04:55:00.837 screenresolution[1793:9900] Display 0: 1600x1200x32@60 04:55:00 INFO - 2016-11-23 04:55:00.843 screenresolution[1794:9903] starting screenresolution argv=screenresolution list 04:55:00 INFO - Available Modes on Display 0 04:55:00 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:55:00 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:55:00 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:55:00 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:55:01 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:55:01 INFO - Intel Iris: 04:55:01 INFO - Chipset Model: Intel Iris 04:55:01 INFO - Type: GPU 04:55:01 INFO - Bus: Built-In 04:55:01 INFO - VRAM (Dynamic, Max): 1536 MB 04:55:01 INFO - Vendor: Intel (0x8086) 04:55:01 INFO - Device ID: 0x0a2e 04:55:01 INFO - Revision ID: 0x0009 04:55:01 INFO - Displays: 04:55:01 INFO - Display: 04:55:01 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:55:01 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:55:01 INFO - Display Serial Number: 1600x1200 60 04:55:01 INFO - Main Display: Yes 04:55:01 INFO - Mirror: Off 04:55:01 INFO - Online: Yes 04:55:01 INFO - Rotation: Supported 04:55:01 INFO - Return code: 0 04:55:01 INFO - Running post-action listener: _resource_record_post_action 04:55:01 INFO - [mozharness: 2016-11-23 12:55:01.077120Z] Finished run-tests step (success) 04:55:01 INFO - Running post-run listener: _resource_record_post_run 04:55:01 INFO - Total resource usage - Wall time: 1195s; CPU: 53.0%; Read bytes: 37704704; Write bytes: 499917312; Read time: 242; Write time: 1643 04:55:01 INFO - TinderboxPrint: CPU usage
53.3% 04:55:01 INFO - TinderboxPrint: I/O read bytes / time
37,704,704 / 242 04:55:01 INFO - TinderboxPrint: I/O write bytes / time
499,917,312 / 1,643 04:55:01 INFO - TinderboxPrint: CPU idle
2,234.7 (46.7%) 04:55:01 INFO - TinderboxPrint: CPU system
955.0 (20.0%) 04:55:01 INFO - TinderboxPrint: CPU user
1,591.8 (33.3%) 04:55:01 INFO - TinderboxPrint: Swap in / out
233,005,056 / 0 04:55:01 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 196139520; Write bytes: 200337408; Read time: 17816; Write time: 469 04:55:01 INFO - run-tests - Wall time: 1174s; CPU: 53.0%; Read bytes: 34550784; Write bytes: 298207744; Read time: 217; Write time: 1169 04:55:01 INFO - Running post-run listener: _upload_blobber_files 04:55:01 INFO - Blob upload gear active. 04:55:01 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:55:01 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 04:55:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:55:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:55:01 INFO - (blobuploader) - INFO - Open directory for files ... 04:55:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:55:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:55:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:55:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:55:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:55:03 INFO - (blobuploader) - INFO - Done attempting. 04:55:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:55:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:55:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:55:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:55:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:55:04 INFO - (blobuploader) - INFO - Done attempting. 04:55:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:55:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:55:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:55:06 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:55:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:55:06 INFO - (blobuploader) - INFO - Done attempting. 04:55:06 INFO - (blobuploader) - INFO - Iteration through files over. 04:55:06 INFO - Return code: 0 04:55:06 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:55:06 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:55:06 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/436395cf86f3bc6a7fa9379f09182ebc3fcdfe9ba41b90748bbd6e2730f28bff3a39e44e42cf3082b007c5dfd7727683966dac70e0a47ea690686dd57c266210", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d3ee0314747eab682f569093b87f710673aca5a8e8e0e037cec56666d31db16afa2cf52977935afe6cf2974d07f74790ec673b34221f4ef6c552b6dcaa51ce4c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5f488129212652841e5e9911b4e3bfeca039aa28d52a64595354fbeb5b01d468937bdfadf4306500cfad05c63619385c0e888c53fb16c33f69920fb2b2c19ee1"} 04:55:06 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:55:06 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:55:06 INFO - Contents: 04:55:06 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/436395cf86f3bc6a7fa9379f09182ebc3fcdfe9ba41b90748bbd6e2730f28bff3a39e44e42cf3082b007c5dfd7727683966dac70e0a47ea690686dd57c266210", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d3ee0314747eab682f569093b87f710673aca5a8e8e0e037cec56666d31db16afa2cf52977935afe6cf2974d07f74790ec673b34221f4ef6c552b6dcaa51ce4c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5f488129212652841e5e9911b4e3bfeca039aa28d52a64595354fbeb5b01d468937bdfadf4306500cfad05c63619385c0e888c53fb16c33f69920fb2b2c19ee1"} 04:55:06 INFO - Running post-run listener: copy_logs_to_upload_dir 04:55:06 INFO - Copying logs to upload dir... 04:55:06 INFO - mkdir: /builds/slave/test/build/upload/logs 04:55:06 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1256.596109 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2016-11-23 04:55:06.637923) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-23 04:55:06.642331) ========= 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.v6imJRwm8z/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.EYM9NlmkIj/Listeners TMPDIR=/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/436395cf86f3bc6a7fa9379f09182ebc3fcdfe9ba41b90748bbd6e2730f28bff3a39e44e42cf3082b007c5dfd7727683966dac70e0a47ea690686dd57c266210", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d3ee0314747eab682f569093b87f710673aca5a8e8e0e037cec56666d31db16afa2cf52977935afe6cf2974d07f74790ec673b34221f4ef6c552b6dcaa51ce4c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5f488129212652841e5e9911b4e3bfeca039aa28d52a64595354fbeb5b01d468937bdfadf4306500cfad05c63619385c0e888c53fb16c33f69920fb2b2c19ee1"} build_url:https://queue.taskcluster.net/v1/task/BqfqjsLyRHaeQstCWBwxnA/artifacts/public/build/firefox-51.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011093 build_url: 'https://queue.taskcluster.net/v1/task/BqfqjsLyRHaeQstCWBwxnA/artifacts/public/build/firefox-51.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/436395cf86f3bc6a7fa9379f09182ebc3fcdfe9ba41b90748bbd6e2730f28bff3a39e44e42cf3082b007c5dfd7727683966dac70e0a47ea690686dd57c266210", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d3ee0314747eab682f569093b87f710673aca5a8e8e0e037cec56666d31db16afa2cf52977935afe6cf2974d07f74790ec673b34221f4ef6c552b6dcaa51ce4c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5f488129212652841e5e9911b4e3bfeca039aa28d52a64595354fbeb5b01d468937bdfadf4306500cfad05c63619385c0e888c53fb16c33f69920fb2b2c19ee1"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-23 04:55:06.677177) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-23 04:55:06.677537) ========= 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.v6imJRwm8z/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.EYM9NlmkIj/Listeners TMPDIR=/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/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.004660 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-23 04:55:06.726511) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-23 04:55:06.726883) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-23 04:55:06.727274) ========= ========= Total master_lag: 0.18 =========