builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0208 starttime: 1484241646.29 results: success (0) buildid: 20170112071716 builduid: e0deb5a2b33a4f15893f866aee1500f8 revision: 5fb0834eba17ac8df15f2cbd34805ecada288c48 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-12 09:20:46.286003) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-12 09:20:46.286472) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-12 09:20:46.286762) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-12 09:20:46.313665) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-12 09:20:46.314091) ========= 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.Sc6RDSgUor/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.fvbnTzQ15p/Listeners TMPDIR=/var/folders/wq/f5xgyhbd75545ndpjmyvls7c00000w/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 --2017-01-12 09:20:46-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 184M=0s 2017-01-12 09:20:46 (184 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.086769 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-12 09:20:46.426745) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-12 09:20:46.427349) ========= 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.Sc6RDSgUor/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.fvbnTzQ15p/Listeners TMPDIR=/var/folders/wq/f5xgyhbd75545ndpjmyvls7c00000w/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.025964 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-12 09:20:46.477204) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-12 09:20:46.477617) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 5fb0834eba17ac8df15f2cbd34805ecada288c48 --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 5fb0834eba17ac8df15f2cbd34805ecada288c48 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Sc6RDSgUor/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.fvbnTzQ15p/Listeners TMPDIR=/var/folders/wq/f5xgyhbd75545ndpjmyvls7c00000w/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 2017-01-12 09:20:46,577 truncating revision to first 12 chars 2017-01-12 09:20:46,577 Setting DEBUG logging. 2017-01-12 09:20:46,578 attempt 1/10 2017-01-12 09:20:46,578 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/5fb0834eba17?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-12 09:20:47,747 unpacking tar archive at: mozilla-beta-5fb0834eba17/testing/mozharness/ program finished with exit code 0 elapsedTime=1.473965 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-12 09:20:47.975484) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-12 09:20:47.975824) ========= script_repo_revision: 5fb0834eba17ac8df15f2cbd34805ecada288c48 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-12 09:20:47.976224) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-12 09:20:47.976492) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-12 09:20:47.995627) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2017-01-12 09:20:47.996042) ========= /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.Sc6RDSgUor/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.fvbnTzQ15p/Listeners TMPDIR=/var/folders/wq/f5xgyhbd75545ndpjmyvls7c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 09:20:48 INFO - MultiFileLogger online at 20170112 09:20:48 in /builds/slave/test 09:20:48 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 09:20:48 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:20:48 INFO - {'append_to_log': False, 09:20:48 INFO - 'base_work_dir': '/builds/slave/test', 09:20:48 INFO - 'blob_upload_branch': 'Mozilla-Beta', 09:20:48 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:20:48 INFO - 'branch': 'Mozilla-Beta', 09:20:48 INFO - 'buildbot_json_path': 'buildprops.json', 09:20:48 INFO - 'config_files': ('talos/mac_config.py',), 09:20:48 INFO - 'default_actions': ('clobber', 09:20:48 INFO - 'read-buildbot-config', 09:20:48 INFO - 'download-and-extract', 09:20:48 INFO - 'populate-webroot', 09:20:48 INFO - 'create-virtualenv', 09:20:48 INFO - 'install', 09:20:48 INFO - 'run-tests'), 09:20:48 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:20:48 INFO - 'download_minidump_stackwalk': True, 09:20:48 INFO - 'download_symbols': 'ondemand', 09:20:48 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:20:48 INFO - 'tooltool.py': '/tools/tooltool.py', 09:20:48 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:20:48 INFO - '/tools/misc-python/virtualenv.py')}, 09:20:48 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:20:48 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:20:48 INFO - 'installer_path': 'installer.exe', 09:20:48 INFO - 'log_level': 'info', 09:20:48 INFO - 'log_name': 'talos', 09:20:48 INFO - 'log_to_console': True, 09:20:48 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 09:20:48 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 09:20:48 INFO - 'opt_config_files': (), 09:20:48 INFO - 'pip_index': False, 09:20:48 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:20:48 INFO - 'cmd': ('bash', 09:20:48 INFO - '-c', 09:20:48 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:20:48 INFO - 'enabled': True, 09:20:48 INFO - 'halt_on_failure': False, 09:20:48 INFO - 'name': 'check_screen_resolution'},), 09:20:48 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:20:48 INFO - 'cmd': ('bash', 09:20:48 INFO - '-c', 09:20:48 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:20:48 INFO - 'enabled': True, 09:20:48 INFO - 'halt_on_failure': False, 09:20:48 INFO - 'name': 'check_screen_resolution'},), 09:20:48 INFO - 'run_cmd_checks_enabled': True, 09:20:48 INFO - 'sps_profile': False, 09:20:48 INFO - 'sps_profile_interval': 0, 09:20:48 INFO - 'suite': 'dromaeojs', 09:20:48 INFO - 'system_bits': '32', 09:20:48 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:20:48 INFO - 'title': 't-yosemite-r7-0208', 09:20:48 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:20:48 INFO - 'use_talos_json': True, 09:20:48 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:20:48 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:20:48 INFO - 'work_dir': 'build'} 09:20:48 INFO - [mozharness: 2017-01-12 17:20:48.197873Z] Running clobber step. 09:20:48 INFO - Running pre-action listener: _resource_record_pre_action 09:20:48 INFO - Running main action method: clobber 09:20:48 INFO - rmtree: /builds/slave/test/build 09:20:48 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:20:50 INFO - Running post-action listener: _resource_record_post_action 09:20:50 INFO - [mozharness: 2017-01-12 17:20:50.321231Z] Finished clobber step (success) 09:20:50 INFO - [mozharness: 2017-01-12 17:20:50.321393Z] Running read-buildbot-config step. 09:20:50 INFO - Running pre-action listener: _resource_record_pre_action 09:20:50 INFO - Running main action method: read_buildbot_config 09:20:50 INFO - Using buildbot properties: 09:20:50 INFO - { 09:20:50 INFO - "project": "", 09:20:50 INFO - "product": "firefox", 09:20:50 INFO - "script_repo_revision": "production", 09:20:50 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 09:20:50 INFO - "repository": "", 09:20:50 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 09:20:50 INFO - "buildid": "20170112071716", 09:20:50 INFO - "pgo_build": "False", 09:20:50 INFO - "basedir": "/builds/slave/test", 09:20:50 INFO - "buildnumber": 15, 09:20:50 INFO - "slavename": "t-yosemite-r7-0208", 09:20:50 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 09:20:50 INFO - "platform": "yosemite_r7", 09:20:50 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 09:20:50 INFO - "branch": "mozilla-beta", 09:20:50 INFO - "repo_path": "releases/mozilla-beta", 09:20:50 INFO - "revision": "5fb0834eba17ac8df15f2cbd34805ecada288c48", 09:20:50 INFO - "stage_platform": "macosx64", 09:20:50 INFO - "builduid": "e0deb5a2b33a4f15893f866aee1500f8", 09:20:50 INFO - "slavebuilddir": "test" 09:20:50 INFO - } 09:20:50 INFO - Found installer url https://queue.taskcluster.net/v1/task/ImAQfE_YRgGX_1e-s5VZVw/artifacts/public/build/firefox-51.0.en-US.mac.dmg. 09:20:50 INFO - Running post-action listener: _resource_record_post_action 09:20:50 INFO - [mozharness: 2017-01-12 17:20:50.324296Z] Finished read-buildbot-config step (success) 09:20:50 INFO - [mozharness: 2017-01-12 17:20:50.324401Z] Running download-and-extract step. 09:20:50 INFO - Running pre-action listener: _resource_record_pre_action 09:20:50 INFO - Running main action method: download_and_extract 09:20:50 INFO - mkdir: /builds/slave/test/build/tests 09:20: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')]} 09:20:50 INFO - trying https://queue.taskcluster.net/v1/task/ImAQfE_YRgGX_1e-s5VZVw/artifacts/public/build/firefox-51.0.en-US.mac.test_packages.json 09:20:50 INFO - Downloading https://queue.taskcluster.net/v1/task/ImAQfE_YRgGX_1e-s5VZVw/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 09:20:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ImAQfE_YRgGX_1e-s5VZVw/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 09:20:51 INFO - Downloaded 1165 bytes. 09:20:51 INFO - Reading from file /builds/slave/test/build/firefox-51.0.en-US.mac.test_packages.json 09:20:51 INFO - Using the following test package requirements: 09:20:51 INFO - {u'common': [u'firefox-51.0.en-US.mac.common.tests.zip'], 09:20:51 INFO - u'cppunittest': [u'firefox-51.0.en-US.mac.common.tests.zip', 09:20:51 INFO - u'firefox-51.0.en-US.mac.cppunittest.tests.zip'], 09:20:51 INFO - u'gtest': [u'firefox-51.0.en-US.mac.common.tests.zip', 09:20:51 INFO - u'firefox-51.0.en-US.mac.gtest.tests.zip'], 09:20:51 INFO - u'jittest': [u'firefox-51.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 09:20:51 INFO - u'mochitest': [u'firefox-51.0.en-US.mac.common.tests.zip', 09:20:51 INFO - u'firefox-51.0.en-US.mac.mochitest.tests.zip'], 09:20:51 INFO - u'mozbase': [u'firefox-51.0.en-US.mac.common.tests.zip'], 09:20:51 INFO - u'reftest': [u'firefox-51.0.en-US.mac.common.tests.zip', 09:20:51 INFO - u'firefox-51.0.en-US.mac.reftest.tests.zip'], 09:20:51 INFO - u'talos': [u'firefox-51.0.en-US.mac.common.tests.zip', 09:20:51 INFO - u'firefox-51.0.en-US.mac.talos.tests.zip'], 09:20:51 INFO - u'web-platform': [u'firefox-51.0.en-US.mac.common.tests.zip', 09:20:51 INFO - u'firefox-51.0.en-US.mac.web-platform.tests.zip'], 09:20:51 INFO - u'xpcshell': [u'firefox-51.0.en-US.mac.common.tests.zip', 09:20:51 INFO - u'firefox-51.0.en-US.mac.xpcshell.tests.zip']} 09:20:51 INFO - Downloading packages: [u'firefox-51.0.en-US.mac.common.tests.zip'] for test suite category: common 09:20:51 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ImAQfE_YRgGX_1e-s5VZVw/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip 09:20:51 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ImAQfE_YRgGX_1e-s5VZVw/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip'}, attempt #1 09:20:51 INFO - Fetch https://queue.taskcluster.net/v1/task/ImAQfE_YRgGX_1e-s5VZVw/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip into memory 09:20:51 INFO - Expected file size: 16236068 09:20:58 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 09:20:58 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ImAQfE_YRgGX_1e-s5VZVw/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip 09:20:58 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ImAQfE_YRgGX_1e-s5VZVw/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip'}, attempt #1 09:20:58 INFO - Fetch https://queue.taskcluster.net/v1/task/ImAQfE_YRgGX_1e-s5VZVw/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip into memory 09:20:59 INFO - Expected file size: 16236068 09:21:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ImAQfE_YRgGX_1e-s5VZVw/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip 09:21:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ImAQfE_YRgGX_1e-s5VZVw/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip'}, attempt #1 09:21:05 INFO - Fetch https://queue.taskcluster.net/v1/task/ImAQfE_YRgGX_1e-s5VZVw/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip into memory 09:21:06 INFO - Expected file size: 14414089 09:21:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:21:06 INFO - trying https://queue.taskcluster.net/v1/task/ImAQfE_YRgGX_1e-s5VZVw/artifacts/public/build/firefox-51.0.en-US.mac.dmg 09:21:06 INFO - Downloading https://queue.taskcluster.net/v1/task/ImAQfE_YRgGX_1e-s5VZVw/artifacts/public/build/firefox-51.0.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0.en-US.mac.dmg 09:21:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ImAQfE_YRgGX_1e-s5VZVw/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 09:21:09 INFO - Downloaded 86145647 bytes. 09:21:09 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ImAQfE_YRgGX_1e-s5VZVw/artifacts/public/build/firefox-51.0.en-US.mac.dmg 09:21:09 INFO - mkdir: /builds/slave/test/properties 09:21:09 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:21:09 INFO - Writing to file /builds/slave/test/properties/build_url 09:21:09 INFO - Contents: 09:21:09 INFO - build_url:https://queue.taskcluster.net/v1/task/ImAQfE_YRgGX_1e-s5VZVw/artifacts/public/build/firefox-51.0.en-US.mac.dmg 09:21:10 INFO - Running post-action listener: _resource_record_post_action 09:21:10 INFO - Running post-action listener: set_extra_try_arguments 09:21:10 INFO - [mozharness: 2017-01-12 17:21:10.003228Z] Finished download-and-extract step (success) 09:21:10 INFO - [mozharness: 2017-01-12 17:21:10.003356Z] Running populate-webroot step. 09:21:10 INFO - Running pre-action listener: _resource_record_pre_action 09:21:10 INFO - Running main action method: populate_webroot 09:21:10 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:21:10 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:21:10 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:21:10 INFO - '--tppagecycles', 09:21:10 INFO - '7'], 09:21:10 INFO - 'tests': ['tsvgm']}}, 09:21:10 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:21:10 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:21:10 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:21:10 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:21:10 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:21:10 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:21:10 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:21:10 INFO - 'talos_options': ['--disable-e10s'], 09:21:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:21:10 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:21:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:21:10 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:21:10 INFO - 'talos_options': ['--disable-e10s'], 09:21:10 INFO - 'tests': ['damp', 'tps']}, 09:21:10 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:21:10 INFO - 'tests': ['damp', 'tps']}, 09:21:10 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:21:10 INFO - 'tests': ['dromaeo_dom']}, 09:21:10 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:21:10 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:21:10 INFO - 'tests': ['basic_compositor_video']}, 09:21:10 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:21:10 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:21:10 INFO - 'tests': ['a11yr', 09:21:10 INFO - 'ts_paint', 09:21:10 INFO - 'tpaint', 09:21:10 INFO - 'sessionrestore', 09:21:10 INFO - 'sessionrestore_no_auto_restore', 09:21:10 INFO - 'tabpaint']}, 09:21:10 INFO - 'other-e10s': {'tests': ['a11yr', 09:21:10 INFO - 'ts_paint', 09:21:10 INFO - 'tpaint', 09:21:10 INFO - 'sessionrestore', 09:21:10 INFO - 'sessionrestore_no_auto_restore', 09:21:10 INFO - 'tabpaint']}, 09:21:10 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:21:10 INFO - 'ts_paint', 09:21:10 INFO - 'tpaint', 09:21:10 INFO - 'sessionrestore', 09:21:10 INFO - 'sessionrestore_no_auto_restore', 09:21:10 INFO - 'tabpaint']}, 09:21:10 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:21:10 INFO - 'ts_paint', 09:21:10 INFO - 'tpaint', 09:21:10 INFO - 'sessionrestore', 09:21:10 INFO - 'sessionrestore_no_auto_restore', 09:21:10 INFO - 'tabpaint']}, 09:21:10 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:21:10 INFO - 'tests': ['a11yr', 09:21:10 INFO - 'ts_paint', 09:21:10 INFO - 'tpaint', 09:21:10 INFO - 'sessionrestore', 09:21:10 INFO - 'sessionrestore_no_auto_restore', 09:21:10 INFO - 'tabpaint']}, 09:21:10 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:21:10 INFO - 'tests': ['a11yr', 09:21:10 INFO - 'ts_paint', 09:21:10 INFO - 'tpaint', 09:21:10 INFO - 'sessionrestore', 09:21:10 INFO - 'sessionrestore_no_auto_restore', 09:21:10 INFO - 'tabpaint']}, 09:21:10 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:21:10 INFO - 'tests': ['tsvgx', 09:21:10 INFO - 'tsvgr_opacity', 09:21:10 INFO - 'tart', 09:21:10 INFO - 'tscrollx', 09:21:10 INFO - 'cart']}, 09:21:10 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:21:10 INFO - 'tsvgr_opacity', 09:21:10 INFO - 'tart', 09:21:10 INFO - 'tscrollx', 09:21:10 INFO - 'cart']}, 09:21:10 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:21:10 INFO - 'talos_options': ['--disable-e10s'], 09:21:10 INFO - 'tests': ['tp5o']}, 09:21:10 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:21:10 INFO - 'tests': ['tp5o']}, 09:21:10 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:21:10 INFO - 'talos_options': ['--disable-e10s', 09:21:10 INFO - '--xperf_path', 09:21:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:21:10 INFO - 'tests': ['tp5n']}, 09:21:10 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:21:10 INFO - 'talos_options': ['--xperf_path', 09:21:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:21:10 INFO - 'tests': ['tp5n']}}, 09:21:10 INFO - 'talos.zip': {'path': '', 09:21:10 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:21:10 INFO - Running post-action listener: _resource_record_post_action 09:21:10 INFO - [mozharness: 2017-01-12 17:21:10.022323Z] Finished populate-webroot step (success) 09:21:10 INFO - [mozharness: 2017-01-12 17:21:10.022454Z] Running create-virtualenv step. 09:21:10 INFO - Running pre-action listener: _resource_record_pre_action 09:21:10 INFO - Running main action method: create_virtualenv 09:21:10 INFO - Creating virtualenv /builds/slave/test/build/venv 09:21:10 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 09:21:10 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:21:10 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:21:10 INFO - Using real prefix '/tools/python27' 09:21:10 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:21:10 INFO - Installing distribute.............................................................................................................................................................................................done. 09:21:13 INFO - Installing pip.................done. 09:21:13 INFO - Return code: 0 09:21:13 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:21:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:21:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:21:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:21:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:21:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103954490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1038ca570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb878cce580>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103768d30>, '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 0x1035cedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103760b20>, '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.Sc6RDSgUor/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.fvbnTzQ15p/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wq/f5xgyhbd75545ndpjmyvls7c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:21:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 09:21:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:21:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Sc6RDSgUor/Render', 09:21:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:21:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:21:13 INFO - 'HOME': '/Users/cltbld', 09:21:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:21:13 INFO - 'LOGNAME': 'cltbld', 09:21:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:21:13 INFO - 'MOZ_NO_REMOTE': '1', 09:21:13 INFO - 'NO_EM_RESTART': '1', 09:21:13 INFO - 'PAGER': '/bin/cat', 09:21:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:21:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:21:13 INFO - 'PWD': '/builds/slave/test', 09:21:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:21:13 INFO - 'SHELL': '/bin/bash', 09:21:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fvbnTzQ15p/Listeners', 09:21:13 INFO - 'TMPDIR': '/var/folders/wq/f5xgyhbd75545ndpjmyvls7c00000w/T/', 09:21:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:21:13 INFO - 'USER': 'cltbld', 09:21:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:21:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:21:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:21:13 INFO - 'XPC_FLAGS': '0x0', 09:21:13 INFO - 'XPC_SERVICE_NAME': '0', 09:21:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:21:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:21:14 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 09:21:14 INFO - Cleaning up... 09:21:14 INFO - Return code: 0 09:21:14 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:21:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:21:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:21:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:21:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:21:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:14 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 0x103954490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1038ca570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb878cce580>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103768d30>, '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 0x1035cedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103760b20>, '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.Sc6RDSgUor/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.fvbnTzQ15p/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wq/f5xgyhbd75545ndpjmyvls7c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:21:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 09:21:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 09:21:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Sc6RDSgUor/Render', 09:21:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:21:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:21:14 INFO - 'HOME': '/Users/cltbld', 09:21:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:21:14 INFO - 'LOGNAME': 'cltbld', 09:21:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:21:14 INFO - 'MOZ_NO_REMOTE': '1', 09:21:14 INFO - 'NO_EM_RESTART': '1', 09:21:14 INFO - 'PAGER': '/bin/cat', 09:21:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:21:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:21:14 INFO - 'PWD': '/builds/slave/test', 09:21:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:21:14 INFO - 'SHELL': '/bin/bash', 09:21:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fvbnTzQ15p/Listeners', 09:21:14 INFO - 'TMPDIR': '/var/folders/wq/f5xgyhbd75545ndpjmyvls7c00000w/T/', 09:21:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:21:14 INFO - 'USER': 'cltbld', 09:21:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:21:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:21:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:21:14 INFO - 'XPC_FLAGS': '0x0', 09:21:14 INFO - 'XPC_SERVICE_NAME': '0', 09:21:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:21:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:21:14 INFO - Downloading/unpacking psutil>=3.1.1 09:21:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:21:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:21:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:21:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:21:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:21:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:21:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:21:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:21:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:21:17 INFO - Installing collected packages: psutil 09:21:17 INFO - Running setup.py install for psutil 09:21:17 INFO - building 'psutil._psutil_osx' extension 09:21:17 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 09:21:18 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 09:21:18 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 09:21:18 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 09:21:18 INFO - building 'psutil._psutil_posix' extension 09:21:18 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 09:21:18 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 09:21:18 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 09:21:18 INFO - ^ 09:21:18 INFO - 1 warning generated. 09:21:18 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 09:21:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:21:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:21:19 INFO - Successfully installed psutil 09:21:19 INFO - Cleaning up... 09:21:19 INFO - Return code: 0 09:21:19 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:21:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:21:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:21:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:21:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:21:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:19 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 0x103954490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1038ca570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb878cce580>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103768d30>, '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 0x1035cedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103760b20>, '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.Sc6RDSgUor/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.fvbnTzQ15p/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wq/f5xgyhbd75545ndpjmyvls7c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:21:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 09:21:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 09:21:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Sc6RDSgUor/Render', 09:21:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:21:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:21:19 INFO - 'HOME': '/Users/cltbld', 09:21:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:21:19 INFO - 'LOGNAME': 'cltbld', 09:21:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:21:19 INFO - 'MOZ_NO_REMOTE': '1', 09:21:19 INFO - 'NO_EM_RESTART': '1', 09:21:19 INFO - 'PAGER': '/bin/cat', 09:21:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:21:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:21:19 INFO - 'PWD': '/builds/slave/test', 09:21:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:21:19 INFO - 'SHELL': '/bin/bash', 09:21:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fvbnTzQ15p/Listeners', 09:21:19 INFO - 'TMPDIR': '/var/folders/wq/f5xgyhbd75545ndpjmyvls7c00000w/T/', 09:21:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:21:19 INFO - 'USER': 'cltbld', 09:21:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:21:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:21:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:21:19 INFO - 'XPC_FLAGS': '0x0', 09:21:19 INFO - 'XPC_SERVICE_NAME': '0', 09:21:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:21:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:21:19 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:21:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:21:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:21:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:21:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:21:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:21:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:21:21 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:21:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:21:22 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:21:22 INFO - Installing collected packages: mozsystemmonitor 09:21:22 INFO - Running setup.py install for mozsystemmonitor 09:21:22 INFO - Successfully installed mozsystemmonitor 09:21:22 INFO - Cleaning up... 09:21:22 INFO - Return code: 0 09:21:22 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:21:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:21:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:21:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:21:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:21:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:22 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 0x103954490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1038ca570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb878cce580>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103768d30>, '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 0x1035cedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103760b20>, '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.Sc6RDSgUor/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.fvbnTzQ15p/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wq/f5xgyhbd75545ndpjmyvls7c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:21:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 09:21:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 09:21:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Sc6RDSgUor/Render', 09:21:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:21:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:21:22 INFO - 'HOME': '/Users/cltbld', 09:21:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:21:22 INFO - 'LOGNAME': 'cltbld', 09:21:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:21:22 INFO - 'MOZ_NO_REMOTE': '1', 09:21:22 INFO - 'NO_EM_RESTART': '1', 09:21:22 INFO - 'PAGER': '/bin/cat', 09:21:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:21:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:21:22 INFO - 'PWD': '/builds/slave/test', 09:21:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:21:22 INFO - 'SHELL': '/bin/bash', 09:21:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fvbnTzQ15p/Listeners', 09:21:22 INFO - 'TMPDIR': '/var/folders/wq/f5xgyhbd75545ndpjmyvls7c00000w/T/', 09:21:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:21:22 INFO - 'USER': 'cltbld', 09:21:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:21:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:21:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:21:22 INFO - 'XPC_FLAGS': '0x0', 09:21:22 INFO - 'XPC_SERVICE_NAME': '0', 09:21:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:21:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:21:22 INFO - Downloading/unpacking jsonschema==2.5.1 09:21:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:21:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:21:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:21:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:21:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:21:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:21:25 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:21:25 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:21:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:21:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:21:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:21:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:21:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:21:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:21:25 INFO - Downloading functools32-3.2.3-2.tar.gz 09:21:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:21:25 INFO - warning: no files found matching '*.txt' 09:21:25 INFO - no previously-included directories found matching 'build' 09:21:25 INFO - no previously-included directories found matching 'dist' 09:21:25 INFO - no previously-included directories found matching '.git*' 09:21:25 INFO - Installing collected packages: jsonschema, functools32 09:21:25 INFO - Running setup.py install for functools32 09:21:25 INFO - warning: no files found matching '*.txt' 09:21:25 INFO - no previously-included directories found matching 'build' 09:21:25 INFO - no previously-included directories found matching 'dist' 09:21:25 INFO - no previously-included directories found matching '.git*' 09:21:25 INFO - Successfully installed jsonschema functools32 09:21:25 INFO - Cleaning up... 09:21:25 INFO - Return code: 0 09:21:25 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:21:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:21:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:21:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:21:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:21:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x103954490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1038ca570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb878cce580>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103768d30>, '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 0x1035cedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103760b20>, '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.Sc6RDSgUor/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.fvbnTzQ15p/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wq/f5xgyhbd75545ndpjmyvls7c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:21:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 09:21:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 09:21:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Sc6RDSgUor/Render', 09:21:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:21:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:21:25 INFO - 'HOME': '/Users/cltbld', 09:21:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:21:25 INFO - 'LOGNAME': 'cltbld', 09:21:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:21:25 INFO - 'MOZ_NO_REMOTE': '1', 09:21:25 INFO - 'NO_EM_RESTART': '1', 09:21:25 INFO - 'PAGER': '/bin/cat', 09:21:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:21:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:21:25 INFO - 'PWD': '/builds/slave/test', 09:21:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:21:25 INFO - 'SHELL': '/bin/bash', 09:21:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fvbnTzQ15p/Listeners', 09:21:25 INFO - 'TMPDIR': '/var/folders/wq/f5xgyhbd75545ndpjmyvls7c00000w/T/', 09:21:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:21:25 INFO - 'USER': 'cltbld', 09:21:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:21:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:21:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:21:25 INFO - 'XPC_FLAGS': '0x0', 09:21:25 INFO - 'XPC_SERVICE_NAME': '0', 09:21:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:21:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:21:26 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:21:26 INFO - Cleaning up... 09:21:26 INFO - Return code: 0 09:21:26 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:21:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:21:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:21:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:21:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:21:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:26 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 0x103954490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1038ca570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb878cce580>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103768d30>, '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 0x1035cedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103760b20>, '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.Sc6RDSgUor/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.fvbnTzQ15p/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wq/f5xgyhbd75545ndpjmyvls7c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:21:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:21:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:21:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Sc6RDSgUor/Render', 09:21:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:21:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:21:26 INFO - 'HOME': '/Users/cltbld', 09:21:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:21:26 INFO - 'LOGNAME': 'cltbld', 09:21:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:21:26 INFO - 'MOZ_NO_REMOTE': '1', 09:21:26 INFO - 'NO_EM_RESTART': '1', 09:21:26 INFO - 'PAGER': '/bin/cat', 09:21:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:21:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:21:26 INFO - 'PWD': '/builds/slave/test', 09:21:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:21:26 INFO - 'SHELL': '/bin/bash', 09:21:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fvbnTzQ15p/Listeners', 09:21:26 INFO - 'TMPDIR': '/var/folders/wq/f5xgyhbd75545ndpjmyvls7c00000w/T/', 09:21:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:21:26 INFO - 'USER': 'cltbld', 09:21:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:21:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:21:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:21:26 INFO - 'XPC_FLAGS': '0x0', 09:21:26 INFO - 'XPC_SERVICE_NAME': '0', 09:21:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:21:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:21:26 INFO - Downloading/unpacking blobuploader==1.2.4 09:21:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:21:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:21:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:21:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:21:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:21:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:21:29 INFO - Downloading blobuploader-1.2.4.tar.gz 09:21:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:21:29 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:21:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:21:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:21:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:21:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:21:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:21:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:21:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:21:29 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:21:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:21:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:21:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:21:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:21:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:21:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:21:30 INFO - Downloading docopt-0.6.1.tar.gz 09:21:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:21:30 INFO - Installing collected packages: blobuploader, requests, docopt 09:21:30 INFO - Running setup.py install for blobuploader 09:21:30 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:21:30 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:21:30 INFO - Running setup.py install for requests 09:21:31 INFO - Running setup.py install for docopt 09:21:31 INFO - Successfully installed blobuploader requests docopt 09:21:31 INFO - Cleaning up... 09:21:31 INFO - Return code: 0 09:21:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:21:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:21:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:21:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:21:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:21:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:31 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 0x103954490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1038ca570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb878cce580>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103768d30>, '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 0x1035cedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103760b20>, '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.Sc6RDSgUor/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.fvbnTzQ15p/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wq/f5xgyhbd75545ndpjmyvls7c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:21:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:21:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:21:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Sc6RDSgUor/Render', 09:21:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:21:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:21:31 INFO - 'HOME': '/Users/cltbld', 09:21:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:21:31 INFO - 'LOGNAME': 'cltbld', 09:21:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:21:31 INFO - 'MOZ_NO_REMOTE': '1', 09:21:31 INFO - 'NO_EM_RESTART': '1', 09:21:31 INFO - 'PAGER': '/bin/cat', 09:21:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:21:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:21:31 INFO - 'PWD': '/builds/slave/test', 09:21:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:21:31 INFO - 'SHELL': '/bin/bash', 09:21:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fvbnTzQ15p/Listeners', 09:21:31 INFO - 'TMPDIR': '/var/folders/wq/f5xgyhbd75545ndpjmyvls7c00000w/T/', 09:21:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:21:31 INFO - 'USER': 'cltbld', 09:21:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:21:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:21:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:21:31 INFO - 'XPC_FLAGS': '0x0', 09:21:31 INFO - 'XPC_SERVICE_NAME': '0', 09:21:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:21:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:21:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:21:31 INFO - Running setup.py (path:/var/folders/wq/f5xgyhbd75545ndpjmyvls7c00000w/T/pip-EuvEND-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:21:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:21:31 INFO - Running setup.py (path:/var/folders/wq/f5xgyhbd75545ndpjmyvls7c00000w/T/pip-nkSdLL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:21:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:21:31 INFO - Running setup.py (path:/var/folders/wq/f5xgyhbd75545ndpjmyvls7c00000w/T/pip-xDPy1Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:21:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:21:32 INFO - Running setup.py (path:/var/folders/wq/f5xgyhbd75545ndpjmyvls7c00000w/T/pip-VkX22R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:21:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:21:32 INFO - Running setup.py (path:/var/folders/wq/f5xgyhbd75545ndpjmyvls7c00000w/T/pip-aIw0z0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:21:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:21:32 INFO - Running setup.py (path:/var/folders/wq/f5xgyhbd75545ndpjmyvls7c00000w/T/pip-gpR2gw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:21:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:21:32 INFO - Running setup.py (path:/var/folders/wq/f5xgyhbd75545ndpjmyvls7c00000w/T/pip-lcFoWe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:21:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:21:32 INFO - Running setup.py (path:/var/folders/wq/f5xgyhbd75545ndpjmyvls7c00000w/T/pip-Kc76dy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:21:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:21:32 INFO - Running setup.py (path:/var/folders/wq/f5xgyhbd75545ndpjmyvls7c00000w/T/pip-Sc84Gv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:21:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:21:32 INFO - Running setup.py (path:/var/folders/wq/f5xgyhbd75545ndpjmyvls7c00000w/T/pip-8I8_Wq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:21:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:21:32 INFO - Running setup.py (path:/var/folders/wq/f5xgyhbd75545ndpjmyvls7c00000w/T/pip-VsAQ9S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:21:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:21:32 INFO - Running setup.py (path:/var/folders/wq/f5xgyhbd75545ndpjmyvls7c00000w/T/pip-nVAiHE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:21:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:21:32 INFO - Running setup.py (path:/var/folders/wq/f5xgyhbd75545ndpjmyvls7c00000w/T/pip-F8dzgy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:21:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:21:33 INFO - Running setup.py (path:/var/folders/wq/f5xgyhbd75545ndpjmyvls7c00000w/T/pip-WQKUOS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:21:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:21:33 INFO - Running setup.py (path:/var/folders/wq/f5xgyhbd75545ndpjmyvls7c00000w/T/pip-QJUKPv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:21:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:21:33 INFO - Running setup.py (path:/var/folders/wq/f5xgyhbd75545ndpjmyvls7c00000w/T/pip-HBsjKg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:21:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:21:33 INFO - Running setup.py (path:/var/folders/wq/f5xgyhbd75545ndpjmyvls7c00000w/T/pip-XzoXlG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:21:33 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:21:33 INFO - Running setup.py install for manifestparser 09:21:33 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:21:33 INFO - Running setup.py install for mozcrash 09:21:33 INFO - Running setup.py install for mozdebug 09:21:33 INFO - Running setup.py install for mozdevice 09:21:34 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:21:34 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:21:34 INFO - Running setup.py install for mozfile 09:21:34 INFO - Running setup.py install for mozhttpd 09:21:34 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:21:34 INFO - Running setup.py install for mozinfo 09:21:34 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:21:34 INFO - Running setup.py install for mozInstall 09:21:34 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:21:34 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:21:34 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:21:34 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:21:34 INFO - Running setup.py install for mozleak 09:21:34 INFO - Running setup.py install for mozlog 09:21:34 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:21:34 INFO - Running setup.py install for moznetwork 09:21:35 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:21:35 INFO - Running setup.py install for mozprocess 09:21:35 INFO - Running setup.py install for mozprofile 09:21:35 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:21:35 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:21:35 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:21:35 INFO - Running setup.py install for mozrunner 09:21:35 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:21:35 INFO - Running setup.py install for mozscreenshot 09:21:35 INFO - Running setup.py install for moztest 09:21:35 INFO - Running setup.py install for mozversion 09:21:36 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:21:36 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:21:36 INFO - Cleaning up... 09:21:36 INFO - Return code: 0 09:21:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:21:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:21:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:21:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:21:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:21:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:36 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 0x103954490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1038ca570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb878cce580>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103768d30>, '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 0x1035cedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103760b20>, '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.Sc6RDSgUor/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.fvbnTzQ15p/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wq/f5xgyhbd75545ndpjmyvls7c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:21:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:21:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:21:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Sc6RDSgUor/Render', 09:21:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:21:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:21:36 INFO - 'HOME': '/Users/cltbld', 09:21:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:21:36 INFO - 'LOGNAME': 'cltbld', 09:21:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:21:36 INFO - 'MOZ_NO_REMOTE': '1', 09:21:36 INFO - 'NO_EM_RESTART': '1', 09:21:36 INFO - 'PAGER': '/bin/cat', 09:21:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:21:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:21:36 INFO - 'PWD': '/builds/slave/test', 09:21:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:21:36 INFO - 'SHELL': '/bin/bash', 09:21:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fvbnTzQ15p/Listeners', 09:21:36 INFO - 'TMPDIR': '/var/folders/wq/f5xgyhbd75545ndpjmyvls7c00000w/T/', 09:21:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:21:36 INFO - 'USER': 'cltbld', 09:21:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:21:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:21:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:21:36 INFO - 'XPC_FLAGS': '0x0', 09:21:36 INFO - 'XPC_SERVICE_NAME': '0', 09:21:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:21:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:21:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:21:36 INFO - Running setup.py (path:/var/folders/wq/f5xgyhbd75545ndpjmyvls7c00000w/T/pip-EsZzSq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:21:36 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 09:21:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:21:36 INFO - Running setup.py (path:/var/folders/wq/f5xgyhbd75545ndpjmyvls7c00000w/T/pip-yPYOxl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:21:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:21:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:21:36 INFO - Running setup.py (path:/var/folders/wq/f5xgyhbd75545ndpjmyvls7c00000w/T/pip-tEXYUU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:21:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:21:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:21:36 INFO - Running setup.py (path:/var/folders/wq/f5xgyhbd75545ndpjmyvls7c00000w/T/pip-RYcIal-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:21:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:21:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:21:36 INFO - Running setup.py (path:/var/folders/wq/f5xgyhbd75545ndpjmyvls7c00000w/T/pip-ytu46b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:21:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 09:21:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:21:36 INFO - Running setup.py (path:/var/folders/wq/f5xgyhbd75545ndpjmyvls7c00000w/T/pip-3GofU1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:21:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 09:21:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:21:36 INFO - Running setup.py (path:/var/folders/wq/f5xgyhbd75545ndpjmyvls7c00000w/T/pip-5bhkfv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:21:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 09:21:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:21:37 INFO - Running setup.py (path:/var/folders/wq/f5xgyhbd75545ndpjmyvls7c00000w/T/pip-wYzVta-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:21:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 09:21:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:21:37 INFO - Running setup.py (path:/var/folders/wq/f5xgyhbd75545ndpjmyvls7c00000w/T/pip-VzKnfh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:21:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 09:21:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:21:37 INFO - Running setup.py (path:/var/folders/wq/f5xgyhbd75545ndpjmyvls7c00000w/T/pip-EN3uT_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:21:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:21:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:21:37 INFO - Running setup.py (path:/var/folders/wq/f5xgyhbd75545ndpjmyvls7c00000w/T/pip-g4HfrL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:21:37 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 09:21:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:21:37 INFO - Running setup.py (path:/var/folders/wq/f5xgyhbd75545ndpjmyvls7c00000w/T/pip-v23sNQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:21:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 09:21:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:21:37 INFO - Running setup.py (path:/var/folders/wq/f5xgyhbd75545ndpjmyvls7c00000w/T/pip-LgXMu3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:21:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 09:21:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:21:37 INFO - Running setup.py (path:/var/folders/wq/f5xgyhbd75545ndpjmyvls7c00000w/T/pip-tvDTba-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:21:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 09:21:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:21:37 INFO - Running setup.py (path:/var/folders/wq/f5xgyhbd75545ndpjmyvls7c00000w/T/pip-edLADT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:21:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 09:21:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:21:37 INFO - Running setup.py (path:/var/folders/wq/f5xgyhbd75545ndpjmyvls7c00000w/T/pip-jIYNXf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:21:38 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 09:21:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:21:38 INFO - Running setup.py (path:/var/folders/wq/f5xgyhbd75545ndpjmyvls7c00000w/T/pip-f6eByV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:21:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 09:21:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:21:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:21:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:21:38 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:21:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:21:38 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:21:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:21:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:21:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:21:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:21:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:21:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:21:40 INFO - Downloading blessings-1.6.tar.gz 09:21:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:21:40 INFO - Installing collected packages: blessings 09:21:40 INFO - Running setup.py install for blessings 09:21:41 INFO - Successfully installed blessings 09:21:41 INFO - Cleaning up... 09:21:41 INFO - Return code: 0 09:21:41 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:21:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:21:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:21:41 INFO - Reading from file tmpfile_stdout 09:21:41 INFO - Current package versions: 09:21:41 INFO - blessings == 1.6 09:21:41 INFO - blobuploader == 1.2.4 09:21:41 INFO - docopt == 0.6.1 09:21:41 INFO - functools32 == 3.2.3-2 09:21:41 INFO - jsonschema == 2.5.1 09:21:41 INFO - manifestparser == 1.1 09:21:41 INFO - mozInstall == 1.12 09:21:41 INFO - mozcrash == 0.17 09:21:41 INFO - mozdebug == 0.1 09:21:41 INFO - mozdevice == 0.48 09:21:41 INFO - mozfile == 1.2 09:21:41 INFO - mozhttpd == 0.7 09:21:41 INFO - mozinfo == 0.9 09:21:41 INFO - mozleak == 0.1 09:21:41 INFO - mozlog == 3.4 09:21:41 INFO - moznetwork == 0.27 09:21:41 INFO - mozprocess == 0.23 09:21:41 INFO - mozprofile == 0.28 09:21:41 INFO - mozrunner == 6.12 09:21:41 INFO - mozscreenshot == 0.1 09:21:41 INFO - mozsystemmonitor == 0.3 09:21:41 INFO - moztest == 0.7 09:21:41 INFO - mozversion == 1.4 09:21:41 INFO - psutil == 3.1.1 09:21:41 INFO - requests == 1.2.3 09:21:41 INFO - wsgiref == 0.1.2 09:21:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:21:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:21:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:21:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:21:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:21:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:41 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 0x103954490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1038ca570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb878cce580>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103768d30>, '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 0x1035cedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103760b20>, '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.Sc6RDSgUor/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.fvbnTzQ15p/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wq/f5xgyhbd75545ndpjmyvls7c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:21:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 09:21:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:21:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Sc6RDSgUor/Render', 09:21:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:21:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:21:41 INFO - 'HOME': '/Users/cltbld', 09:21:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:21:41 INFO - 'LOGNAME': 'cltbld', 09:21:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:21:41 INFO - 'MOZ_NO_REMOTE': '1', 09:21:41 INFO - 'NO_EM_RESTART': '1', 09:21:41 INFO - 'PAGER': '/bin/cat', 09:21:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:21:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:21:41 INFO - 'PWD': '/builds/slave/test', 09:21:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:21:41 INFO - 'SHELL': '/bin/bash', 09:21:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fvbnTzQ15p/Listeners', 09:21:41 INFO - 'TMPDIR': '/var/folders/wq/f5xgyhbd75545ndpjmyvls7c00000w/T/', 09:21:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:21:41 INFO - 'USER': 'cltbld', 09:21:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:21:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:21:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:21:41 INFO - 'XPC_FLAGS': '0x0', 09:21:41 INFO - 'XPC_SERVICE_NAME': '0', 09:21:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:21:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:21:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:21:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 09:21:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 09:21:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:21:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 09:21:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 09:21:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 09:21:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 09:21:41 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 09:21:41 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:21:41 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:21:41 INFO - Cleaning up... 09:21:41 INFO - Return code: 0 09:21:41 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:21:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:21:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:21:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:21:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:21:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103954490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1038ca570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb878cce580>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103768d30>, '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 0x1035cedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103760b20>, '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.Sc6RDSgUor/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.fvbnTzQ15p/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wq/f5xgyhbd75545ndpjmyvls7c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:21:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 09:21:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:21:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Sc6RDSgUor/Render', 09:21:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:21:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:21:41 INFO - 'HOME': '/Users/cltbld', 09:21:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:21:41 INFO - 'LOGNAME': 'cltbld', 09:21:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:21:41 INFO - 'MOZ_NO_REMOTE': '1', 09:21:41 INFO - 'NO_EM_RESTART': '1', 09:21:41 INFO - 'PAGER': '/bin/cat', 09:21:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:21:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:21:41 INFO - 'PWD': '/builds/slave/test', 09:21:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:21:41 INFO - 'SHELL': '/bin/bash', 09:21:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fvbnTzQ15p/Listeners', 09:21:41 INFO - 'TMPDIR': '/var/folders/wq/f5xgyhbd75545ndpjmyvls7c00000w/T/', 09:21:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:21:41 INFO - 'USER': 'cltbld', 09:21:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:21:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:21:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:21:41 INFO - 'XPC_FLAGS': '0x0', 09:21:41 INFO - 'XPC_SERVICE_NAME': '0', 09:21:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:21:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:21:41 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:21:41 INFO - Cleaning up... 09:21:41 INFO - Return code: 0 09:21:41 INFO - Running post-action listener: _resource_record_post_action 09:21:41 INFO - Running post-action listener: _start_resource_monitoring 09:21:41 INFO - Starting resource monitoring. 09:21:41 INFO - [mozharness: 2017-01-12 17:21:41.989707Z] Finished create-virtualenv step (success) 09:21:41 INFO - [mozharness: 2017-01-12 17:21:41.990745Z] Running install step. 09:21:41 INFO - Running pre-action listener: _resource_record_pre_action 09:21:41 INFO - Running main action method: install 09:21:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:21:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:21:42 INFO - Reading from file tmpfile_stdout 09:21:42 INFO - Detecting whether we're running mozinstall >=1.0... 09:21:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:21:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:21:42 INFO - Reading from file tmpfile_stdout 09:21:42 INFO - Output received: 09:21:42 INFO - Usage: mozinstall [options] installer 09:21:42 INFO - Options: 09:21:42 INFO - -h, --help show this help message and exit 09:21:42 INFO - -d DEST, --destination=DEST 09:21:42 INFO - Directory to install application into. [default: 09:21:42 INFO - "/builds/slave/test"] 09:21:42 INFO - --app=APP Application being installed. [default: firefox] 09:21:42 INFO - mkdir: /builds/slave/test/build/application 09:21:42 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'] 09:21:42 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 09:22:04 INFO - Reading from file tmpfile_stdout 09:22:04 INFO - Output received: 09:22:04 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 09:22:04 INFO - Running post-action listener: _resource_record_post_action 09:22:04 INFO - [mozharness: 2017-01-12 17:22:04.076515Z] Finished install step (success) 09:22:04 INFO - [mozharness: 2017-01-12 17:22:04.076688Z] Running run-tests step. 09:22:04 INFO - Running pre-action listener: _resource_record_pre_action 09:22:04 INFO - Running main action method: run_tests 09:22:04 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:22:04 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:22:04 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:22:04 INFO - 2017-01-12 09:22:04.091 screenresolution[1624:7369] starting screenresolution argv=screenresolution get 09:22:04 INFO - 2017-01-12 09:22:04.093 screenresolution[1624:7369] Display 0: 1600x1200x32@60 09:22:04 INFO - 2017-01-12 09:22:04.099 screenresolution[1625:7373] starting screenresolution argv=screenresolution list 09:22:04 INFO - Available Modes on Display 0 09:22:04 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:22:04 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:22:04 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:22:04 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:22:04 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:22:04 INFO - Intel Iris: 09:22:04 INFO - Chipset Model: Intel Iris 09:22:04 INFO - Type: GPU 09:22:04 INFO - Bus: Built-In 09:22:04 INFO - VRAM (Dynamic, Max): 1536 MB 09:22:04 INFO - Vendor: Intel (0x8086) 09:22:04 INFO - Device ID: 0x0a2e 09:22:04 INFO - Revision ID: 0x0009 09:22:04 INFO - Displays: 09:22:04 INFO - Display: 09:22:04 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:22:04 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:22:04 INFO - Display Serial Number: 1600x1200 60 09:22:04 INFO - Main Display: Yes 09:22:04 INFO - Mirror: Off 09:22:04 INFO - Online: Yes 09:22:04 INFO - Rotation: Supported 09:22:04 INFO - Return code: 0 09:22:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:22:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:22:04 INFO - Python 2.7.3 09:22:04 INFO - Return code: 0 09:22:04 INFO - grabbing minidump binary from tooltool 09:22: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')]} 09:22:04 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 0x103768d30>, '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 0x1035cedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103760b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:22:04 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 09:22:04 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 09:22:04 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 09:22:04 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:22:04 INFO - Return code: 0 09:22:04 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 09:22:04 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:22:04 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:22:04 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 09:22:04 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:22:04 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/ImAQfE_YRgGX_1e-s5VZVw/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0208', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 09:22:04 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/ImAQfE_YRgGX_1e-s5VZVw/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0208 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 09:22:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Sc6RDSgUor/Render', 09:22:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:22:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:22:04 INFO - 'HOME': '/Users/cltbld', 09:22:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:22:04 INFO - 'LOGNAME': 'cltbld', 09:22:04 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:22:04 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 09:22:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:22:04 INFO - 'MOZ_NO_REMOTE': '1', 09:22:04 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:22:04 INFO - 'NO_EM_RESTART': '1', 09:22:04 INFO - 'PAGER': '/bin/cat', 09:22:04 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:22:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:22:04 INFO - 'PWD': '/builds/slave/test', 09:22:04 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:22:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:22:04 INFO - 'SHELL': '/bin/bash', 09:22:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fvbnTzQ15p/Listeners', 09:22:04 INFO - 'TMPDIR': '/var/folders/wq/f5xgyhbd75545ndpjmyvls7c00000w/T/', 09:22:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:22:04 INFO - 'USER': 'cltbld', 09:22:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:22:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:22:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:22:04 INFO - 'XPC_FLAGS': '0x0', 09:22:04 INFO - 'XPC_SERVICE_NAME': '0', 09:22:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:22:04 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/ImAQfE_YRgGX_1e-s5VZVw/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0208', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 09:22:04 INFO - mozversion application_buildid: 20170112071716 09:22:04 INFO - mozversion application_changeset: 5fb0834eba17ac8df15f2cbd34805ecada288c48 09:22:04 INFO - mozversion application_display_name: Firefox 09:22:04 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:22:04 INFO - mozversion application_name: Firefox 09:22:04 INFO - mozversion application_remotingname: firefox 09:22:04 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 09:22:04 INFO - mozversion application_vendor: Mozilla 09:22:04 INFO - mozversion application_version: 51.0 09:22:04 INFO - mozversion platform_buildid: 20170112071716 09:22:04 INFO - mozversion platform_changeset: 5fb0834eba17ac8df15f2cbd34805ecada288c48 09:22:04 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 09:22:04 INFO - mozversion platform_version: 51.0 09:22:04 INFO - using testdate: 1484241724 09:22:04 INFO - actual date: 1484241724 09:22:04 INFO - starting webserver on 'localhost:49235' 09:22:04 INFO - SUITE-START | Running 2 tests 09:22:04 INFO - TEST-START | dromaeo_css 09:22:04 INFO - operating with platform_type : mac_ 09:22:04 INFO - Initialising browser for dromaeo_css test... 09:22:04 INFO - TEST-INFO | started process 1635 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/wq/f5xgyhbd75545ndpjmyvls7c00000w/T/tmpoINNi3/profile http://localhost:49235/getInfo.html) 09:22:07 INFO - PROCESS | 1635 | __metrics Screen width/height:1600/1200 09:22:07 INFO - PROCESS | 1635 | colorDepth:24 09:22:07 INFO - PROCESS | 1635 | Browser inner width/height: 1024/689 09:22:07 INFO - PROCESS | 1635 | __metrics 09:22:07 INFO - PROCESS | 1635 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:22:07 INFO - PROCESS | 1635 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:22:07 INFO - TEST-INFO | 1635: exit 0 09:22:07 INFO - Browser initialized. 09:22:07 INFO - Running cycle 1/1 for dromaeo_css test... 09:22:07 INFO - TEST-INFO | started process 1638 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/wq/f5xgyhbd75545ndpjmyvls7c00000w/T/tmpoINNi3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:22:19 INFO - PROCESS | 1638 | RSS: Main: 168771584 09:22:19 INFO - PROCESS | 1638 | 09:23:11 INFO - PROCESS | 1638 | 1484241791485 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 09:25:21 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49235/tests/dromaeo/cssquery-ext.html) 09:25:23 INFO - PROCESS | 1638 | RSS: Main: 317829120 09:25:23 INFO - PROCESS | 1638 | 09:28:26 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-ext.html (next: http://localhost:49235/tests/dromaeo/cssquery-jquery.html) 09:28:26 INFO - PROCESS | 1638 | RSS: Main: 301727744 09:28:26 INFO - PROCESS | 1638 | 09:31:28 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49235/tests/dromaeo/cssquery-mootools.html) 09:31:29 INFO - PROCESS | 1638 | RSS: Main: 279650304 09:31:29 INFO - PROCESS | 1638 | 09:34:31 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49235/tests/dromaeo/cssquery-prototype.html) 09:34:32 INFO - PROCESS | 1638 | RSS: Main: 282218496 09:34:32 INFO - PROCESS | 1638 | 09:37:35 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49235/tests/dromaeo/cssquery-yui.html) 09:37:36 INFO - PROCESS | 1638 | RSS: Main: 257904640 09:37:36 INFO - PROCESS | 1638 | 09:40:39 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-yui.html (next: http://localhost:49235/tests/dromaeo/cssquery-dojo.html) 09:40:39 INFO - PROCESS | 1638 | RSS: Main: 354570240 09:40:39 INFO - PROCESS | 1638 | 09:40:39 INFO - PROCESS | 1638 | __start_tp_report 09:40:39 INFO - PROCESS | 1638 | _x_x_mozilla_page_load 09:40:39 INFO - PROCESS | 1638 | _x_x_mozilla_page_load_details 09:40:39 INFO - PROCESS | 1638 | |i|pagename|runs| 09:40:39 INFO - PROCESS | 1638 | |0;dojo.html;3453.810040447775;3463.4804779283095;3494.405950988332;3514.7188224942006;3539.4867744177095;5670.177824215486;5710.857228569288;5720.256366672332;5747.827565173041;5771.884562308751;5673.744681489333;5725.685087320207;5725.713714314278;5726.541876649869;5727.455891690293;5148.768305426265;5204.791808327663;5214.217867319894;5227.372715274172;5228.607854410915;5174.3790745110455;5185.481451854822;5195.844124676266;5296.25852380667;5305.151175811871;4571.428571428572;5017.749112544377;5268.31511903452;5285.02227087988;5316.441773613773;5238.292830467895;5309.5752339812725;5317.8404647860625;5322.946770532284;5325.946740532584;5207.6354655174155;5250.08123578376;5267.683938963636;5270.84041510867;5296.496832800878;5573.024720673866;5588.86027849303;5643.435656434365;5649.0114230009585;5735.569832262597;6165.198524191871;6222.751089956397;6236.96881515594;6267.8746425071695;6285.308616052231;5477.20580515823;6272.466840318579;6310.895593271205;6322.525810564226;6327.746890124389;5714.057180565202;5765.682887441231;5775.306963164448;5785.363610002896;5850.882982340372;6224.221972253468;6274.780382686676;6278.591891527036;6300.464460520907;6304.8423789404715;6218;6220.595661282002;6223.439890409885;6227.439530442282;6231.501479881598;6126.700892189549;6192.659403732748;6233.812985610439;6295.622262664163;6322.810315690536;5657.462541058593;6006.579539432198;6146.231721034871;6216.658083805343;6306.1171435998995;6261.342559031327;6290.496760259169;6295.842603934847;6306.022566502108;6317.620942743358;4829.203181475087;4953.72754498506;5006.599472042228;5009.173486374781;5030.943501864576;4399.12017596482;4455.977720111378;4469.73181609098;4511.639068874482;4520.4575450946095;5796.82609521715;5797.826065218051;5803.767849286066;5819.447152520504;5826.533877289807;5790.681512516768;6016.909746353808;6277.309495955441;6278.152449419361;6324.936750632435;5622.0161471742285;5637.830865074055;5695.259616249861;5695.886082278331;5782.335031471351;5376.38171610262;5411.729413529308;5417.756200970965;5451.890962180734;5451.890962180734;6331.68341582919;6342.334054924167;6346.2067241594805;6353.396427339396;6361;6105.786297479567;6186.845328866814;6283.7800676976085;6286.811395658137;6290.811275661737;6222.408871157233;6257.43683068526;6271.560990730605;6276.937230627818;6346.524010699309;6216.7824126155365;6231.75072997075;6232.719527621359;6232.875342493034;6232.9715596926;6202.317745047951;6214.5960512566535;6254.468370188585;6263.9664455364355;6286.905696414649;5806.535477161732;6005.519558435228;6022.8795424090395;6043.969780151247;6050.6369617823075;6106.915739268716;6119.807225076679;6125.357545073132;6135.937063216418;6145.446909778141;5909.5863289569315;5918.970405147947;5919;5921.703914804329;5930.318013428511;5918.378570250234;5973.01445261527;6035.879282414415;6054.39456054391;6089.5432842537875;4285.957140428556;5540.307461567304;6042.969785151046;6048.879022419439;6050.939490605214 09:40:39 INFO - PROCESS | 1638 | |1;ext.html;498.28744894800445;505.5147058823529;535.2159086937636;540.5540429145956;553.3359968038355;26372.472550549002;32098;33262.6694932203;33293.334133317316;33332.66667333326;28201;35158.472622910616;35189.82405087971;42464.36303455451;43704.99999999992;9681.419114853095;9786.26603004774;9796.755081122994;9823.312368134233;9831.066048725359;9531.046895310448;9628.326017178766;9633.084856938614;9640.228781697482;9651.986541413156;9142.72571822843;9358.625654973794;9607.807843843118;9642.13220810127;12009.219400738968;12041.578544750935;12288.631341059783;12290.446929888087;12300.692482687915;12302.200356976813;12169.513219471211;12271.754564908651;12280.263184208976;12281.877181228163;12315.19951203169;27801.86099069512;30727.38545229105;32947.835260823544;40678;41370.58629413698;3365.377405180025;3448.327576122657;3463.4631632097066;3477.51314815926;3884.3979183226643;25604;30522.54216186759;30548.8472557638;30569.388612227853;31926.201844954063;3269.2807582331848;3318.5354050432957;3401.149712571857;3515.490253913168;3517.5251341068883;526898;528469.9999999962;528860;528952;529879;60423.697881510314;60670.69664651737;60785.696071519356;60834.783304333665;60872.69563652154;63246.68376658087;63276;63309.733805324555;63367.6831615839;63414.365856340846;17131.828681713272;17360;17367.218475168647;17379.304827807;17406.95558266508;12226.572069977687;12462.937685311697;13342.599722008355;13413.731725365438;13430.664233394244;13237.73524529504;15528;15575.065496070272;15579.454719084777;15734.527964161094;5486.149646804752;6315.242170939517;6683.164604424447;6721.731130754715;6756.797296081126;910.649399981012;990.7126933189294;1001.464216644092;1102.9283096598695;1119.8040342939953;30659.080227592764;30724.846375768426;30727.38545229083;31172;31344.21639459032;1005.8189525885265;1097.1825989637612;1145.541783286692;1157.1784033336426;1237.975240495185;15143.261248744204;16195.271212795216;16225.756613650805;16362.590935226715;16469.83530164707;680289;685774.2824144621;686184;687453;700737;60184.69907650434;60240.397596024355;60256.39743602595;60272.69863650654;60451.69774151189;1302.5766625846638;1337.190999445341;1413.2721648351312;1441.8630230128122;1447.4644381578462;28730.138095857157;30889.8455507721;31121.533177002817;31530.211744706565;33147.50278745869;41283;50670.49329506805;50676.98646027133;50782.49217507926;50811;582789;585016;585464;586163;587295;22807.31578052661;27561.448771024065;27564.448711026067;28048.71951280461;28103.57844632373;46263.768681156376;47603.52396475991;47913;49029.2645610309;49305.50694493009;37773.4333984996;39786.2042759149;39937.600623993385;40566.59433405746;41650.58349416588;39966.18765849466;40377.596224037385;41270.38094428526;41373.586264136975;41457.79271103746;38797.41803873001;39341;39379.80310098431;39417.60582394139;39797.60202397939;33344.666553335126;34841.46456779097;35019.29961400707;35455;35594.64405355913;26364.624756117813;26584.468310634067;26616.467670646867;26630.866845666424;26971.86514067417 09:40:39 INFO - PROCESS | 1638 | |2;jquery.html;386.7698719262038;388.9436031775393;396.32624538284904;401.5462527344101;417.9644730197933;15122.848771512281;20578.0739866706;21209;22070.558588828215;22074.896255187236;16484.258208380623;18936.62126757464;20453.693194602092;21189.894050529765;21305.893470532665;5891.705414729267;6161.075838624198;6165.075238714184;6165.136880836686;6166.7224974876235;5831.883362332751;6024.126501657257;6060.1212824140475;6134.41723036313;6140.293866205398;6072.848178795522;6076.878462430749;6081.300650425192;6087.026075827868;6091.025435930252;5795.130730390433;5975.940240597603;6032.306284777241;6044.667543285118;6051.727672254759;5250.684958902478;5251.6061295402615;5256.553192978601;5257.290265814105;5264.8683782905355;13444.462221511129;13644.454221831114;23399.5960242386;24319.513609727885;25302.746972530407;2120.946976325589;2182.945426364354;2253.222638189838;2369;2566.910158144456;10129.341592796445;10151.340162889388;10623.681289561326;13599.524016659469;14629.341679624442;1936.4965109071743;1965.4693232827199;1976.3082920977542;2032.8576999610034;2102.800233977785;114777;146586;154959;161864.14407567674;164877;16433.30509741397;20664.58670826605;21612;21934.341969740613;22153.446163846034;36395.818020909726;36963.4455483168;37159.071023224096;37294.81352593274;37349.253014939546;9989.600415983425;10513.789724205473;11290.435478226056;11372.20394572372;11567.88432115685;9615.51922403877;9630.014695444435;9650.806983860284;9772.364796288219;9816.901830981742;9790.363626364264;10005.899941000642;10084.647037353658;10109.595616175418;10127.240456965757;3584.874529391459;3585.0320413488735;3874.3994680824517;3877;3894.337962546374;863.2662237098416;897.6633762339122;897.7306807957586;983.1643103362228;1086.5979587552656;20845.58308833815;21312.04095815692;21595.13619455204;21699.240526581492;21770.455738606346;943.5093751249312;951.4957072751453;991.7223177510309;1025.1491262252312;1058.0319008107494;9697.6605818796;9828.181786369545;10861.294015888941;11436;11457.453243812146;611709;619444;626000;661854;662026;136197;138714.30642846922;143050.28474857766;143415.28292358472;148875;998.7203582996773;1002.6941782756184;1009.485162567096;1024.1857723110145;1025.0774303127096;17928.91035544814;18600.627987440446;19110.14004369779;19165.712514312017;19185.232590696214;56392;57662;58128;59693;59719;85647.5717621408;86577;86608;87340.56329718311;89094;7180;7900.802479938047;7907;8389.328853691812;8540.44487108336;11974.341411222467;12911.612651620466;12986.220826750046;13377.063605547908;13578;11044.404564927396;11323.773524529628;11325.377104259345;11388.014195032003;11645.5341786331;10983.505742241778;11139.665810025712;11258.887411125785;11729;11738.94130529342;11335.603253886075;11383.146264030396;11807.82288265694;11833.822492662444;12153.756924861276;8247.463914845515;8283.95858020706;8344.082150963268;8380.748577542683;8401.99176098872;9486.241100712065;11460.713482163013;11654.359010254517;11765.058795296185;11902.345371004678 09:40:39 INFO - PROCESS | 1638 | |3;mootools.html;1398.7831886057652;1560.1575149419311;1576.7950166478358;1814.6007878266776;1965.3219639224462;7981.521108733473;8499.575021248937;8734.12658734127;8978.416402933804;8992.41549299295;8436.354910792397;8863.46819190849;8942.508162051085;8954.820903581924;8960.372773905812;2188.2888061380036;2425.042108367194;2425.8301918865686;2426.4055306449945;2431.8662473563945;2145.4850835799375;2259.536794957038;2407.6629271901948;2426.648136020276;2434.817388695846;2234.648037937041;2374.501354715503;2402.0872068613903;2408.554417432772;2413.0227257960555;2171.543975765091;2363.0902102690416;2397.184957114572;2399.844010139353;2406.2781165650235;2334.2880421471446;2362.574736547421;2365.73976862545;2369.988150059256;2371.762823717632;9048.683296084671;9075.591598378089;9149.679761208392;9174.816503669888;9196.724098277062;5409.972950135224;5635.63368381058;5637.3517045539875;5640.5487560995025;5645.237892884449;3734.9066273343383;3754.1928485375774;3786.1481166737262;3823.0633494793674;3826.827792749333;1131.6548452721916;1134.8694900086514;1138.612871623652;1152.285582938575;1159.174300476744;12271.38643067843;12325.445354959049;12395.876041239653;12408;12411.4414851331;4519.81920723174;4666.60333871618;4782.832600858953;4785.1625965455905;4785.832495862628;9557.996410376949;9572.712818615453;9581.952090239503;9584.760380990392;9606;5442.6462279951675;5445.564354851603;5446.645968012067;5448.482394172547;5448.809291674773;4315.8273669053515;4563.361129441881;4700.929486057712;4712.905741885212;5115.0792857285305;3924.823382947774;3954.525456945185;4010.0776821331256;4060.4721386219603;4064.695147863922;1192.439553409896;1199.208522375228;1200.0519589524354;1212.3695678247261;1213.6783752305646;943.6414162618161;948.6300342866288;977.6773664690635;977.7848873247874;1009.8992098612548;5221.582273418117;5958.374370691102;5974.462298393166;6021.879562408727;6161;407.212044693519;431.439129132127;431.8164779968501;445.9353393757952;446.90614970855836;3584.318979393959;4048.8987775305854;4080.5307389649975;4178.101708132766;4212.178625168062;10608.893911060944;11136.33182009082;11146.275492092987;11146.777064458665;11153.721156970978;9450.763730906783;10687.83968240477;10952.671419857417;11108.611198608172;11115.666530004113;7789.298963093349;8592.828143437097;8596.011458682207;8596.78508037304;8609.526476043753;5799.333076696234;5901.380355062656;5957;6041.305249896318;6056.212692349966;9954.850677239703;10267.178625710074;10331.553582498305;10362.378257304586;10438.895611043792;9499.335046546676;9830.967748386316;10514.737131571466;10532.89467105319;10650.573977041142;6711.3288671132495;7039.225685174524;7161.534500257467;7227.2772722729405;7343.44924130703;7605.809854753676;8044.637991290523;8559.972803263649;8650;8662.610182541675;7781.649825757741;7809.297163255334;7825.3739700824935;7854.450188486751;7993.280604745601;7457.738979135921;7606.277403646644;7610.581418022062;7657.119431265476;7709.653065612173;6076.270847498328;7109.893351599627;7136.250693677297;7195.352418282379;7205.963970180115;5069.239614057921;5114.514121158484;5114.539691427641;5168.095583272988;5188;5098.2352647103235;5125.487451254845;5148.150555158357;5243.921341179809;5306.787728490817 09:40:39 INFO - PROCESS | 1638 | |4;prototype.html;292.86235469329415;297.7022977022977;304.3471753089624;305.75997841694266;319.39952888569485;5153.407358153813;5295.179247216678;5295.470452954707;5391.2991311129545;5418.566514678826;4295.849645262417;4611.216093264145;5323.60072994526;5360.973195134028;5365.731713414333;4141.606547378009;4147.0461793787445;4151.12826306476;4151.522574903887;4164.97917510412;3943.963148375749;4136.27615167346;4154.688398370119;4155.919460940162;4165.97917010416;4098.4671992640915;4105.302098643223;4112.403701463286;4117.3206420940505;4143.233501802161;3606.386914224588;3813.199228162089;3845.557760857509;4067.8983025424304;4114.449041594231;3601.243738814852;3617.9095522611883;3643.7611212187717;3646.9635303646887;3649.3431182387158;4326.437563116775;4604.907901841944;4753.738544380058;4966.652334336598;5226.491284183613;4085.5301640311445;4699.67102302839;4723.740194289313;4729.834455794031;4758.095961767253;5302.575793936514;5378.489043540857;5463.453654634504;5645;5667.433256674341;3267.77125601208;3505.7028899307165;3773.0378753417976;3840.4461033413027;3911.374180131194;4555.658325625592;5539.556835453154;5860.7948721794955;5881.588288819784;5886.941130588682;4040.474738284004;4045.3122969095325;4052.5339585947404;4072.0430698785763;4095.488063992001;3891.377379619304;3998.520177578651;4010.6764767627196;4096.487939007624;4106.891139392407;4656.604188644003;4669;4680.9297860532115;4691.554302341272;4693.296005599187;5668.348139963874;5677.082812859114;5702.800401985994;5707;5736.541076713853;1053.5575058475458;1173.137743758337;1336.9264690441923;1355.4036224061579;1360.2858499287952;784.4508843809242;945.5886689290181;951.8048799995984;957.875476188091;962.4081190068058;4113.716887127613;4575.702579332333;5301.920471192858;5331.893362132736;5381.246625472437;5036.5718913892;5250.65870718402;5274.393444753826;5383.650062745909;5757.85605359861;5237.685738855681;5245.711485868237;5252.868678282997;5279.172599865144;5389.299391079135;2233.497463070796;2738.1107036145395;2775.8889644414;3045.172896262225;3070.5087186050123;5404.91892621611;5717.742701578439;5855.238818953594;5869.6814758170285;5919.01712926166;4755.524447555286;5388.407275199725;5423.996560636295;5835.153902684087;5850.912236316459;5248.291480650216;5631.085430953495;5881.353390974079;5909.8227053188475;5944.435278648608;5475.342958844964;5591.937531868932;5720.8283751487525;5886.676232807236;5930.360989359693;5808.477237048686;5887.8233652990475;5896.579983609582;5928.620686208819;5954.493868021266;5828.970855145697;6091.5126789857595;6154.569180157346;6203.937960620336;6215.65813880241;3088.027271409499;3167.319026409333;3350.6146793119105;3977.2244412339314;3987.601239875989;5892.582302264591;5903.793367232126;5910.911336330045;5913.586048976703;5967.791127310524;5072.82245121419;5123.692578445305;5453.590980676545;5729.796742683916;5744.109663002241;4749.810007599657;5725.914111288417;5729.197912292199;5730.914036289376;5838.4453476919625;4515.9903842789645;4776.904461910812;5365.892682146257;5413.593980451403;5598.580106491948;4937.950620493749;5644.9435505644415;5728.54171666274;5757.769689212385;5759.2512973313205;4376.978115109404;5586.916196256978;5595.916061259166;5602.187682786055;5611.915821262766 09:40:39 INFO - PROCESS | 1638 | |5;yui.html;740.2930201657417;750.7560042986031;755.2900273742681;789.8143936174994;856.5417501636625;14426.855731442682;16171.0297382157;16849.241784119728;17205.311787528513;17261.482155535323;12005.699857503567;14483;14531.782023269632;14532.564023079325;14577.05249158804;717.9964100179492;737.8856277277004;866.6273502393984;878.3105262369041;899.4872922434215;900.693764120199;902.4585248850669;903.5617725403207;906.2206502407923;907.0883761819396;964.9517524123801;966.4974213409023;966.5360626899093;967.3760424526176;967.9564419601099;960.6157536985191;960.9135177833958;961.0149596663406;961.0773657289011;962.138885697304;711.1856923822246;711.5019486359569;711.7971378157253;712.0174159659637;712.5226098514008;15430.305636246396;15455.227238638023;15461.768073478906;15469.845301547066;15492.457763978207;14926.925365373103;14950.70098598022;14951.551453456414;15017.098974061482;15158.696826063528;10121.949390253001;11952.788734084223;12077.27536347822;12171.513139474411;12577.182483138567;3856.4022576500406;3872.941905871386;3927.98036009821;3970.027343300881;4068.4914385701786;117184;119624;122104;123694;123977.38011309976;9944.602215911282;10815.513301901434;10902.400367979679;11679.941600292113;11776.823347649792;21736.347909562737;22080.88959555192;22085;22098.33704988853;22098.44753881166;7759.301662850257;7914.960425197837;8092.83814323722;8135.633896474673;8267.875981860278;4506.797194126272;4517.616002639812;4522.954770452319;4605.332226827159;4733.83431579893;3069.693030696957;3482.5124482571955;3643.3441980443245;3648.21563363878;3648.325059863934;568.6133429268054;667.893137098062;676.0636518422021;677.7898851356096;683.6889215406978;620.872721092175;636.6584357242737;638.2628064585411;648.2771709543919;671.8085345676557;9410.90589094114;9552;9556.61773529051;9672.322937394314;9740.46427446483;554.4870994330229;573.1774903014187;574.3452464190826;644.7819500916831;648.7340190521863;4431.645468362523;4473.127740090651;4716.764161791965;4768.479978465581;4785.186518291899;127128;177734;178977.1051144762;179067;183013;136768;140393;141629;145700.27149864394;155995.22002389916;121851.3907430475;124678;126458;128261.71738282684;130315.34842325917;8920.420172688755;8963.193312601898;9088.500132492776;9146.176844084064;9158.358914875895;66906.6654666743;67592;68446.65776671085;69880;70329.64835175792;66644;75683.86474203001;88531;90842;91739;13586.796198057235;13713.314334283445;13827.585172444842;14019.228942408265;14047.367868446148;15175;15389.538313850155;15565.221738913235;15731.764023539885;15741.898067135191;14083.929580352033;14268.14391136535;14743.705125897637;14817.92591037081;14875.702485950436;13608.387622557208;13767.724645507235;14229.14625122496;15142.242887855342;15447.691046178788;11935;14011.719765604426;14663.92668036653;14832.629184270048;14967.625809354853;11491.195616306779;11739.178257521891;11808.173427859967;12133.453994570089;12185.817212741638;11778.705532361759;11834.704132396759;12017.519299227934;12070.456829442872;12132 09:40:39 INFO - PROCESS | 1638 | __end_tp_report 09:40:39 INFO - PROCESS | 1638 | __start_cc_report 09:40:39 INFO - PROCESS | 1638 | _x_x_mozilla_cycle_collect,1457 09:40:39 INFO - PROCESS | 1638 | __end_cc_report 09:40:39 INFO - PROCESS | 1638 | __startTimestamp1484242839350__endTimestamp 09:40:39 INFO - PROCESS | 1638 | 09:40:39 INFO - PROCESS | 1638 | ------- Summary: start ------- 09:40:39 INFO - PROCESS | 1638 | Number of tests: 6 09:40:39 INFO - PROCESS | 1638 | 09:40:39 INFO - PROCESS | 1638 | [#0] dojo.html Cycles:165 Average:5738.55 Median:5918.38 stddev:630.62 (10.7%) stddev-sans-first:606.55 09:40:39 INFO - PROCESS | 1638 | Values: 3453.8 3463.5 3494.4 3514.7 3539.5 5670.2 5710.9 5720.3 5747.8 5771.9 5673.7 5725.7 5725.7 5726.5 5727.5 5148.8 5204.8 5214.2 5227.4 5228.6 5174.4 5185.5 5195.8 5296.3 5305.2 4571.4 5017.7 5268.3 5285.0 5316.4 5238.3 5309.6 5317.8 5322.9 5325.9 5207.6 5250.1 5267.7 5270.8 5296.5 5573.0 5588.9 5643.4 5649.0 5735.6 6165.2 6222.8 6237.0 6267.9 6285.3 5477.2 6272.5 6310.9 6322.5 6327.7 5714.1 5765.7 5775.3 5785.4 5850.9 6224.2 6274.8 6278.6 6300.5 6304.8 6218.0 6220.6 6223.4 6227.4 6231.5 6126.7 6192.7 6233.8 6295.6 6322.8 5657.5 6006.6 6146.2 6216.7 6306.1 6261.3 6290.5 6295.8 6306.0 6317.6 4829.2 4953.7 5006.6 5009.2 5030.9 4399.1 4456.0 4469.7 4511.6 4520.5 5796.8 5797.8 5803.8 5819.4 5826.5 5790.7 6016.9 6277.3 6278.2 6324.9 5622.0 5637.8 5695.3 5695.9 5782.3 5376.4 5411.7 5417.8 5451.9 5451.9 6331.7 6342.3 6346.2 6353.4 6361.0 6105.8 6186.8 6283.8 6286.8 6290.8 6222.4 6257.4 6271.6 6276.9 6346.5 6216.8 6231.8 6232.7 6232.9 6233.0 6202.3 6214.6 6254.5 6264.0 6286.9 5806.5 6005.5 6022.9 6044.0 6050.6 6106.9 6119.8 6125.4 6135.9 6145.4 5909.6 5919.0 5919.0 5921.7 5930.3 5918.4 5973.0 6035.9 6054.4 6089.5 4286.0 5540.3 6043.0 6048.9 6050.9 09:40:39 INFO - PROCESS | 1638 | 09:40:39 INFO - PROCESS | 1638 | [#1] ext.html Cycles:180 Average:72768.01 Median:19353.67 stddev:161740.37 (835.7%) stddev-sans-first:162103.07 09:40:39 INFO - PROCESS | 1638 | Values: 498.3 505.5 535.2 540.6 553.3 26372.5 32098.0 33262.7 33293.3 33332.7 28201.0 35158.5 35189.8 42464.4 43705.0 9681.4 9786.3 9796.8 9823.3 9831.1 9531.0 9628.3 9633.1 9640.2 9652.0 9142.7 9358.6 9607.8 9642.1 12009.2 12041.6 12288.6 12290.4 12300.7 12302.2 12169.5 12271.8 12280.3 12281.9 12315.2 27801.9 30727.4 32947.8 40678.0 41370.6 3365.4 3448.3 3463.5 3477.5 3884.4 25604.0 30522.5 30548.8 30569.4 31926.2 3269.3 3318.5 3401.1 3515.5 3517.5 526898.0 528470.0 528860.0 528952.0 529879.0 60423.7 60670.7 60785.7 60834.8 60872.7 63246.7 63276.0 63309.7 63367.7 63414.4 17131.8 17360.0 17367.2 17379.3 17407.0 12226.6 12462.9 13342.6 13413.7 13430.7 13237.7 15528.0 15575.1 15579.5 15734.5 5486.1 6315.2 6683.2 6721.7 6756.8 910.6 990.7 1001.5 1102.9 1119.8 30659.1 30724.8 30727.4 31172.0 31344.2 1005.8 1097.2 1145.5 1157.2 1238.0 15143.3 16195.3 16225.8 16362.6 16469.8 680289.0 685774.3 686184.0 687453.0 700737.0 60184.7 60240.4 60256.4 60272.7 60451.7 1302.6 1337.2 1413.3 1441.9 1447.5 28730.1 30889.8 31121.5 31530.2 33147.5 41283.0 50670.5 50677.0 50782.5 50811.0 582789.0 585016.0 585464.0 586163.0 587295.0 22807.3 27561.4 27564.4 28048.7 28103.6 46263.8 47603.5 47913.0 49029.3 49305.5 37773.4 39786.2 39937.6 40566.6 41650.6 39966.2 40377.6 41270.4 41373.6 41457.8 38797.4 39341.0 39379.8 39417.6 39797.6 33344.7 34841.5 35019.3 35455.0 35594.6 26364.6 26584.5 26616.5 26630.9 26971.9 09:40:39 INFO - PROCESS | 1638 | 09:40:39 INFO - PROCESS | 1638 | [#2] jquery.html Cycles:180 Average:38860.20 Median:12203.33 stddev:107002.39 (876.8%) stddev-sans-first:107263.56 09:40:39 INFO - PROCESS | 1638 | Values: 386.8 388.9 396.3 401.5 418.0 15122.8 20578.1 21209.0 22070.6 22074.9 16484.3 18936.6 20453.7 21189.9 21305.9 5891.7 6161.1 6165.1 6165.1 6166.7 5831.9 6024.1 6060.1 6134.4 6140.3 6072.8 6076.9 6081.3 6087.0 6091.0 5795.1 5975.9 6032.3 6044.7 6051.7 5250.7 5251.6 5256.6 5257.3 5264.9 13444.5 13644.5 23399.6 24319.5 25302.7 2120.9 2182.9 2253.2 2369.0 2566.9 10129.3 10151.3 10623.7 13599.5 14629.3 1936.5 1965.5 1976.3 2032.9 2102.8 114777.0 146586.0 154959.0 161864.1 164877.0 16433.3 20664.6 21612.0 21934.3 22153.4 36395.8 36963.4 37159.1 37294.8 37349.3 9989.6 10513.8 11290.4 11372.2 11567.9 9615.5 9630.0 9650.8 9772.4 9816.9 9790.4 10005.9 10084.6 10109.6 10127.2 3584.9 3585.0 3874.4 3877.0 3894.3 863.3 897.7 897.7 983.2 1086.6 20845.6 21312.0 21595.1 21699.2 21770.5 943.5 951.5 991.7 1025.1 1058.0 9697.7 9828.2 10861.3 11436.0 11457.5 611709.0 619444.0 626000.0 661854.0 662026.0 136197.0 138714.3 143050.3 143415.3 148875.0 998.7 1002.7 1009.5 1024.2 1025.1 17928.9 18600.6 19110.1 19165.7 19185.2 56392.0 57662.0 58128.0 59693.0 59719.0 85647.6 86577.0 86608.0 87340.6 89094.0 7180.0 7900.8 7907.0 8389.3 8540.4 11974.3 12911.6 12986.2 13377.1 13578.0 11044.4 11323.8 11325.4 11388.0 11645.5 10983.5 11139.7 11258.9 11729.0 11738.9 11335.6 11383.1 11807.8 11833.8 12153.8 8247.5 8284.0 8344.1 8380.7 8402.0 9486.2 11460.7 11654.4 11765.1 11902.3 09:40:39 INFO - PROCESS | 1638 | 09:40:39 INFO - PROCESS | 1638 | [#3] mootools.html Cycles:180 Average:5792.75 Median:4927.54 stddev:3287.08 (66.7%) stddev-sans-first:3279.72 09:40:39 INFO - PROCESS | 1638 | Values: 1398.8 1560.2 1576.8 1814.6 1965.3 7981.5 8499.6 8734.1 8978.4 8992.4 8436.4 8863.5 8942.5 8954.8 8960.4 2188.3 2425.0 2425.8 2426.4 2431.9 2145.5 2259.5 2407.7 2426.6 2434.8 2234.6 2374.5 2402.1 2408.6 2413.0 2171.5 2363.1 2397.2 2399.8 2406.3 2334.3 2362.6 2365.7 2370.0 2371.8 9048.7 9075.6 9149.7 9174.8 9196.7 5410.0 5635.6 5637.4 5640.5 5645.2 3734.9 3754.2 3786.1 3823.1 3826.8 1131.7 1134.9 1138.6 1152.3 1159.2 12271.4 12325.4 12395.9 12408.0 12411.4 4519.8 4666.6 4782.8 4785.2 4785.8 9558.0 9572.7 9582.0 9584.8 9606.0 5442.6 5445.6 5446.6 5448.5 5448.8 4315.8 4563.4 4700.9 4712.9 5115.1 3924.8 3954.5 4010.1 4060.5 4064.7 1192.4 1199.2 1200.1 1212.4 1213.7 943.6 948.6 977.7 977.8 1009.9 5221.6 5958.4 5974.5 6021.9 6161.0 407.2 431.4 431.8 445.9 446.9 3584.3 4048.9 4080.5 4178.1 4212.2 10608.9 11136.3 11146.3 11146.8 11153.7 9450.8 10687.8 10952.7 11108.6 11115.7 7789.3 8592.8 8596.0 8596.8 8609.5 5799.3 5901.4 5957.0 6041.3 6056.2 9954.9 10267.2 10331.6 10362.4 10438.9 9499.3 9831.0 10514.7 10532.9 10650.6 6711.3 7039.2 7161.5 7227.3 7343.4 7605.8 8044.6 8560.0 8650.0 8662.6 7781.6 7809.3 7825.4 7854.5 7993.3 7457.7 7606.3 7610.6 7657.1 7709.7 6076.3 7109.9 7136.3 7195.4 7206.0 5069.2 5114.5 5114.5 5168.1 5188.0 5098.2 5125.5 5148.2 5243.9 5306.8 09:40:39 INFO - PROCESS | 1638 | 09:40:39 INFO - PROCESS | 1638 | [#4] prototype.html Cycles:180 Average:4573.75 Median:5241.70 stddev:1418.60 (27.1%) stddev-sans-first:1385.71 09:40:39 INFO - PROCESS | 1638 | Values: 292.9 297.7 304.3 305.8 319.4 5153.4 5295.2 5295.5 5391.3 5418.6 4295.8 4611.2 5323.6 5361.0 5365.7 4141.6 4147.0 4151.1 4151.5 4165.0 3944.0 4136.3 4154.7 4155.9 4166.0 4098.5 4105.3 4112.4 4117.3 4143.2 3606.4 3813.2 3845.6 4067.9 4114.4 3601.2 3617.9 3643.8 3647.0 3649.3 4326.4 4604.9 4753.7 4966.7 5226.5 4085.5 4699.7 4723.7 4729.8 4758.1 5302.6 5378.5 5463.5 5645.0 5667.4 3267.8 3505.7 3773.0 3840.4 3911.4 4555.7 5539.6 5860.8 5881.6 5886.9 4040.5 4045.3 4052.5 4072.0 4095.5 3891.4 3998.5 4010.7 4096.5 4106.9 4656.6 4669.0 4680.9 4691.6 4693.3 5668.3 5677.1 5702.8 5707.0 5736.5 1053.6 1173.1 1336.9 1355.4 1360.3 784.5 945.6 951.8 957.9 962.4 4113.7 4575.7 5301.9 5331.9 5381.2 5036.6 5250.7 5274.4 5383.7 5757.9 5237.7 5245.7 5252.9 5279.2 5389.3 2233.5 2738.1 2775.9 3045.2 3070.5 5404.9 5717.7 5855.2 5869.7 5919.0 4755.5 5388.4 5424.0 5835.2 5850.9 5248.3 5631.1 5881.4 5909.8 5944.4 5475.3 5591.9 5720.8 5886.7 5930.4 5808.5 5887.8 5896.6 5928.6 5954.5 5829.0 6091.5 6154.6 6203.9 6215.7 3088.0 3167.3 3350.6 3977.2 3987.6 5892.6 5903.8 5910.9 5913.6 5967.8 5072.8 5123.7 5453.6 5729.8 5744.1 4749.8 5725.9 5729.2 5730.9 5838.4 4516.0 4776.9 5365.9 5413.6 5598.6 4938.0 5644.9 5728.5 5757.8 5759.3 4377.0 5586.9 5595.9 5602.2 5611.9 09:40:39 INFO - PROCESS | 1638 | 09:40:39 INFO - PROCESS | 1638 | [#5] yui.html Cycles:180 Average:26793.53 Median:3562.93 stddev:44122.80 (1238.4%) stddev-sans-first:44203.21 09:40:39 INFO - PROCESS | 1638 | Values: 740.3 750.8 755.3 789.8 856.5 14426.9 16171.0 16849.2 17205.3 17261.5 12005.7 14483.0 14531.8 14532.6 14577.1 718.0 737.9 866.6 878.3 899.5 900.7 902.5 903.6 906.2 907.1 965.0 966.5 966.5 967.4 968.0 960.6 960.9 961.0 961.1 962.1 711.2 711.5 711.8 712.0 712.5 15430.3 15455.2 15461.8 15469.8 15492.5 14926.9 14950.7 14951.6 15017.1 15158.7 10121.9 11952.8 12077.3 12171.5 12577.2 3856.4 3872.9 3928.0 3970.0 4068.5 117184.0 119624.0 122104.0 123694.0 123977.4 9944.6 10815.5 10902.4 11679.9 11776.8 21736.3 22080.9 22085.0 22098.3 22098.4 7759.3 7915.0 8092.8 8135.6 8267.9 4506.8 4517.6 4523.0 4605.3 4733.8 3069.7 3482.5 3643.3 3648.2 3648.3 568.6 667.9 676.1 677.8 683.7 620.9 636.7 638.3 648.3 671.8 9410.9 9552.0 9556.6 9672.3 9740.5 554.5 573.2 574.3 644.8 648.7 4431.6 4473.1 4716.8 4768.5 4785.2 127128.0 177734.0 178977.1 179067.0 183013.0 136768.0 140393.0 141629.0 145700.3 155995.2 121851.4 124678.0 126458.0 128261.7 130315.3 8920.4 8963.2 9088.5 9146.2 9158.4 66906.7 67592.0 68446.7 69880.0 70329.6 66644.0 75683.9 88531.0 90842.0 91739.0 13586.8 13713.3 13827.6 14019.2 14047.4 15175.0 15389.5 15565.2 15731.8 15741.9 14083.9 14268.1 14743.7 14817.9 14875.7 13608.4 13767.7 14229.1 15142.2 15447.7 11935.0 14011.7 14663.9 14832.6 14967.6 11491.2 11739.2 11808.2 12133.5 12185.8 11778.7 11834.7 12017.5 12070.5 12132.0 09:40:39 INFO - PROCESS | 1638 | -------- Summary: end -------- 09:40:39 INFO - PROCESS | 1638 | 09:40:39 INFO - TEST-INFO | 1638: exit 0 09:40:39 INFO - TEST-OK | dromaeo_css | took 1115220ms 09:40:39 INFO - TEST-START | kraken 09:40:39 INFO - operating with platform_type : mac_ 09:40:39 INFO - Initialising browser for kraken test... 09:40:39 INFO - TEST-INFO | started process 1649 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/wq/f5xgyhbd75545ndpjmyvls7c00000w/T/tmpOj2HcR/profile http://localhost:49235/getInfo.html) 09:40:42 INFO - PROCESS | 1649 | __metrics Screen width/height:1600/1200 09:40:42 INFO - PROCESS | 1649 | colorDepth:24 09:40:42 INFO - PROCESS | 1649 | Browser inner width/height: 1024/689 09:40:42 INFO - PROCESS | 1649 | __metrics 09:40:42 INFO - PROCESS | 1649 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:40:42 INFO - PROCESS | 1649 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:40:43 INFO - TEST-INFO | 1649: exit 0 09:40:43 INFO - Browser initialized. 09:40:43 INFO - Running cycle 1/1 for kraken test... 09:40:43 INFO - TEST-INFO | started process 1651 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/wq/f5xgyhbd75545ndpjmyvls7c00000w/T/tmpOj2HcR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:40:54 INFO - PROCESS | 1651 | RSS: Main: 169177088 09:40:54 INFO - PROCESS | 1651 | 09:40:57 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49235/tests/kraken/driver.html?testName=audio-beat-detection) 09:40:58 INFO - PROCESS | 1651 | RSS: Main: 218914816 09:40:58 INFO - PROCESS | 1651 | 09:41:01 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49235/tests/kraken/driver.html?testName=audio-dft) 09:41:01 INFO - PROCESS | 1651 | RSS: Main: 232448000 09:41:01 INFO - PROCESS | 1651 | 09:41:04 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49235/tests/kraken/driver.html?testName=audio-fft) 09:41:05 INFO - PROCESS | 1651 | RSS: Main: 328749056 09:41:05 INFO - PROCESS | 1651 | 09:41:07 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49235/tests/kraken/driver.html?testName=audio-oscillator) 09:41:08 INFO - PROCESS | 1651 | RSS: Main: 229294080 09:41:08 INFO - PROCESS | 1651 | 09:41:10 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49235/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:41:10 INFO - PROCESS | 1651 | RSS: Main: 230322176 09:41:10 INFO - PROCESS | 1651 | 09:41:13 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49235/tests/kraken/driver.html?testName=imaging-darkroom) 09:41:14 INFO - PROCESS | 1651 | RSS: Main: 266203136 09:41:14 INFO - PROCESS | 1651 | 09:41:16 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49235/tests/kraken/driver.html?testName=imaging-desaturate) 09:41:17 INFO - PROCESS | 1651 | RSS: Main: 268926976 09:41:17 INFO - PROCESS | 1651 | 09:41:20 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49235/tests/kraken/driver.html?testName=json-parse-financial) 09:41:20 INFO - PROCESS | 1651 | RSS: Main: 267804672 09:41:20 INFO - PROCESS | 1651 | 09:41:22 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49235/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:41:22 INFO - PROCESS | 1651 | RSS: Main: 240136192 09:41:22 INFO - PROCESS | 1651 | 09:41:24 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:41:25 INFO - PROCESS | 1651 | RSS: Main: 245723136 09:41:25 INFO - PROCESS | 1651 | 09:41:27 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:41:28 INFO - PROCESS | 1651 | RSS: Main: 255975424 09:41:28 INFO - PROCESS | 1651 | 09:41:30 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:41:31 INFO - PROCESS | 1651 | RSS: Main: 262193152 09:41:31 INFO - PROCESS | 1651 | 09:41:34 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:41:34 INFO - PROCESS | 1651 | RSS: Main: 261693440 09:41:34 INFO - PROCESS | 1651 | 09:41:36 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49235/tests/kraken/driver.html?testName=ai-astar) 09:41:37 INFO - PROCESS | 1651 | RSS: Main: 305000448 09:41:37 INFO - PROCESS | 1651 | 09:41:37 INFO - PROCESS | 1651 | __start_tp_report 09:41:37 INFO - PROCESS | 1651 | _x_x_mozilla_page_load 09:41:37 INFO - PROCESS | 1651 | _x_x_mozilla_page_load_details 09:41:37 INFO - PROCESS | 1651 | |i|pagename|runs| 09:41:37 INFO - PROCESS | 1651 | |0;ai-astar;114;112;113;111;113;111;110;114;112;113 09:41:37 INFO - PROCESS | 1651 | |1;audio-beat-detection;144;106;92;159;138;106;107;109;137;105 09:41:37 INFO - PROCESS | 1651 | |2;audio-dft;184;180;182;184;181;184;183;184;182;183 09:41:37 INFO - PROCESS | 1651 | |3;audio-fft;81;58;59;90;74;83;83;65;82;59 09:41:37 INFO - PROCESS | 1651 | |4;audio-oscillator;89;70;91;70;67;68;92;67;68;88 09:41:37 INFO - PROCESS | 1651 | |5;imaging-gaussian-blur;89;85;89;86;87;93;136;87;87;85 09:41:37 INFO - PROCESS | 1651 | |6;imaging-darkroom;94;93;94;93;93;93;93;94;94;93 09:41:37 INFO - PROCESS | 1651 | |7;imaging-desaturate;86;85;83;84;84;84;87;84;84;95 09:41:37 INFO - PROCESS | 1651 | |8;json-parse-financial;56;53;52;52;54;57;59;57;57;57 09:41:37 INFO - PROCESS | 1651 | |9;json-stringify-tinderbox;64;71;69;76;74;68;69;69;69;71 09:41:37 INFO - PROCESS | 1651 | |10;stanford-crypto-aes;84;82;80;83;80;79;83;86;86;88 09:41:37 INFO - PROCESS | 1651 | |11;stanford-crypto-ccm;139;137;135;135;134;146;124;148;168;149 09:41:37 INFO - PROCESS | 1651 | |12;stanford-crypto-pbkdf2;159;160;160;160;159;161;159;157;156;160 09:41:37 INFO - PROCESS | 1651 | |13;stanford-crypto-sha256-iterative;65;67;77;84;85;85;67;64;64;65 09:41:37 INFO - PROCESS | 1651 | __end_tp_report 09:41:37 INFO - PROCESS | 1651 | __start_cc_report 09:41:37 INFO - PROCESS | 1651 | _x_x_mozilla_cycle_collect,1884 09:41:37 INFO - PROCESS | 1651 | __end_cc_report 09:41:37 INFO - PROCESS | 1651 | __startTimestamp1484242897037__endTimestamp 09:41:37 INFO - PROCESS | 1651 | 09:41:37 INFO - PROCESS | 1651 | ------- Summary: start ------- 09:41:37 INFO - PROCESS | 1651 | Number of tests: 14 09:41:37 INFO - PROCESS | 1651 | 09:41:37 INFO - PROCESS | 1651 | [#0] ai-astar Cycles:10 Average:112.30 Median:113.00 stddev:1.34 (1.2%) stddev-sans-first:1.27 09:41:37 INFO - PROCESS | 1651 | Values: 114.0 112.0 113.0 111.0 113.0 111.0 110.0 114.0 112.0 113.0 09:41:37 INFO - PROCESS | 1651 | 09:41:37 INFO - PROCESS | 1651 | [#1] audio-beat-detection Cycles:10 Average:120.30 Median:137.50 stddev:22.11 (16.1%) stddev-sans-first:21.73 09:41:37 INFO - PROCESS | 1651 | Values: 144.0 106.0 92.0 159.0 138.0 106.0 107.0 109.0 137.0 105.0 09:41:37 INFO - PROCESS | 1651 | 09:41:37 INFO - PROCESS | 1651 | [#2] audio-dft Cycles:10 Average:182.70 Median:183.50 stddev:1.42 (0.8%) stddev-sans-first:1.42 09:41:37 INFO - PROCESS | 1651 | Values: 184.0 180.0 182.0 184.0 181.0 184.0 183.0 184.0 182.0 183.0 09:41:37 INFO - PROCESS | 1651 | 09:41:37 INFO - PROCESS | 1651 | [#3] audio-fft Cycles:10 Average:73.40 Median:81.50 stddev:12.08 (14.8%) stddev-sans-first:12.50 09:41:37 INFO - PROCESS | 1651 | Values: 81.0 58.0 59.0 90.0 74.0 83.0 83.0 65.0 82.0 59.0 09:41:37 INFO - PROCESS | 1651 | 09:41:37 INFO - PROCESS | 1651 | [#4] audio-oscillator Cycles:10 Average:77.00 Median:79.00 stddev:11.28 (14.3%) stddev-sans-first:11.10 09:41:37 INFO - PROCESS | 1651 | Values: 89.0 70.0 91.0 70.0 67.0 68.0 92.0 67.0 68.0 88.0 09:41:37 INFO - PROCESS | 1651 | 09:41:37 INFO - PROCESS | 1651 | [#5] imaging-gaussian-blur Cycles:10 Average:92.40 Median:87.00 stddev:15.50 (17.8%) stddev-sans-first:16.39 09:41:37 INFO - PROCESS | 1651 | Values: 89.0 85.0 89.0 86.0 87.0 93.0 136.0 87.0 87.0 85.0 09:41:37 INFO - PROCESS | 1651 | 09:41:37 INFO - PROCESS | 1651 | [#6] imaging-darkroom Cycles:10 Average:93.40 Median:93.50 stddev:0.52 (0.6%) stddev-sans-first:0.50 09:41:37 INFO - PROCESS | 1651 | Values: 94.0 93.0 94.0 93.0 93.0 93.0 93.0 94.0 94.0 93.0 09:41:37 INFO - PROCESS | 1651 | 09:41:37 INFO - PROCESS | 1651 | [#7] imaging-desaturate Cycles:10 Average:85.60 Median:84.50 stddev:3.50 (4.1%) stddev-sans-first:3.71 09:41:37 INFO - PROCESS | 1651 | Values: 86.0 85.0 83.0 84.0 84.0 84.0 87.0 84.0 84.0 95.0 09:41:37 INFO - PROCESS | 1651 | 09:41:37 INFO - PROCESS | 1651 | [#8] json-parse-financial Cycles:10 Average:55.40 Median:57.00 stddev:2.46 (4.3%) stddev-sans-first:2.60 09:41:37 INFO - PROCESS | 1651 | Values: 56.0 53.0 52.0 52.0 54.0 57.0 59.0 57.0 57.0 57.0 09:41:37 INFO - PROCESS | 1651 | 09:41:37 INFO - PROCESS | 1651 | [#9] json-stringify-tinderbox Cycles:10 Average:70.00 Median:70.00 stddev:3.30 (4.7%) stddev-sans-first:2.69 09:41:37 INFO - PROCESS | 1651 | Values: 64.0 71.0 69.0 76.0 74.0 68.0 69.0 69.0 69.0 71.0 09:41:37 INFO - PROCESS | 1651 | 09:41:37 INFO - PROCESS | 1651 | [#10] stanford-crypto-aes Cycles:10 Average:83.10 Median:83.50 stddev:2.96 (3.5%) stddev-sans-first:3.12 09:41:37 INFO - PROCESS | 1651 | Values: 84.0 82.0 80.0 83.0 80.0 79.0 83.0 86.0 86.0 88.0 09:41:37 INFO - PROCESS | 1651 | 09:41:37 INFO - PROCESS | 1651 | [#11] stanford-crypto-ccm Cycles:10 Average:141.50 Median:142.50 stddev:11.99 (8.4%) stddev-sans-first:12.69 09:41:37 INFO - PROCESS | 1651 | Values: 139.0 137.0 135.0 135.0 134.0 146.0 124.0 148.0 168.0 149.0 09:41:37 INFO - PROCESS | 1651 | 09:41:37 INFO - PROCESS | 1651 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.10 Median:160.00 stddev:1.52 (1.0%) stddev-sans-first:1.62 09:41:37 INFO - PROCESS | 1651 | Values: 159.0 160.0 160.0 160.0 159.0 161.0 159.0 157.0 156.0 160.0 09:41:37 INFO - PROCESS | 1651 | 09:41:37 INFO - PROCESS | 1651 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.30 Median:72.00 stddev:9.32 (12.9%) stddev-sans-first:9.51 09:41:37 INFO - PROCESS | 1651 | Values: 65.0 67.0 77.0 84.0 85.0 85.0 67.0 64.0 64.0 65.0 09:41:37 INFO - PROCESS | 1651 | -------- Summary: end -------- 09:41:37 INFO - PROCESS | 1651 | 09:41:37 INFO - TEST-INFO | 1651: exit 0 09:41:37 INFO - TEST-OK | kraken | took 57946ms 09:41:37 INFO - SUITE-END | took 1173s 09:41:38 INFO - Completed test suite (00:19:33) 09:41:38 INFO - javascript benchmark 09:41:38 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3453.810040447775, 3463.4804779283095, 3494.405950988332, 3514.7188224942006, 3539.4867744177095, 5670.177824215486, 5710.857228569288, 5720.256366672332, 5747.827565173041, 5771.884562308751, 5673.744681489333, 5725.685087320207, 5725.713714314278, 5726.541876649869, 5727.455891690293, 5148.768305426265, 5204.791808327663, 5214.217867319894, 5227.372715274172, 5228.607854410915, 5174.3790745110455, 5185.481451854822, 5195.844124676266, 5296.25852380667, 5305.151175811871, 4571.428571428572, 5017.749112544377, 5268.31511903452, 5285.02227087988, 5316.441773613773, 5238.292830467895, 5309.5752339812725, 5317.8404647860625, 5322.946770532284, 5325.946740532584, 5207.6354655174155, 5250.08123578376, 5267.683938963636, 5270.84041510867, 5296.496832800878, 5573.024720673866, 5588.86027849303, 5643.435656434365, 5649.0114230009585, 5735.569832262597, 6165.198524191871, 6222.751089956397, 6236.96881515594, 6267.8746425071695, 6285.308616052231, 5477.20580515823, 6272.466840318579, 6310.895593271205, 6322.525810564226, 6327.746890124389, 5714.057180565202, 5765.682887441231, 5775.306963164448, 5785.363610002896, 5850.882982340372, 6224.221972253468, 6274.780382686676, 6278.591891527036, 6300.464460520907, 6304.8423789404715, 6218.0, 6220.595661282002, 6223.439890409885, 6227.439530442282, 6231.501479881598, 6126.700892189549, 6192.659403732748, 6233.812985610439, 6295.622262664163, 6322.810315690536, 5657.462541058593, 6006.579539432198, 6146.231721034871, 6216.658083805343, 6306.1171435998995, 6261.342559031327, 6290.496760259169, 6295.842603934847, 6306.022566502108, 6317.620942743358, 4829.203181475087, 4953.72754498506, 5006.599472042228, 5009.173486374781, 5030.943501864576, 4399.12017596482, 4455.977720111378, 4469.73181609098, 4511.639068874482, 4520.4575450946095, 5796.82609521715, 5797.826065218051, 5803.767849286066, 5819.447152520504, 5826.533877289807, 5790.681512516768, 6016.909746353808, 6277.309495955441, 6278.152449419361, 6324.936750632435, 5622.0161471742285, 5637.830865074055, 5695.259616249861, 5695.886082278331, 5782.335031471351, 5376.38171610262, 5411.729413529308, 5417.756200970965, 5451.890962180734, 5451.890962180734, 6331.68341582919, 6342.334054924167, 6346.2067241594805, 6353.396427339396, 6361.0, 6105.786297479567, 6186.845328866814, 6283.7800676976085, 6286.811395658137, 6290.811275661737, 6222.408871157233, 6257.43683068526, 6271.560990730605, 6276.937230627818, 6346.524010699309, 6216.7824126155365, 6231.75072997075, 6232.719527621359, 6232.875342493034, 6232.9715596926, 6202.317745047951, 6214.5960512566535, 6254.468370188585, 6263.9664455364355, 6286.905696414649, 5806.535477161732, 6005.519558435228, 6022.8795424090395, 6043.969780151247, 6050.6369617823075, 6106.915739268716, 6119.807225076679, 6125.357545073132, 6135.937063216418, 6145.446909778141, 5909.5863289569315, 5918.970405147947, 5919.0, 5921.703914804329, 5930.318013428511, 5918.378570250234, 5973.01445261527, 6035.879282414415, 6054.39456054391, 6089.5432842537875, 4285.957140428556, 5540.307461567304, 6042.969785151046, 6048.879022419439, 6050.939490605214], "value": 5700.720473652114, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [498.28744894800445, 505.5147058823529, 535.2159086937636, 540.5540429145956, 553.3359968038355, 26372.472550549002, 32098.0, 33262.6694932203, 33293.334133317316, 33332.66667333326, 28201.0, 35158.472622910616, 35189.82405087971, 42464.36303455451, 43704.99999999992, 9681.419114853095, 9786.26603004774, 9796.755081122994, 9823.312368134233, 9831.066048725359, 9531.046895310448, 9628.326017178766, 9633.084856938614, 9640.228781697482, 9651.986541413156, 9142.72571822843, 9358.625654973794, 9607.807843843118, 9642.13220810127, 12009.219400738968, 12041.578544750935, 12288.631341059783, 12290.446929888087, 12300.692482687915, 12302.200356976813, 12169.513219471211, 12271.754564908651, 12280.263184208976, 12281.877181228163, 12315.19951203169, 27801.86099069512, 30727.38545229105, 32947.835260823544, 40678.0, 41370.58629413698, 3365.377405180025, 3448.327576122657, 3463.4631632097066, 3477.51314815926, 3884.3979183226643, 25604.0, 30522.54216186759, 30548.8472557638, 30569.388612227853, 31926.201844954063, 3269.2807582331848, 3318.5354050432957, 3401.149712571857, 3515.490253913168, 3517.5251341068883, 526898.0, 528469.9999999962, 528860.0, 528952.0, 529879.0, 60423.697881510314, 60670.69664651737, 60785.696071519356, 60834.783304333665, 60872.69563652154, 63246.68376658087, 63276.0, 63309.733805324555, 63367.6831615839, 63414.365856340846, 17131.828681713272, 17360.0, 17367.218475168647, 17379.304827807, 17406.95558266508, 12226.572069977687, 12462.937685311697, 13342.599722008355, 13413.731725365438, 13430.664233394244, 13237.73524529504, 15528.0, 15575.065496070272, 15579.454719084777, 15734.527964161094, 5486.149646804752, 6315.242170939517, 6683.164604424447, 6721.731130754715, 6756.797296081126, 910.649399981012, 990.7126933189294, 1001.464216644092, 1102.9283096598695, 1119.8040342939953, 30659.080227592764, 30724.846375768426, 30727.38545229083, 31172.0, 31344.21639459032, 1005.8189525885265, 1097.1825989637612, 1145.541783286692, 1157.1784033336426, 1237.975240495185, 15143.261248744204, 16195.271212795216, 16225.756613650805, 16362.590935226715, 16469.83530164707, 680289.0, 685774.2824144621, 686184.0, 687453.0, 700737.0, 60184.69907650434, 60240.397596024355, 60256.39743602595, 60272.69863650654, 60451.69774151189, 1302.5766625846638, 1337.190999445341, 1413.2721648351312, 1441.8630230128122, 1447.4644381578462, 28730.138095857157, 30889.8455507721, 31121.533177002817, 31530.211744706565, 33147.50278745869, 41283.0, 50670.49329506805, 50676.98646027133, 50782.49217507926, 50811.0, 582789.0, 585016.0, 585464.0, 586163.0, 587295.0, 22807.31578052661, 27561.448771024065, 27564.448711026067, 28048.71951280461, 28103.57844632373, 46263.768681156376, 47603.52396475991, 47913.0, 49029.2645610309, 49305.50694493009, 37773.4333984996, 39786.2042759149, 39937.600623993385, 40566.59433405746, 41650.58349416588, 39966.18765849466, 40377.596224037385, 41270.38094428526, 41373.586264136975, 41457.79271103746, 38797.41803873001, 39341.0, 39379.80310098431, 39417.60582394139, 39797.60202397939, 33344.666553335126, 34841.46456779097, 35019.29961400707, 35455.0, 35594.64405355913, 26364.624756117813, 26584.468310634067, 26616.467670646867, 26630.866845666424, 26971.86514067417], "value": 20253.96370194466, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [386.7698719262038, 388.9436031775393, 396.32624538284904, 401.5462527344101, 417.9644730197933, 15122.848771512281, 20578.0739866706, 21209.0, 22070.558588828215, 22074.896255187236, 16484.258208380623, 18936.62126757464, 20453.693194602092, 21189.894050529765, 21305.893470532665, 5891.705414729267, 6161.075838624198, 6165.075238714184, 6165.136880836686, 6166.7224974876235, 5831.883362332751, 6024.126501657257, 6060.1212824140475, 6134.41723036313, 6140.293866205398, 6072.848178795522, 6076.878462430749, 6081.300650425192, 6087.026075827868, 6091.025435930252, 5795.130730390433, 5975.940240597603, 6032.306284777241, 6044.667543285118, 6051.727672254759, 5250.684958902478, 5251.6061295402615, 5256.553192978601, 5257.290265814105, 5264.8683782905355, 13444.462221511129, 13644.454221831114, 23399.5960242386, 24319.513609727885, 25302.746972530407, 2120.946976325589, 2182.945426364354, 2253.222638189838, 2369.0, 2566.910158144456, 10129.341592796445, 10151.340162889388, 10623.681289561326, 13599.524016659469, 14629.341679624442, 1936.4965109071743, 1965.4693232827199, 1976.3082920977542, 2032.8576999610034, 2102.800233977785, 114777.0, 146586.0, 154959.0, 161864.14407567674, 164877.0, 16433.30509741397, 20664.58670826605, 21612.0, 21934.341969740613, 22153.446163846034, 36395.818020909726, 36963.4455483168, 37159.071023224096, 37294.81352593274, 37349.253014939546, 9989.600415983425, 10513.789724205473, 11290.435478226056, 11372.20394572372, 11567.88432115685, 9615.51922403877, 9630.014695444435, 9650.806983860284, 9772.364796288219, 9816.901830981742, 9790.363626364264, 10005.899941000642, 10084.647037353658, 10109.595616175418, 10127.240456965757, 3584.874529391459, 3585.0320413488735, 3874.3994680824517, 3877.0, 3894.337962546374, 863.2662237098416, 897.6633762339122, 897.7306807957586, 983.1643103362228, 1086.5979587552656, 20845.58308833815, 21312.04095815692, 21595.13619455204, 21699.240526581492, 21770.455738606346, 943.5093751249312, 951.4957072751453, 991.7223177510309, 1025.1491262252312, 1058.0319008107494, 9697.6605818796, 9828.181786369545, 10861.294015888941, 11436.0, 11457.453243812146, 611709.0, 619444.0, 626000.0, 661854.0, 662026.0, 136197.0, 138714.30642846922, 143050.28474857766, 143415.28292358472, 148875.0, 998.7203582996773, 1002.6941782756184, 1009.485162567096, 1024.1857723110145, 1025.0774303127096, 17928.91035544814, 18600.627987440446, 19110.14004369779, 19165.712514312017, 19185.232590696214, 56392.0, 57662.0, 58128.0, 59693.0, 59719.0, 85647.5717621408, 86577.0, 86608.0, 87340.56329718311, 89094.0, 7180.0, 7900.802479938047, 7907.0, 8389.328853691812, 8540.44487108336, 11974.341411222467, 12911.612651620466, 12986.220826750046, 13377.063605547908, 13578.0, 11044.404564927396, 11323.773524529628, 11325.377104259345, 11388.014195032003, 11645.5341786331, 10983.505742241778, 11139.665810025712, 11258.887411125785, 11729.0, 11738.94130529342, 11335.603253886075, 11383.146264030396, 11807.82288265694, 11833.822492662444, 12153.756924861276, 8247.463914845515, 8283.95858020706, 8344.082150963268, 8380.748577542683, 8401.99176098872, 9486.241100712065, 11460.713482163013, 11654.359010254517, 11765.058795296185, 11902.345371004678], "value": 10786.052832657466, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1398.7831886057652, 1560.1575149419311, 1576.7950166478358, 1814.6007878266776, 1965.3219639224462, 7981.521108733473, 8499.575021248937, 8734.12658734127, 8978.416402933804, 8992.41549299295, 8436.354910792397, 8863.46819190849, 8942.508162051085, 8954.820903581924, 8960.372773905812, 2188.2888061380036, 2425.042108367194, 2425.8301918865686, 2426.4055306449945, 2431.8662473563945, 2145.4850835799375, 2259.536794957038, 2407.6629271901948, 2426.648136020276, 2434.817388695846, 2234.648037937041, 2374.501354715503, 2402.0872068613903, 2408.554417432772, 2413.0227257960555, 2171.543975765091, 2363.0902102690416, 2397.184957114572, 2399.844010139353, 2406.2781165650235, 2334.2880421471446, 2362.574736547421, 2365.73976862545, 2369.988150059256, 2371.762823717632, 9048.683296084671, 9075.591598378089, 9149.679761208392, 9174.816503669888, 9196.724098277062, 5409.972950135224, 5635.63368381058, 5637.3517045539875, 5640.5487560995025, 5645.237892884449, 3734.9066273343383, 3754.1928485375774, 3786.1481166737262, 3823.0633494793674, 3826.827792749333, 1131.6548452721916, 1134.8694900086514, 1138.612871623652, 1152.285582938575, 1159.174300476744, 12271.38643067843, 12325.445354959049, 12395.876041239653, 12408.0, 12411.4414851331, 4519.81920723174, 4666.60333871618, 4782.832600858953, 4785.1625965455905, 4785.832495862628, 9557.996410376949, 9572.712818615453, 9581.952090239503, 9584.760380990392, 9606.0, 5442.6462279951675, 5445.564354851603, 5446.645968012067, 5448.482394172547, 5448.809291674773, 4315.8273669053515, 4563.361129441881, 4700.929486057712, 4712.905741885212, 5115.0792857285305, 3924.823382947774, 3954.525456945185, 4010.0776821331256, 4060.4721386219603, 4064.695147863922, 1192.439553409896, 1199.208522375228, 1200.0519589524354, 1212.3695678247261, 1213.6783752305646, 943.6414162618161, 948.6300342866288, 977.6773664690635, 977.7848873247874, 1009.8992098612548, 5221.582273418117, 5958.374370691102, 5974.462298393166, 6021.879562408727, 6161.0, 407.212044693519, 431.439129132127, 431.8164779968501, 445.9353393757952, 446.90614970855836, 3584.318979393959, 4048.8987775305854, 4080.5307389649975, 4178.101708132766, 4212.178625168062, 10608.893911060944, 11136.33182009082, 11146.275492092987, 11146.777064458665, 11153.721156970978, 9450.763730906783, 10687.83968240477, 10952.671419857417, 11108.611198608172, 11115.666530004113, 7789.298963093349, 8592.828143437097, 8596.011458682207, 8596.78508037304, 8609.526476043753, 5799.333076696234, 5901.380355062656, 5957.0, 6041.305249896318, 6056.212692349966, 9954.850677239703, 10267.178625710074, 10331.553582498305, 10362.378257304586, 10438.895611043792, 9499.335046546676, 9830.967748386316, 10514.737131571466, 10532.89467105319, 10650.573977041142, 6711.3288671132495, 7039.225685174524, 7161.534500257467, 7227.2772722729405, 7343.44924130703, 7605.809854753676, 8044.637991290523, 8559.972803263649, 8650.0, 8662.610182541675, 7781.649825757741, 7809.297163255334, 7825.3739700824935, 7854.450188486751, 7993.280604745601, 7457.738979135921, 7606.277403646644, 7610.581418022062, 7657.119431265476, 7709.653065612173, 6076.270847498328, 7109.893351599627, 7136.250693677297, 7195.352418282379, 7205.963970180115, 5069.239614057921, 5114.514121158484, 5114.539691427641, 5168.095583272988, 5188.0, 5098.2352647103235, 5125.487451254845, 5148.150555158357, 5243.921341179809, 5306.787728490817], "value": 4567.735787664439, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [292.86235469329415, 297.7022977022977, 304.3471753089624, 305.75997841694266, 319.39952888569485, 5153.407358153813, 5295.179247216678, 5295.470452954707, 5391.2991311129545, 5418.566514678826, 4295.849645262417, 4611.216093264145, 5323.60072994526, 5360.973195134028, 5365.731713414333, 4141.606547378009, 4147.0461793787445, 4151.12826306476, 4151.522574903887, 4164.97917510412, 3943.963148375749, 4136.27615167346, 4154.688398370119, 4155.919460940162, 4165.97917010416, 4098.4671992640915, 4105.302098643223, 4112.403701463286, 4117.3206420940505, 4143.233501802161, 3606.386914224588, 3813.199228162089, 3845.557760857509, 4067.8983025424304, 4114.449041594231, 3601.243738814852, 3617.9095522611883, 3643.7611212187717, 3646.9635303646887, 3649.3431182387158, 4326.437563116775, 4604.907901841944, 4753.738544380058, 4966.652334336598, 5226.491284183613, 4085.5301640311445, 4699.67102302839, 4723.740194289313, 4729.834455794031, 4758.095961767253, 5302.575793936514, 5378.489043540857, 5463.453654634504, 5645.0, 5667.433256674341, 3267.77125601208, 3505.7028899307165, 3773.0378753417976, 3840.4461033413027, 3911.374180131194, 4555.658325625592, 5539.556835453154, 5860.7948721794955, 5881.588288819784, 5886.941130588682, 4040.474738284004, 4045.3122969095325, 4052.5339585947404, 4072.0430698785763, 4095.488063992001, 3891.377379619304, 3998.520177578651, 4010.6764767627196, 4096.487939007624, 4106.891139392407, 4656.604188644003, 4669.0, 4680.9297860532115, 4691.554302341272, 4693.296005599187, 5668.348139963874, 5677.082812859114, 5702.800401985994, 5707.0, 5736.541076713853, 1053.5575058475458, 1173.137743758337, 1336.9264690441923, 1355.4036224061579, 1360.2858499287952, 784.4508843809242, 945.5886689290181, 951.8048799995984, 957.875476188091, 962.4081190068058, 4113.716887127613, 4575.702579332333, 5301.920471192858, 5331.893362132736, 5381.246625472437, 5036.5718913892, 5250.65870718402, 5274.393444753826, 5383.650062745909, 5757.85605359861, 5237.685738855681, 5245.711485868237, 5252.868678282997, 5279.172599865144, 5389.299391079135, 2233.497463070796, 2738.1107036145395, 2775.8889644414, 3045.172896262225, 3070.5087186050123, 5404.91892621611, 5717.742701578439, 5855.238818953594, 5869.6814758170285, 5919.01712926166, 4755.524447555286, 5388.407275199725, 5423.996560636295, 5835.153902684087, 5850.912236316459, 5248.291480650216, 5631.085430953495, 5881.353390974079, 5909.8227053188475, 5944.435278648608, 5475.342958844964, 5591.937531868932, 5720.8283751487525, 5886.676232807236, 5930.360989359693, 5808.477237048686, 5887.8233652990475, 5896.579983609582, 5928.620686208819, 5954.493868021266, 5828.970855145697, 6091.5126789857595, 6154.569180157346, 6203.937960620336, 6215.65813880241, 3088.027271409499, 3167.319026409333, 3350.6146793119105, 3977.2244412339314, 3987.601239875989, 5892.582302264591, 5903.793367232126, 5910.911336330045, 5913.586048976703, 5967.791127310524, 5072.82245121419, 5123.692578445305, 5453.590980676545, 5729.796742683916, 5744.109663002241, 4749.810007599657, 5725.914111288417, 5729.197912292199, 5730.914036289376, 5838.4453476919625, 4515.9903842789645, 4776.904461910812, 5365.892682146257, 5413.593980451403, 5598.580106491948, 4937.950620493749, 5644.9435505644415, 5728.54171666274, 5757.769689212385, 5759.2512973313205, 4376.978115109404, 5586.916196256978, 5595.916061259166, 5602.187682786055, 5611.915821262766], "value": 4118.555441605765, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [740.2930201657417, 750.7560042986031, 755.2900273742681, 789.8143936174994, 856.5417501636625, 14426.855731442682, 16171.0297382157, 16849.241784119728, 17205.311787528513, 17261.482155535323, 12005.699857503567, 14483.0, 14531.782023269632, 14532.564023079325, 14577.05249158804, 717.9964100179492, 737.8856277277004, 866.6273502393984, 878.3105262369041, 899.4872922434215, 900.693764120199, 902.4585248850669, 903.5617725403207, 906.2206502407923, 907.0883761819396, 964.9517524123801, 966.4974213409023, 966.5360626899093, 967.3760424526176, 967.9564419601099, 960.6157536985191, 960.9135177833958, 961.0149596663406, 961.0773657289011, 962.138885697304, 711.1856923822246, 711.5019486359569, 711.7971378157253, 712.0174159659637, 712.5226098514008, 15430.305636246396, 15455.227238638023, 15461.768073478906, 15469.845301547066, 15492.457763978207, 14926.925365373103, 14950.70098598022, 14951.551453456414, 15017.098974061482, 15158.696826063528, 10121.949390253001, 11952.788734084223, 12077.27536347822, 12171.513139474411, 12577.182483138567, 3856.4022576500406, 3872.941905871386, 3927.98036009821, 3970.027343300881, 4068.4914385701786, 117184.0, 119624.0, 122104.0, 123694.0, 123977.38011309976, 9944.602215911282, 10815.513301901434, 10902.400367979679, 11679.941600292113, 11776.823347649792, 21736.347909562737, 22080.88959555192, 22085.0, 22098.33704988853, 22098.44753881166, 7759.301662850257, 7914.960425197837, 8092.83814323722, 8135.633896474673, 8267.875981860278, 4506.797194126272, 4517.616002639812, 4522.954770452319, 4605.332226827159, 4733.83431579893, 3069.693030696957, 3482.5124482571955, 3643.3441980443245, 3648.21563363878, 3648.325059863934, 568.6133429268054, 667.893137098062, 676.0636518422021, 677.7898851356096, 683.6889215406978, 620.872721092175, 636.6584357242737, 638.2628064585411, 648.2771709543919, 671.8085345676557, 9410.90589094114, 9552.0, 9556.61773529051, 9672.322937394314, 9740.46427446483, 554.4870994330229, 573.1774903014187, 574.3452464190826, 644.7819500916831, 648.7340190521863, 4431.645468362523, 4473.127740090651, 4716.764161791965, 4768.479978465581, 4785.186518291899, 127128.0, 177734.0, 178977.1051144762, 179067.0, 183013.0, 136768.0, 140393.0, 141629.0, 145700.27149864394, 155995.22002389916, 121851.3907430475, 124678.0, 126458.0, 128261.71738282684, 130315.34842325917, 8920.420172688755, 8963.193312601898, 9088.500132492776, 9146.176844084064, 9158.358914875895, 66906.6654666743, 67592.0, 68446.65776671085, 69880.0, 70329.64835175792, 66644.0, 75683.86474203001, 88531.0, 90842.0, 91739.0, 13586.796198057235, 13713.314334283445, 13827.585172444842, 14019.228942408265, 14047.367868446148, 15175.0, 15389.538313850155, 15565.221738913235, 15731.764023539885, 15741.898067135191, 14083.929580352033, 14268.14391136535, 14743.705125897637, 14817.92591037081, 14875.702485950436, 13608.387622557208, 13767.724645507235, 14229.14625122496, 15142.242887855342, 15447.691046178788, 11935.0, 14011.719765604426, 14663.92668036653, 14832.629184270048, 14967.625809354853, 11491.195616306779, 11739.178257521891, 11808.173427859967, 12133.453994570089, 12185.817212741638, 11778.705532361759, 11834.704132396759, 12017.519299227934, 12070.456829442872, 12132.0], "value": 8129.607961929674, "unit": "score"}], "name": "dromaeo_css", "value": 7585.385991256773, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 112.0, 113.0, 111.0, 113.0, 111.0, 110.0, 114.0, 112.0, 113.0], "value": 112.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 106.0, 92.0, 159.0, 138.0, 106.0, 107.0, 109.0, 137.0, 105.0], "value": 120.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 180.0, 182.0, 184.0, 181.0, 184.0, 183.0, 184.0, 182.0, 183.0], "value": 182.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 58.0, 59.0, 90.0, 74.0, 83.0, 83.0, 65.0, 82.0, 59.0], "value": 73.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 70.0, 91.0, 70.0, 67.0, 68.0, 92.0, 67.0, 68.0, 88.0], "value": 77.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 85.0, 89.0, 86.0, 87.0, 93.0, 136.0, 87.0, 87.0, 85.0], "value": 92.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 93.0, 94.0, 93.0, 93.0, 93.0, 93.0, 94.0, 94.0, 93.0], "value": 93.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 83.0, 84.0, 84.0, 84.0, 87.0, 84.0, 84.0, 95.0], "value": 85.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 53.0, 52.0, 52.0, 54.0, 57.0, 59.0, 57.0, 57.0, 57.0], "value": 55.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 71.0, 69.0, 76.0, 74.0, 68.0, 69.0, 69.0, 69.0, 71.0], "value": 70.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 82.0, 80.0, 83.0, 80.0, 79.0, 83.0, 86.0, 86.0, 88.0], "value": 83.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 137.0, 135.0, 135.0, 134.0, 146.0, 124.0, 148.0, 168.0, 149.0], "value": 141.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 160.0, 160.0, 160.0, 159.0, 161.0, 159.0, 157.0, 156.0, 160.0], "value": 159.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 67.0, 77.0, 84.0, 85.0, 85.0, 67.0, 64.0, 64.0, 65.0], "value": 72.3, "unit": "score"}], "name": "kraken", "value": 1418.4999999999998, "alertThreshold": 2.0}]} 09:41:38 INFO - Return code: 0 09:41:38 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:41:38 INFO - # TBPL SUCCESS # 09:41:38 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:41:38 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:41:38 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:41:38 INFO - 2017-01-12 09:41:38.350 screenresolution[1655:9899] starting screenresolution argv=screenresolution get 09:41:38 INFO - 2017-01-12 09:41:38.353 screenresolution[1655:9899] Display 0: 1600x1200x32@60 09:41:38 INFO - 2017-01-12 09:41:38.359 screenresolution[1656:9902] starting screenresolution argv=screenresolution list 09:41:38 INFO - Available Modes on Display 0 09:41:38 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:41:38 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:41:38 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:41:38 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:41:38 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:41:38 INFO - Intel Iris: 09:41:38 INFO - Chipset Model: Intel Iris 09:41:38 INFO - Type: GPU 09:41:38 INFO - Bus: Built-In 09:41:38 INFO - VRAM (Dynamic, Max): 1536 MB 09:41:38 INFO - Vendor: Intel (0x8086) 09:41:38 INFO - Device ID: 0x0a2e 09:41:38 INFO - Revision ID: 0x0009 09:41:38 INFO - Displays: 09:41:38 INFO - Display: 09:41:38 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:41:38 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:41:38 INFO - Display Serial Number: 1600x1200 60 09:41:38 INFO - Main Display: Yes 09:41:38 INFO - Mirror: Off 09:41:38 INFO - Online: Yes 09:41:38 INFO - Rotation: Supported 09:41:38 INFO - Return code: 0 09:41:38 INFO - Running post-action listener: _resource_record_post_action 09:41:38 INFO - [mozharness: 2017-01-12 17:41:38.595031Z] Finished run-tests step (success) 09:41:38 INFO - Running post-run listener: _resource_record_post_run 09:41:38 INFO - Total resource usage - Wall time: 1196s; CPU: 53.0%; Read bytes: 37786624; Write bytes: 498269696; Read time: 247; Write time: 1602 09:41:38 INFO - TinderboxPrint: CPU usage
53.1% 09:41:38 INFO - TinderboxPrint: I/O read bytes / time
37,786,624 / 247 09:41:38 INFO - TinderboxPrint: I/O write bytes / time
498,269,696 / 1,602 09:41:38 INFO - TinderboxPrint: CPU idle
2,244.8 (46.9%) 09:41:38 INFO - TinderboxPrint: CPU system
955.4 (20.0%) 09:41:38 INFO - TinderboxPrint: CPU user
1,585.5 (33.1%) 09:41:38 INFO - TinderboxPrint: Swap in / out
233,443,328 / 0 09:41:38 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 196438528; Write bytes: 200345600; Read time: 17848; Write time: 467 09:41:38 INFO - run-tests - Wall time: 1175s; CPU: 53.0%; Read bytes: 34440192; Write bytes: 296572416; Read time: 225; Write time: 1131 09:41:39 INFO - Running post-run listener: _upload_blobber_files 09:41:39 INFO - Blob upload gear active. 09:41:39 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:41:39 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 09:41:39 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'] 09:41:39 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 09:41:39 INFO - (blobuploader) - INFO - Open directory for files ... 09:41:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:41:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:41:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:41:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:41:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:41:40 INFO - (blobuploader) - INFO - Done attempting. 09:41:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:41:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:41:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:41:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:41:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:41:41 INFO - (blobuploader) - INFO - Done attempting. 09:41:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:41:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:41:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:41:44 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:41:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:41:44 INFO - (blobuploader) - INFO - Done attempting. 09:41:44 INFO - (blobuploader) - INFO - Iteration through files over. 09:41:44 INFO - Return code: 0 09:41:44 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:41:44 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:41:44 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/616d6e35fc0f324c6727723ecfac22724bbbafbddd2f3b740652dc323f2a91d95f2e2532ef111551c6bb31710bbcae9cd909411f431d4b0a467e8a78d6e85fe8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d1110cb71ffb72b165b19022ddbdf739034ca166c34d9dd053e317defb0d556c6889a78742f5ee7c714d64df7b7c87ae96c47a00844e811ccb982245f23644cb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/200da834dbda30e5f5b65aa3c8168503e8503d5753424f607f2ce3e4442c19eddf4988c33d8c3a82a3b20f8eccb3eb42527041881bb9d0505e21a2a4749d2489"} 09:41:44 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:41:44 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:41:44 INFO - Contents: 09:41:44 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/616d6e35fc0f324c6727723ecfac22724bbbafbddd2f3b740652dc323f2a91d95f2e2532ef111551c6bb31710bbcae9cd909411f431d4b0a467e8a78d6e85fe8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d1110cb71ffb72b165b19022ddbdf739034ca166c34d9dd053e317defb0d556c6889a78742f5ee7c714d64df7b7c87ae96c47a00844e811ccb982245f23644cb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/200da834dbda30e5f5b65aa3c8168503e8503d5753424f607f2ce3e4442c19eddf4988c33d8c3a82a3b20f8eccb3eb42527041881bb9d0505e21a2a4749d2489"} 09:41:44 INFO - Running post-run listener: copy_logs_to_upload_dir 09:41:44 INFO - Copying logs to upload dir... 09:41:44 INFO - mkdir: /builds/slave/test/build/upload/logs 09:41:44 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1256.132374 ========= master_lag: 1.58 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2017-01-12 09:41:45.711429) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-12 09:41:45.718070) ========= 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.Sc6RDSgUor/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.fvbnTzQ15p/Listeners TMPDIR=/var/folders/wq/f5xgyhbd75545ndpjmyvls7c00000w/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/616d6e35fc0f324c6727723ecfac22724bbbafbddd2f3b740652dc323f2a91d95f2e2532ef111551c6bb31710bbcae9cd909411f431d4b0a467e8a78d6e85fe8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d1110cb71ffb72b165b19022ddbdf739034ca166c34d9dd053e317defb0d556c6889a78742f5ee7c714d64df7b7c87ae96c47a00844e811ccb982245f23644cb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/200da834dbda30e5f5b65aa3c8168503e8503d5753424f607f2ce3e4442c19eddf4988c33d8c3a82a3b20f8eccb3eb42527041881bb9d0505e21a2a4749d2489"} build_url:https://queue.taskcluster.net/v1/task/ImAQfE_YRgGX_1e-s5VZVw/artifacts/public/build/firefox-51.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011255 build_url: 'https://queue.taskcluster.net/v1/task/ImAQfE_YRgGX_1e-s5VZVw/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/616d6e35fc0f324c6727723ecfac22724bbbafbddd2f3b740652dc323f2a91d95f2e2532ef111551c6bb31710bbcae9cd909411f431d4b0a467e8a78d6e85fe8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d1110cb71ffb72b165b19022ddbdf739034ca166c34d9dd053e317defb0d556c6889a78742f5ee7c714d64df7b7c87ae96c47a00844e811ccb982245f23644cb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/200da834dbda30e5f5b65aa3c8168503e8503d5753424f607f2ce3e4442c19eddf4988c33d8c3a82a3b20f8eccb3eb42527041881bb9d0505e21a2a4749d2489"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-12 09:41:45.758889) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 3 secs) (at 2017-01-12 09:41:45.759216) ========= 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.Sc6RDSgUor/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.fvbnTzQ15p/Listeners TMPDIR=/var/folders/wq/f5xgyhbd75545ndpjmyvls7c00000w/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.004999 ========= master_lag: 3.36 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 3 secs) (at 2017-01-12 09:41:49.123352) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-12 09:41:49.123784) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-12 09:41:49.136232) ========= ========= Total master_lag: 5.05 =========