builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0249 starttime: 1480610959.08 results: success (0) buildid: 20161201065444 builduid: 20fde412ae8a45eaa3b5cd58528a8d64 revision: ed3d26ab8b35982ad915254c68087e97b2d9b792 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-01 08:49:19.079096) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-01 08:49:19.079576) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-01 08:49:19.079870) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-01 08:49:19.107162) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-01 08:49:19.107462) ========= 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.N9LfoUeDAN/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.0e06HXg8cb/Listeners TMPDIR=/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-12-01 08:49:19-- 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% 8.33M=0.001s 2016-12-01 08:49:19 (8.33 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.141543 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-01 08:49:19.272602) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-01 08:49:19.272983) ========= 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.N9LfoUeDAN/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.0e06HXg8cb/Listeners TMPDIR=/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/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.019666 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-01 08:49:19.321966) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-01 08:49:19.322349) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev ed3d26ab8b35982ad915254c68087e97b2d9b792 --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 ed3d26ab8b35982ad915254c68087e97b2d9b792 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.N9LfoUeDAN/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.0e06HXg8cb/Listeners TMPDIR=/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-12-01 08:49:19,403 truncating revision to first 12 chars 2016-12-01 08:49:19,403 Setting DEBUG logging. 2016-12-01 08:49:19,403 attempt 1/10 2016-12-01 08:49:19,403 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/ed3d26ab8b35?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-01 08:49:20,695 unpacking tar archive at: mozilla-beta-ed3d26ab8b35/testing/mozharness/ program finished with exit code 0 elapsedTime=1.549926 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-01 08:49:20.898459) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-01 08:49:20.898896) ========= script_repo_revision: ed3d26ab8b35982ad915254c68087e97b2d9b792 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-01 08:49:20.899293) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-01 08:49:20.899588) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-01 08:49:20.919299) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2016-12-01 08:49:20.919648) ========= /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.N9LfoUeDAN/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.0e06HXg8cb/Listeners TMPDIR=/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 08:49:21 INFO - MultiFileLogger online at 20161201 08:49:21 in /builds/slave/test 08:49:21 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 08:49:21 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:49:21 INFO - {'append_to_log': False, 08:49:21 INFO - 'base_work_dir': '/builds/slave/test', 08:49:21 INFO - 'blob_upload_branch': 'Mozilla-Beta', 08:49:21 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:49:21 INFO - 'branch': 'Mozilla-Beta', 08:49:21 INFO - 'buildbot_json_path': 'buildprops.json', 08:49:21 INFO - 'config_files': ('talos/mac_config.py',), 08:49:21 INFO - 'default_actions': ('clobber', 08:49:21 INFO - 'read-buildbot-config', 08:49:21 INFO - 'download-and-extract', 08:49:21 INFO - 'populate-webroot', 08:49:21 INFO - 'create-virtualenv', 08:49:21 INFO - 'install', 08:49:21 INFO - 'run-tests'), 08:49:21 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:49:21 INFO - 'download_minidump_stackwalk': True, 08:49:21 INFO - 'download_symbols': 'ondemand', 08:49:21 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:49:21 INFO - 'tooltool.py': '/tools/tooltool.py', 08:49:21 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:49:21 INFO - '/tools/misc-python/virtualenv.py')}, 08:49:21 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:49:21 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:49:21 INFO - 'installer_path': 'installer.exe', 08:49:21 INFO - 'log_level': 'info', 08:49:21 INFO - 'log_name': 'talos', 08:49:21 INFO - 'log_to_console': True, 08:49:21 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:49:21 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:49:21 INFO - 'opt_config_files': (), 08:49:21 INFO - 'pip_index': False, 08:49:21 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:49:21 INFO - 'cmd': ('bash', 08:49:21 INFO - '-c', 08:49:21 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:49:21 INFO - 'enabled': True, 08:49:21 INFO - 'halt_on_failure': False, 08:49:21 INFO - 'name': 'check_screen_resolution'},), 08:49:21 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:49:21 INFO - 'cmd': ('bash', 08:49:21 INFO - '-c', 08:49:21 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:49:21 INFO - 'enabled': True, 08:49:21 INFO - 'halt_on_failure': False, 08:49:21 INFO - 'name': 'check_screen_resolution'},), 08:49:21 INFO - 'run_cmd_checks_enabled': True, 08:49:21 INFO - 'sps_profile': False, 08:49:21 INFO - 'sps_profile_interval': 0, 08:49:21 INFO - 'suite': 'dromaeojs', 08:49:21 INFO - 'system_bits': '32', 08:49:21 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:49:21 INFO - 'title': 't-yosemite-r7-0249', 08:49:21 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:49:21 INFO - 'use_talos_json': True, 08:49:21 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:49:21 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:49:21 INFO - 'work_dir': 'build'} 08:49:21 INFO - [mozharness: 2016-12-01 16:49:21.114857Z] Running clobber step. 08:49:21 INFO - Running pre-action listener: _resource_record_pre_action 08:49:21 INFO - Running main action method: clobber 08:49:21 INFO - rmtree: /builds/slave/test/build 08:49:21 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:49:21 INFO - Running post-action listener: _resource_record_post_action 08:49:21 INFO - [mozharness: 2016-12-01 16:49:21.562618Z] Finished clobber step (success) 08:49:21 INFO - [mozharness: 2016-12-01 16:49:21.562856Z] Running read-buildbot-config step. 08:49:21 INFO - Running pre-action listener: _resource_record_pre_action 08:49:21 INFO - Running main action method: read_buildbot_config 08:49:21 INFO - Using buildbot properties: 08:49:21 INFO - { 08:49:21 INFO - "project": "", 08:49:21 INFO - "product": "firefox", 08:49:21 INFO - "script_repo_revision": "production", 08:49:21 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 08:49:21 INFO - "repository": "", 08:49:21 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 08:49:21 INFO - "buildid": "20161201065444", 08:49:21 INFO - "pgo_build": "False", 08:49:21 INFO - "basedir": "/builds/slave/test", 08:49:21 INFO - "buildnumber": 45, 08:49:21 INFO - "slavename": "t-yosemite-r7-0249", 08:49:21 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 08:49:21 INFO - "platform": "yosemite_r7", 08:49:21 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 08:49:21 INFO - "branch": "mozilla-beta", 08:49:21 INFO - "repo_path": "releases/mozilla-beta", 08:49:21 INFO - "revision": "ed3d26ab8b35982ad915254c68087e97b2d9b792", 08:49:21 INFO - "stage_platform": "macosx64", 08:49:21 INFO - "builduid": "20fde412ae8a45eaa3b5cd58528a8d64", 08:49:21 INFO - "slavebuilddir": "test" 08:49:21 INFO - } 08:49:21 INFO - Found installer url https://queue.taskcluster.net/v1/task/Jq0CJMX0RJW1dK38kXe2BQ/artifacts/public/build/firefox-51.0.en-US.mac.dmg. 08:49:21 INFO - Running post-action listener: _resource_record_post_action 08:49:21 INFO - [mozharness: 2016-12-01 16:49:21.568745Z] Finished read-buildbot-config step (success) 08:49:21 INFO - [mozharness: 2016-12-01 16:49:21.568812Z] Running download-and-extract step. 08:49:21 INFO - Running pre-action listener: _resource_record_pre_action 08:49:21 INFO - Running main action method: download_and_extract 08:49:21 INFO - mkdir: /builds/slave/test/build/tests 08:49:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:49:21 INFO - trying https://queue.taskcluster.net/v1/task/Jq0CJMX0RJW1dK38kXe2BQ/artifacts/public/build/firefox-51.0.en-US.mac.test_packages.json 08:49:21 INFO - Downloading https://queue.taskcluster.net/v1/task/Jq0CJMX0RJW1dK38kXe2BQ/artifacts/public/build/firefox-51.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0.en-US.mac.test_packages.json 08:49:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Jq0CJMX0RJW1dK38kXe2BQ/artifacts/public/build/firefox-51.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0.en-US.mac.test_packages.json'}, attempt #1 08:49:22 INFO - Downloaded 1165 bytes. 08:49:22 INFO - Reading from file /builds/slave/test/build/firefox-51.0.en-US.mac.test_packages.json 08:49:22 INFO - Using the following test package requirements: 08:49:22 INFO - {u'common': [u'firefox-51.0.en-US.mac.common.tests.zip'], 08:49:22 INFO - u'cppunittest': [u'firefox-51.0.en-US.mac.common.tests.zip', 08:49:22 INFO - u'firefox-51.0.en-US.mac.cppunittest.tests.zip'], 08:49:22 INFO - u'gtest': [u'firefox-51.0.en-US.mac.common.tests.zip', 08:49:22 INFO - u'firefox-51.0.en-US.mac.gtest.tests.zip'], 08:49:22 INFO - u'jittest': [u'firefox-51.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 08:49:22 INFO - u'mochitest': [u'firefox-51.0.en-US.mac.common.tests.zip', 08:49:22 INFO - u'firefox-51.0.en-US.mac.mochitest.tests.zip'], 08:49:22 INFO - u'mozbase': [u'firefox-51.0.en-US.mac.common.tests.zip'], 08:49:22 INFO - u'reftest': [u'firefox-51.0.en-US.mac.common.tests.zip', 08:49:22 INFO - u'firefox-51.0.en-US.mac.reftest.tests.zip'], 08:49:22 INFO - u'talos': [u'firefox-51.0.en-US.mac.common.tests.zip', 08:49:22 INFO - u'firefox-51.0.en-US.mac.talos.tests.zip'], 08:49:22 INFO - u'web-platform': [u'firefox-51.0.en-US.mac.common.tests.zip', 08:49:22 INFO - u'firefox-51.0.en-US.mac.web-platform.tests.zip'], 08:49:22 INFO - u'xpcshell': [u'firefox-51.0.en-US.mac.common.tests.zip', 08:49:22 INFO - u'firefox-51.0.en-US.mac.xpcshell.tests.zip']} 08:49:22 INFO - Downloading packages: [u'firefox-51.0.en-US.mac.common.tests.zip'] for test suite category: common 08:49:22 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Jq0CJMX0RJW1dK38kXe2BQ/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip 08:49:22 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Jq0CJMX0RJW1dK38kXe2BQ/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip'}, attempt #1 08:49:22 INFO - Fetch https://queue.taskcluster.net/v1/task/Jq0CJMX0RJW1dK38kXe2BQ/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip into memory 08:49:23 INFO - Expected file size: 16233212 08:49:30 INFO - Downloading packages: [u'firefox-51.0.en-US.mac.common.tests.zip', u'firefox-51.0.en-US.mac.talos.tests.zip'] for test suite category: talos 08:49:30 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Jq0CJMX0RJW1dK38kXe2BQ/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip 08:49:30 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Jq0CJMX0RJW1dK38kXe2BQ/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip'}, attempt #1 08:49:30 INFO - Fetch https://queue.taskcluster.net/v1/task/Jq0CJMX0RJW1dK38kXe2BQ/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip into memory 08:49:30 INFO - Expected file size: 16233212 08:49:37 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Jq0CJMX0RJW1dK38kXe2BQ/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip 08:49:37 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Jq0CJMX0RJW1dK38kXe2BQ/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip'}, attempt #1 08:49:37 INFO - Fetch https://queue.taskcluster.net/v1/task/Jq0CJMX0RJW1dK38kXe2BQ/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip into memory 08:49:38 INFO - Expected file size: 14414089 08:49:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:49:39 INFO - trying https://queue.taskcluster.net/v1/task/Jq0CJMX0RJW1dK38kXe2BQ/artifacts/public/build/firefox-51.0.en-US.mac.dmg 08:49:39 INFO - Downloading https://queue.taskcluster.net/v1/task/Jq0CJMX0RJW1dK38kXe2BQ/artifacts/public/build/firefox-51.0.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0.en-US.mac.dmg 08:49:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Jq0CJMX0RJW1dK38kXe2BQ/artifacts/public/build/firefox-51.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0.en-US.mac.dmg'}, attempt #1 08:49:41 INFO - Downloaded 86063310 bytes. 08:49:41 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Jq0CJMX0RJW1dK38kXe2BQ/artifacts/public/build/firefox-51.0.en-US.mac.dmg 08:49:41 INFO - mkdir: /builds/slave/test/properties 08:49:41 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:49:41 INFO - Writing to file /builds/slave/test/properties/build_url 08:49:41 INFO - Contents: 08:49:41 INFO - build_url:https://queue.taskcluster.net/v1/task/Jq0CJMX0RJW1dK38kXe2BQ/artifacts/public/build/firefox-51.0.en-US.mac.dmg 08:49:42 INFO - Running post-action listener: _resource_record_post_action 08:49:42 INFO - Running post-action listener: set_extra_try_arguments 08:49:42 INFO - [mozharness: 2016-12-01 16:49:42.055090Z] Finished download-and-extract step (success) 08:49:42 INFO - [mozharness: 2016-12-01 16:49:42.055212Z] Running populate-webroot step. 08:49:42 INFO - Running pre-action listener: _resource_record_pre_action 08:49:42 INFO - Running main action method: populate_webroot 08:49:42 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:49:42 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:49:42 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:49:42 INFO - '--tppagecycles', 08:49:42 INFO - '7'], 08:49:42 INFO - 'tests': ['tsvgm']}}, 08:49:42 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:49:42 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:49:42 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:49:42 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:49:42 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:49:42 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:49:42 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:49:42 INFO - 'talos_options': ['--disable-e10s'], 08:49:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:49:42 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:49:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:49:42 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:49:42 INFO - 'talos_options': ['--disable-e10s'], 08:49:42 INFO - 'tests': ['damp', 'tps']}, 08:49:42 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:49:42 INFO - 'tests': ['damp', 'tps']}, 08:49:42 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:49:42 INFO - 'tests': ['dromaeo_dom']}, 08:49:42 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:49:42 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:49:42 INFO - 'tests': ['basic_compositor_video']}, 08:49:42 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:49:42 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:49:42 INFO - 'tests': ['a11yr', 08:49:42 INFO - 'ts_paint', 08:49:42 INFO - 'tpaint', 08:49:42 INFO - 'sessionrestore', 08:49:42 INFO - 'sessionrestore_no_auto_restore', 08:49:42 INFO - 'tabpaint']}, 08:49:42 INFO - 'other-e10s': {'tests': ['a11yr', 08:49:42 INFO - 'ts_paint', 08:49:42 INFO - 'tpaint', 08:49:42 INFO - 'sessionrestore', 08:49:42 INFO - 'sessionrestore_no_auto_restore', 08:49:42 INFO - 'tabpaint']}, 08:49:42 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:49:42 INFO - 'ts_paint', 08:49:42 INFO - 'tpaint', 08:49:42 INFO - 'sessionrestore', 08:49:42 INFO - 'sessionrestore_no_auto_restore', 08:49:42 INFO - 'tabpaint']}, 08:49:42 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:49:42 INFO - 'ts_paint', 08:49:42 INFO - 'tpaint', 08:49:42 INFO - 'sessionrestore', 08:49:42 INFO - 'sessionrestore_no_auto_restore', 08:49:42 INFO - 'tabpaint']}, 08:49:42 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:49:42 INFO - 'tests': ['a11yr', 08:49:42 INFO - 'ts_paint', 08:49:42 INFO - 'tpaint', 08:49:42 INFO - 'sessionrestore', 08:49:42 INFO - 'sessionrestore_no_auto_restore', 08:49:42 INFO - 'tabpaint']}, 08:49:42 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:49:42 INFO - 'tests': ['a11yr', 08:49:42 INFO - 'ts_paint', 08:49:42 INFO - 'tpaint', 08:49:42 INFO - 'sessionrestore', 08:49:42 INFO - 'sessionrestore_no_auto_restore', 08:49:42 INFO - 'tabpaint']}, 08:49:42 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:49:42 INFO - 'tests': ['tsvgx', 08:49:42 INFO - 'tsvgr_opacity', 08:49:42 INFO - 'tart', 08:49:42 INFO - 'tscrollx', 08:49:42 INFO - 'cart']}, 08:49:42 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:49:42 INFO - 'tsvgr_opacity', 08:49:42 INFO - 'tart', 08:49:42 INFO - 'tscrollx', 08:49:42 INFO - 'cart']}, 08:49:42 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:49:42 INFO - 'talos_options': ['--disable-e10s'], 08:49:42 INFO - 'tests': ['tp5o']}, 08:49:42 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:49:42 INFO - 'tests': ['tp5o']}, 08:49:42 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:49:42 INFO - 'talos_options': ['--disable-e10s', 08:49:42 INFO - '--xperf_path', 08:49:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:49:42 INFO - 'tests': ['tp5n']}, 08:49:42 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:49:42 INFO - 'talos_options': ['--xperf_path', 08:49:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:49:42 INFO - 'tests': ['tp5n']}}, 08:49:42 INFO - 'talos.zip': {'path': '', 08:49:42 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:49:42 INFO - Running post-action listener: _resource_record_post_action 08:49:42 INFO - [mozharness: 2016-12-01 16:49:42.073981Z] Finished populate-webroot step (success) 08:49:42 INFO - [mozharness: 2016-12-01 16:49:42.074093Z] Running create-virtualenv step. 08:49:42 INFO - Running pre-action listener: _resource_record_pre_action 08:49:42 INFO - Running main action method: create_virtualenv 08:49:42 INFO - Creating virtualenv /builds/slave/test/build/venv 08:49:42 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 08:49:42 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:49:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:49:42 INFO - Using real prefix '/tools/python27' 08:49:42 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:49:42 INFO - Installing distribute.............................................................................................................................................................................................done. 08:49:45 INFO - Installing pip.................done. 08:49:45 INFO - Return code: 0 08:49:45 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:49:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:49:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:49:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:49:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:49:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49:45 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 0x10336a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1032e0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb54a5b5420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10317ed30>, '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 0x102fe4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103176b20>, '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.N9LfoUeDAN/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.0e06HXg8cb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:49:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:49:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:49:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.N9LfoUeDAN/Render', 08:49:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:49:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:49:45 INFO - 'HOME': '/Users/cltbld', 08:49:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:49:45 INFO - 'LOGNAME': 'cltbld', 08:49:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:49:45 INFO - 'MOZ_NO_REMOTE': '1', 08:49:45 INFO - 'NO_EM_RESTART': '1', 08:49:45 INFO - 'PAGER': '/bin/cat', 08:49:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:49:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:49:45 INFO - 'PWD': '/builds/slave/test', 08:49:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:49:45 INFO - 'SHELL': '/bin/bash', 08:49:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0e06HXg8cb/Listeners', 08:49:45 INFO - 'TMPDIR': '/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/', 08:49:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:49:45 INFO - 'USER': 'cltbld', 08:49:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:49:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:49:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:49:45 INFO - 'XPC_FLAGS': '0x0', 08:49:45 INFO - 'XPC_SERVICE_NAME': '0', 08:49:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:49:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:49:46 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 08:49:46 INFO - Cleaning up... 08:49:46 INFO - Return code: 0 08:49:46 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:49:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:49:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:49:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:49:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:49:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10336a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1032e0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb54a5b5420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10317ed30>, '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 0x102fe4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103176b20>, '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.N9LfoUeDAN/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.0e06HXg8cb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:49:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:49:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:49:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.N9LfoUeDAN/Render', 08:49:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:49:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:49:46 INFO - 'HOME': '/Users/cltbld', 08:49:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:49:46 INFO - 'LOGNAME': 'cltbld', 08:49:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:49:46 INFO - 'MOZ_NO_REMOTE': '1', 08:49:46 INFO - 'NO_EM_RESTART': '1', 08:49:46 INFO - 'PAGER': '/bin/cat', 08:49:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:49:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:49:46 INFO - 'PWD': '/builds/slave/test', 08:49:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:49:46 INFO - 'SHELL': '/bin/bash', 08:49:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0e06HXg8cb/Listeners', 08:49:46 INFO - 'TMPDIR': '/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/', 08:49:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:49:46 INFO - 'USER': 'cltbld', 08:49:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:49:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:49:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:49:46 INFO - 'XPC_FLAGS': '0x0', 08:49:46 INFO - 'XPC_SERVICE_NAME': '0', 08:49:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:49:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:49:46 INFO - Downloading/unpacking psutil>=3.1.1 08:49:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:49:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:49:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:49:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:49:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:49:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:49:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:49:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:49:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:49:49 INFO - Installing collected packages: psutil 08:49:49 INFO - Running setup.py install for psutil 08:49:49 INFO - building 'psutil._psutil_osx' extension 08:49:49 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 08:49:49 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 08:49:49 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 08:49:49 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 08:49:49 INFO - building 'psutil._psutil_posix' extension 08:49:49 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 08:49:49 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 08:49:49 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 08:49:49 INFO - ^ 08:49:50 INFO - 1 warning generated. 08:49:50 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 08:49:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:49:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:49:50 INFO - Successfully installed psutil 08:49:50 INFO - Cleaning up... 08:49:50 INFO - Return code: 0 08:49:50 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:49:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:49:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:49:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:49:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:49:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10336a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1032e0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb54a5b5420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10317ed30>, '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 0x102fe4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103176b20>, '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.N9LfoUeDAN/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.0e06HXg8cb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:49:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:49:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 08:49:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.N9LfoUeDAN/Render', 08:49:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:49:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:49:50 INFO - 'HOME': '/Users/cltbld', 08:49:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:49:50 INFO - 'LOGNAME': 'cltbld', 08:49:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:49:50 INFO - 'MOZ_NO_REMOTE': '1', 08:49:50 INFO - 'NO_EM_RESTART': '1', 08:49:50 INFO - 'PAGER': '/bin/cat', 08:49:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:49:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:49:50 INFO - 'PWD': '/builds/slave/test', 08:49:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:49:50 INFO - 'SHELL': '/bin/bash', 08:49:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0e06HXg8cb/Listeners', 08:49:50 INFO - 'TMPDIR': '/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/', 08:49:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:49:50 INFO - 'USER': 'cltbld', 08:49:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:49:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:49:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:49:50 INFO - 'XPC_FLAGS': '0x0', 08:49:50 INFO - 'XPC_SERVICE_NAME': '0', 08:49:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:49:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:49:50 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:49:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:49:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:49:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:49:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:49:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:49:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:49:53 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:49:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:49:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:49:53 INFO - Installing collected packages: mozsystemmonitor 08:49:53 INFO - Running setup.py install for mozsystemmonitor 08:49:53 INFO - Successfully installed mozsystemmonitor 08:49:53 INFO - Cleaning up... 08:49:53 INFO - Return code: 0 08:49:53 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:49:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:49:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:49:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:49:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:49:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49:53 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 0x10336a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1032e0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb54a5b5420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10317ed30>, '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 0x102fe4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103176b20>, '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.N9LfoUeDAN/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.0e06HXg8cb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:49:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:49:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 08:49:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.N9LfoUeDAN/Render', 08:49:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:49:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:49:53 INFO - 'HOME': '/Users/cltbld', 08:49:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:49:53 INFO - 'LOGNAME': 'cltbld', 08:49:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:49:53 INFO - 'MOZ_NO_REMOTE': '1', 08:49:53 INFO - 'NO_EM_RESTART': '1', 08:49:53 INFO - 'PAGER': '/bin/cat', 08:49:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:49:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:49:53 INFO - 'PWD': '/builds/slave/test', 08:49:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:49:53 INFO - 'SHELL': '/bin/bash', 08:49:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0e06HXg8cb/Listeners', 08:49:53 INFO - 'TMPDIR': '/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/', 08:49:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:49:53 INFO - 'USER': 'cltbld', 08:49:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:49:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:49:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:49:53 INFO - 'XPC_FLAGS': '0x0', 08:49:53 INFO - 'XPC_SERVICE_NAME': '0', 08:49:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:49:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:49:53 INFO - Downloading/unpacking jsonschema==2.5.1 08:49:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:49:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:49:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:49:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:49:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:49:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:49:56 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:49:56 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:49:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:49:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:49:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:49:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:49:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:49:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:49:56 INFO - Downloading functools32-3.2.3-2.tar.gz 08:49:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:49:56 INFO - warning: no files found matching '*.txt' 08:49:56 INFO - no previously-included directories found matching 'build' 08:49:56 INFO - no previously-included directories found matching 'dist' 08:49:56 INFO - no previously-included directories found matching '.git*' 08:49:56 INFO - Installing collected packages: jsonschema, functools32 08:49:56 INFO - Running setup.py install for functools32 08:49:56 INFO - warning: no files found matching '*.txt' 08:49:56 INFO - no previously-included directories found matching 'build' 08:49:56 INFO - no previously-included directories found matching 'dist' 08:49:56 INFO - no previously-included directories found matching '.git*' 08:49:56 INFO - Successfully installed jsonschema functools32 08:49:56 INFO - Cleaning up... 08:49:57 INFO - Return code: 0 08:49:57 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:49:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:49:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:49:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:49:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:49:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10336a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1032e0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb54a5b5420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10317ed30>, '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 0x102fe4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103176b20>, '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.N9LfoUeDAN/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.0e06HXg8cb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:49:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 08:49:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 08:49:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.N9LfoUeDAN/Render', 08:49:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:49:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:49:57 INFO - 'HOME': '/Users/cltbld', 08:49:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:49:57 INFO - 'LOGNAME': 'cltbld', 08:49:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:49:57 INFO - 'MOZ_NO_REMOTE': '1', 08:49:57 INFO - 'NO_EM_RESTART': '1', 08:49:57 INFO - 'PAGER': '/bin/cat', 08:49:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:49:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:49:57 INFO - 'PWD': '/builds/slave/test', 08:49:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:49:57 INFO - 'SHELL': '/bin/bash', 08:49:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0e06HXg8cb/Listeners', 08:49:57 INFO - 'TMPDIR': '/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/', 08:49:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:49:57 INFO - 'USER': 'cltbld', 08:49:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:49:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:49:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:49:57 INFO - 'XPC_FLAGS': '0x0', 08:49:57 INFO - 'XPC_SERVICE_NAME': '0', 08:49:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:49:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:49:57 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:49:57 INFO - Cleaning up... 08:49:57 INFO - Return code: 0 08:49:57 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:49:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:49:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:49:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:49:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:49:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10336a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1032e0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb54a5b5420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10317ed30>, '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 0x102fe4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103176b20>, '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.N9LfoUeDAN/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.0e06HXg8cb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:49:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:49:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:49:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.N9LfoUeDAN/Render', 08:49:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:49:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:49:57 INFO - 'HOME': '/Users/cltbld', 08:49:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:49:57 INFO - 'LOGNAME': 'cltbld', 08:49:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:49:57 INFO - 'MOZ_NO_REMOTE': '1', 08:49:57 INFO - 'NO_EM_RESTART': '1', 08:49:57 INFO - 'PAGER': '/bin/cat', 08:49:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:49:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:49:57 INFO - 'PWD': '/builds/slave/test', 08:49:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:49:57 INFO - 'SHELL': '/bin/bash', 08:49:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0e06HXg8cb/Listeners', 08:49:57 INFO - 'TMPDIR': '/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/', 08:49:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:49:57 INFO - 'USER': 'cltbld', 08:49:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:49:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:49:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:49:57 INFO - 'XPC_FLAGS': '0x0', 08:49:57 INFO - 'XPC_SERVICE_NAME': '0', 08:49:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:49:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:49:57 INFO - Downloading/unpacking blobuploader==1.2.4 08:49:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:49:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:49:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:49:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:49:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:49:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:50:00 INFO - Downloading blobuploader-1.2.4.tar.gz 08:50:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:50:00 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:50:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:50:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:50:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:50:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:50:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:50:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:50:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:50:00 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:50:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:50:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:50:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:50:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:50:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:50:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:50:01 INFO - Downloading docopt-0.6.1.tar.gz 08:50:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:50:01 INFO - Installing collected packages: blobuploader, requests, docopt 08:50:01 INFO - Running setup.py install for blobuploader 08:50:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:50:01 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:50:01 INFO - Running setup.py install for requests 08:50:02 INFO - Running setup.py install for docopt 08:50:02 INFO - Successfully installed blobuploader requests docopt 08:50:02 INFO - Cleaning up... 08:50:02 INFO - Return code: 0 08:50:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:50:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:50:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:50:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:50:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:50:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:50:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:50:02 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 0x10336a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1032e0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb54a5b5420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10317ed30>, '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 0x102fe4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103176b20>, '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.N9LfoUeDAN/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.0e06HXg8cb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:50:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:50:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:50:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.N9LfoUeDAN/Render', 08:50:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:50:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:50:02 INFO - 'HOME': '/Users/cltbld', 08:50:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:50:02 INFO - 'LOGNAME': 'cltbld', 08:50:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:50:02 INFO - 'MOZ_NO_REMOTE': '1', 08:50:02 INFO - 'NO_EM_RESTART': '1', 08:50:02 INFO - 'PAGER': '/bin/cat', 08:50:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:50:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:50:02 INFO - 'PWD': '/builds/slave/test', 08:50:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:50:02 INFO - 'SHELL': '/bin/bash', 08:50:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0e06HXg8cb/Listeners', 08:50:02 INFO - 'TMPDIR': '/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/', 08:50:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:50:02 INFO - 'USER': 'cltbld', 08:50:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:50:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:50:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:50:02 INFO - 'XPC_FLAGS': '0x0', 08:50:02 INFO - 'XPC_SERVICE_NAME': '0', 08:50:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:50:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:50:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:50:02 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-f_sGw3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:50:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:50:02 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-4tun5k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:50:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:50:02 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-TI3U6Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:50:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:50:02 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-c6eb5l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:50:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:50:03 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-00cz1a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:50:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:50:03 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-zf_neP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:50:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:50:03 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-MAtKg0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:50:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:50:03 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-LHWely-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:50:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:50:03 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-yd5Fb_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:50:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:50:03 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-FD_KwY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:50:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:50:03 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-HcXp35-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:50:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:50:03 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-c07VtU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:50:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:50:03 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-RdfJXT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:50:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:50:03 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-qgOlVI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:50:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:50:04 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-ftouCJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:50:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:50:04 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-rBsAIS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:50:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:50:04 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-0mEhbf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:50:04 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:50:04 INFO - Running setup.py install for manifestparser 08:50:04 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:50:04 INFO - Running setup.py install for mozcrash 08:50:04 INFO - Running setup.py install for mozdebug 08:50:04 INFO - Running setup.py install for mozdevice 08:50:05 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:50:05 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:50:05 INFO - Running setup.py install for mozfile 08:50:05 INFO - Running setup.py install for mozhttpd 08:50:05 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:50:05 INFO - Running setup.py install for mozinfo 08:50:05 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:50:05 INFO - Running setup.py install for mozInstall 08:50:05 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:50:05 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:50:05 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:50:05 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:50:05 INFO - Running setup.py install for mozleak 08:50:05 INFO - Running setup.py install for mozlog 08:50:05 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:50:05 INFO - Running setup.py install for moznetwork 08:50:06 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:50:06 INFO - Running setup.py install for mozprocess 08:50:06 INFO - Running setup.py install for mozprofile 08:50:06 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:50:06 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:50:06 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:50:06 INFO - Running setup.py install for mozrunner 08:50:06 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:50:06 INFO - Running setup.py install for mozscreenshot 08:50:06 INFO - Running setup.py install for moztest 08:50:06 INFO - Running setup.py install for mozversion 08:50:06 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:50:07 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:50:07 INFO - Cleaning up... 08:50:07 INFO - Return code: 0 08:50:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:50:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:50:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:50:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:50:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:50:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:50:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:50:07 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 0x10336a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1032e0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb54a5b5420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10317ed30>, '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 0x102fe4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103176b20>, '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.N9LfoUeDAN/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.0e06HXg8cb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:50:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:50:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:50:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.N9LfoUeDAN/Render', 08:50:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:50:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:50:07 INFO - 'HOME': '/Users/cltbld', 08:50:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:50:07 INFO - 'LOGNAME': 'cltbld', 08:50:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:50:07 INFO - 'MOZ_NO_REMOTE': '1', 08:50:07 INFO - 'NO_EM_RESTART': '1', 08:50:07 INFO - 'PAGER': '/bin/cat', 08:50:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:50:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:50:07 INFO - 'PWD': '/builds/slave/test', 08:50:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:50:07 INFO - 'SHELL': '/bin/bash', 08:50:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0e06HXg8cb/Listeners', 08:50:07 INFO - 'TMPDIR': '/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/', 08:50:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:50:07 INFO - 'USER': 'cltbld', 08:50:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:50:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:50:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:50:07 INFO - 'XPC_FLAGS': '0x0', 08:50:07 INFO - 'XPC_SERVICE_NAME': '0', 08:50:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:50:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:50:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:50:07 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-T9Z4we-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:50:07 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 08:50:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:50:07 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-cFwFPX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:50:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:50:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:50:07 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-NGRYJz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:50:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:50:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:50:07 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-xveMBw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:50:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:50:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:50:07 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-finnae-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:50:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 08:50:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:50:07 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-U1m46V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:50:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 08:50:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:50:07 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-MBOvHu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:50:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 08:50:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:50:08 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-nKdUPp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:50:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 08:50:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:50:08 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-iQzRDB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:50:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 08:50:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:50:08 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-Ek5bTx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:50:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:50:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:50:08 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-3rf9Nd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:50:08 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 08:50:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:50:08 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-CIvjvo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:50:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 08:50:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:50:08 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-Kqxwbq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:50:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 08:50:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:50:08 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-h8RHPs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:50:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 08:50:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:50:08 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-GdHG98-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:50:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 08:50:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:50:08 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-OwUq08-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:50:08 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 08:50:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:50:09 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-jWiSVR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:50:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 08:50:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:50:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:50:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:50:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:50:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:50:09 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:50:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:50:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:50:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:50:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:50:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:50:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:50:12 INFO - Downloading blessings-1.6.tar.gz 08:50:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:50:12 INFO - Installing collected packages: blessings 08:50:12 INFO - Running setup.py install for blessings 08:50:12 INFO - Successfully installed blessings 08:50:12 INFO - Cleaning up... 08:50:12 INFO - Return code: 0 08:50:12 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:50:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:50:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:50:12 INFO - Reading from file tmpfile_stdout 08:50:12 INFO - Current package versions: 08:50:12 INFO - blessings == 1.6 08:50:12 INFO - blobuploader == 1.2.4 08:50:12 INFO - docopt == 0.6.1 08:50:12 INFO - functools32 == 3.2.3-2 08:50:12 INFO - jsonschema == 2.5.1 08:50:12 INFO - manifestparser == 1.1 08:50:12 INFO - mozInstall == 1.12 08:50:12 INFO - mozcrash == 0.17 08:50:12 INFO - mozdebug == 0.1 08:50:12 INFO - mozdevice == 0.48 08:50:12 INFO - mozfile == 1.2 08:50:12 INFO - mozhttpd == 0.7 08:50:12 INFO - mozinfo == 0.9 08:50:12 INFO - mozleak == 0.1 08:50:12 INFO - mozlog == 3.4 08:50:12 INFO - moznetwork == 0.27 08:50:12 INFO - mozprocess == 0.23 08:50:12 INFO - mozprofile == 0.28 08:50:12 INFO - mozrunner == 6.12 08:50:12 INFO - mozscreenshot == 0.1 08:50:12 INFO - mozsystemmonitor == 0.3 08:50:12 INFO - moztest == 0.7 08:50:12 INFO - mozversion == 1.4 08:50:12 INFO - psutil == 3.1.1 08:50:12 INFO - requests == 1.2.3 08:50:12 INFO - wsgiref == 0.1.2 08:50:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:50:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:50:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:50:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:50: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')]} 08:50:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:50:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:50:13 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 0x10336a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1032e0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb54a5b5420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10317ed30>, '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 0x102fe4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103176b20>, '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.N9LfoUeDAN/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.0e06HXg8cb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:50:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 08:50:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:50:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.N9LfoUeDAN/Render', 08:50:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:50:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:50:13 INFO - 'HOME': '/Users/cltbld', 08:50:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:50:13 INFO - 'LOGNAME': 'cltbld', 08:50:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:50:13 INFO - 'MOZ_NO_REMOTE': '1', 08:50:13 INFO - 'NO_EM_RESTART': '1', 08:50:13 INFO - 'PAGER': '/bin/cat', 08:50:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:50:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:50:13 INFO - 'PWD': '/builds/slave/test', 08:50:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:50:13 INFO - 'SHELL': '/bin/bash', 08:50:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0e06HXg8cb/Listeners', 08:50:13 INFO - 'TMPDIR': '/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/', 08:50:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:50:13 INFO - 'USER': 'cltbld', 08:50:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:50:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:50:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:50:13 INFO - 'XPC_FLAGS': '0x0', 08:50:13 INFO - 'XPC_SERVICE_NAME': '0', 08:50:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:50:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:50:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:50:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 08:50:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 08:50:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:50:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 08:50:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 08:50:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 08:50:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 08:50:13 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 08:50:13 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:50:13 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:50:13 INFO - Cleaning up... 08:50:13 INFO - Return code: 0 08:50:13 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:50: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')]} 08:50:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:50:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:50: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')]} 08:50:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:50:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:50: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10336a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1032e0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb54a5b5420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10317ed30>, '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 0x102fe4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103176b20>, '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.N9LfoUeDAN/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.0e06HXg8cb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:50: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', 'jsonschema'] in /builds/slave/test/build 08:50: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 jsonschema 08:50:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.N9LfoUeDAN/Render', 08:50:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:50:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:50:13 INFO - 'HOME': '/Users/cltbld', 08:50:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:50:13 INFO - 'LOGNAME': 'cltbld', 08:50:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:50:13 INFO - 'MOZ_NO_REMOTE': '1', 08:50:13 INFO - 'NO_EM_RESTART': '1', 08:50:13 INFO - 'PAGER': '/bin/cat', 08:50:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:50:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:50:13 INFO - 'PWD': '/builds/slave/test', 08:50:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:50:13 INFO - 'SHELL': '/bin/bash', 08:50:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0e06HXg8cb/Listeners', 08:50:13 INFO - 'TMPDIR': '/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/', 08:50:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:50:13 INFO - 'USER': 'cltbld', 08:50:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:50:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:50:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:50:13 INFO - 'XPC_FLAGS': '0x0', 08:50:13 INFO - 'XPC_SERVICE_NAME': '0', 08:50:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:50:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:50:13 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:50:13 INFO - Cleaning up... 08:50:13 INFO - Return code: 0 08:50:13 INFO - Running post-action listener: _resource_record_post_action 08:50:13 INFO - Running post-action listener: _start_resource_monitoring 08:50:13 INFO - Starting resource monitoring. 08:50:13 INFO - [mozharness: 2016-12-01 16:50:13.761393Z] Finished create-virtualenv step (success) 08:50:13 INFO - [mozharness: 2016-12-01 16:50:13.762386Z] Running install step. 08:50:13 INFO - Running pre-action listener: _resource_record_pre_action 08:50:13 INFO - Running main action method: install 08:50:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:50:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:50:14 INFO - Reading from file tmpfile_stdout 08:50:14 INFO - Detecting whether we're running mozinstall >=1.0... 08:50:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:50:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:50:14 INFO - Reading from file tmpfile_stdout 08:50:14 INFO - Output received: 08:50:14 INFO - Usage: mozinstall [options] installer 08:50:14 INFO - Options: 08:50:14 INFO - -h, --help show this help message and exit 08:50:14 INFO - -d DEST, --destination=DEST 08:50:14 INFO - Directory to install application into. [default: 08:50:14 INFO - "/builds/slave/test"] 08:50:14 INFO - --app=APP Application being installed. [default: firefox] 08:50:14 INFO - mkdir: /builds/slave/test/build/application 08:50:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 08:50:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0.en-US.mac.dmg --destination /builds/slave/test/build/application 08:50:36 INFO - Reading from file tmpfile_stdout 08:50:36 INFO - Output received: 08:50:36 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 08:50:36 INFO - Running post-action listener: _resource_record_post_action 08:50:36 INFO - [mozharness: 2016-12-01 16:50:36.474414Z] Finished install step (success) 08:50:36 INFO - [mozharness: 2016-12-01 16:50:36.474546Z] Running run-tests step. 08:50:36 INFO - Running pre-action listener: _resource_record_pre_action 08:50:36 INFO - Running main action method: run_tests 08:50:36 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:50:36 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:50:36 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:50:36 INFO - 2016-12-01 08:50:36.489 screenresolution[2611:293522] starting screenresolution argv=screenresolution get 08:50:36 INFO - 2016-12-01 08:50:36.492 screenresolution[2611:293522] Display 0: 1600x1200x32@60 08:50:36 INFO - 2016-12-01 08:50:36.498 screenresolution[2612:293525] starting screenresolution argv=screenresolution list 08:50:36 INFO - Available Modes on Display 0 08:50:36 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:50:36 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:50:36 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:50:36 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:50:36 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:50:36 INFO - Intel Iris: 08:50:36 INFO - Chipset Model: Intel Iris 08:50:36 INFO - Type: GPU 08:50:36 INFO - Bus: Built-In 08:50:36 INFO - VRAM (Dynamic, Max): 1536 MB 08:50:36 INFO - Vendor: Intel (0x8086) 08:50:36 INFO - Device ID: 0x0a2e 08:50:36 INFO - Revision ID: 0x0009 08:50:36 INFO - Displays: 08:50:36 INFO - Display: 08:50:36 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:50:36 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:50:36 INFO - Display Serial Number: 1600x1200 60 08:50:36 INFO - Main Display: Yes 08:50:36 INFO - Mirror: Off 08:50:36 INFO - Online: Yes 08:50:36 INFO - Rotation: Supported 08:50:36 INFO - Return code: 0 08:50:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:50:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:50:36 INFO - Python 2.7.3 08:50:36 INFO - Return code: 0 08:50:36 INFO - grabbing minidump binary from tooltool 08:50: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')]} 08:50:36 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 0x10317ed30>, '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 0x102fe4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103176b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:50:36 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 08:50:36 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 08:50:36 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 08:50:36 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:50:36 INFO - Return code: 0 08:50:36 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 08:50:36 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:50:36 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:50:36 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 08:50:36 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:50:36 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/Jq0CJMX0RJW1dK38kXe2BQ/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0249', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 08:50:36 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/Jq0CJMX0RJW1dK38kXe2BQ/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0249 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 08:50:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.N9LfoUeDAN/Render', 08:50:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:50:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:50:36 INFO - 'HOME': '/Users/cltbld', 08:50:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:50:36 INFO - 'LOGNAME': 'cltbld', 08:50:36 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:50:36 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 08:50:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:50:36 INFO - 'MOZ_NO_REMOTE': '1', 08:50:36 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:50:36 INFO - 'NO_EM_RESTART': '1', 08:50:36 INFO - 'PAGER': '/bin/cat', 08:50:36 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:50:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:50:36 INFO - 'PWD': '/builds/slave/test', 08:50:36 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:50:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:50:36 INFO - 'SHELL': '/bin/bash', 08:50:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0e06HXg8cb/Listeners', 08:50:36 INFO - 'TMPDIR': '/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/', 08:50:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:50:36 INFO - 'USER': 'cltbld', 08:50:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:50:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:50:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:50:36 INFO - 'XPC_FLAGS': '0x0', 08:50:36 INFO - 'XPC_SERVICE_NAME': '0', 08:50:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:50:36 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/Jq0CJMX0RJW1dK38kXe2BQ/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0249', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 08:50:37 INFO - mozversion application_buildid: 20161201065444 08:50:37 INFO - mozversion application_changeset: ed3d26ab8b35982ad915254c68087e97b2d9b792 08:50:37 INFO - mozversion application_display_name: Firefox 08:50:37 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:50:37 INFO - mozversion application_name: Firefox 08:50:37 INFO - mozversion application_remotingname: firefox 08:50:37 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 08:50:37 INFO - mozversion application_vendor: Mozilla 08:50:37 INFO - mozversion application_version: 51.0 08:50:37 INFO - mozversion platform_buildid: 20161201065444 08:50:37 INFO - mozversion platform_changeset: ed3d26ab8b35982ad915254c68087e97b2d9b792 08:50:37 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 08:50:37 INFO - mozversion platform_version: 51.0 08:50:37 INFO - using testdate: 1480611037 08:50:37 INFO - actual date: 1480611037 08:50:37 INFO - starting webserver on 'localhost:52935' 08:50:37 INFO - SUITE-START | Running 2 tests 08:50:37 INFO - TEST-START | dromaeo_css 08:50:37 INFO - operating with platform_type : mac_ 08:50:37 INFO - Initialising browser for dromaeo_css test... 08:50:37 INFO - TEST-INFO | started process 2622 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/tmpfwXTGp/profile http://localhost:52935/getInfo.html) 08:50:39 INFO - PROCESS | 2622 | __metrics Screen width/height:1600/1200 08:50:39 INFO - PROCESS | 2622 | colorDepth:24 08:50:39 INFO - PROCESS | 2622 | Browser inner width/height: 1024/689 08:50:39 INFO - PROCESS | 2622 | __metrics 08:50:39 INFO - PROCESS | 2622 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:50:39 INFO - PROCESS | 2622 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:50:40 INFO - TEST-INFO | 2622: exit 0 08:50:40 INFO - Browser initialized. 08:50:40 INFO - Running cycle 1/1 for dromaeo_css test... 08:50:40 INFO - TEST-INFO | started process 2626 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/tmpfwXTGp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:50:52 INFO - PROCESS | 2626 | RSS: Main: 169160704 08:50:52 INFO - PROCESS | 2626 | 08:51:43 INFO - PROCESS | 2626 | 1480611103907 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 08:53:54 INFO - PROCESS | 2626 | Cycle 1(1): loaded http://localhost:52935/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52935/tests/dromaeo/cssquery-ext.html) 08:53:55 INFO - PROCESS | 2626 | RSS: Main: 283877376 08:53:55 INFO - PROCESS | 2626 | 08:56:58 INFO - PROCESS | 2626 | Cycle 1(1): loaded http://localhost:52935/tests/dromaeo/cssquery-ext.html (next: http://localhost:52935/tests/dromaeo/cssquery-jquery.html) 08:56:58 INFO - PROCESS | 2626 | RSS: Main: 299479040 08:56:58 INFO - PROCESS | 2626 | 09:00:01 INFO - PROCESS | 2626 | Cycle 1(1): loaded http://localhost:52935/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52935/tests/dromaeo/cssquery-mootools.html) 09:00:01 INFO - PROCESS | 2626 | RSS: Main: 266326016 09:00:01 INFO - PROCESS | 2626 | 09:03:03 INFO - PROCESS | 2626 | Cycle 1(1): loaded http://localhost:52935/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52935/tests/dromaeo/cssquery-prototype.html) 09:03:04 INFO - PROCESS | 2626 | RSS: Main: 284155904 09:03:04 INFO - PROCESS | 2626 | 09:06:07 INFO - PROCESS | 2626 | Cycle 1(1): loaded http://localhost:52935/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52935/tests/dromaeo/cssquery-yui.html) 09:06:08 INFO - PROCESS | 2626 | RSS: Main: 262352896 09:06:08 INFO - PROCESS | 2626 | 09:09:11 INFO - PROCESS | 2626 | Cycle 1(1): loaded http://localhost:52935/tests/dromaeo/cssquery-yui.html (next: http://localhost:52935/tests/dromaeo/cssquery-dojo.html) 09:09:11 INFO - PROCESS | 2626 | RSS: Main: 308535296 09:09:11 INFO - PROCESS | 2626 | 09:09:11 INFO - PROCESS | 2626 | __start_tp_report 09:09:11 INFO - PROCESS | 2626 | _x_x_mozilla_page_load 09:09:11 INFO - PROCESS | 2626 | _x_x_mozilla_page_load_details 09:09:11 INFO - PROCESS | 2626 | |i|pagename|runs| 09:09:11 INFO - PROCESS | 2626 | |0;dojo.html;3404.5233667286584;3447.2588393495394;3462.619111897691;3488.668576485233;3510.771799833011;5763.56773242007;5830.6501609903435;5885.558583106263;5893.911591326134;5912.142739302799;5773.797917072903;5791.391903850098;5879.11813228016;5889.263842019747;5912.704364781765;5265.420803711599;5289.761960711778;5360.731963401814;5366.221897824813;5372.54333381663;5221.530062294392;5226.08543504887;5237.057329680656;5376.973115134419;5396.028714831329;5204.1413166827615;5274.971380580789;5300.708461034642;5303.098473259555;5308.203769434577;5275.182346736262;5303.893922121536;5344.412114667383;5366.9463305366835;5384.219288203189;5122;5210.739463026834;5309.309789727349;5311;5334.1732031535175;5692.6299790513485;5704.828855134353;5729.856753581152;5741.052726300156;5773.191753154561;6215.316315205324;6281.309056003882;6304.7793327233785;6322.4942004639515;6337.524685648595;6276.466500347476;6278.40355166263;6283.465905398047;6293.30773614902;6295.653739044351;5759.1937128802;5776.104703770922;5786.334571524244;5801.390853960358;5820.912686309709;6298.02380631003;6299.622022678563;6328.430441260309;6329.019002054597;6337.33457986914;6231.563790534619;6244.188255526843;6246.063090536365;6255.311915689271;6258.123862659231;6202.689865506797;6216.627002379872;6232;6268.811935641938;6282.842928926722;6289.937100629027;6290.402411770874;6302.149209856702;6309.684515774193;6309.684515774193;6201.472874805602;6262.655553944577;6299.874002520016;6310.5267104967315;6324.33594472583;4891.682040667345;4948.158813001798;4958.206686930074;4987.725675087905;5000.2499625056535;4568.063546972929;4569.200389931749;4594.95405045952;4621.722696638212;4625.930611040837;5790.044642634002;5792.073268277056;5797.333306669787;5804.4195580442465;5836.824895253149;6182.783602573978;6217.129601855744;6223.719932603044;6251.562390632612;6275.02737075754;5710.7430165642645;5711.942880571141;5716.314042314865;5747.942520574825;5776.508996735324;5410.1343784994215;5435.891282174334;5436.91844622331;5456.727163641802;5464.23500709901;6200.658963757037;6242.687865606792;6243.37566243372;6267.4986001119805;6339.175907132043;6268.404501572343;6293.748250070129;6300.716467759054;6301;6301.338359472373;5578.442155784389;6350.396712312323;6363.681815909279;6367.140436041261;6378.712957916812;5509.917351239815;6258.624482531062;6270;6295.464885484602;6334.081558174131;5621.55027597783;6166.969165154145;6203.976343903206;6225.408586184305;6297.433231009231;4895.779689914034;6233.065040244;6239.220097487814;6240.500759939103;6271.310155882758;6174.104754810437;6212.720427580679;6221.9377806223165;6237.1891654084675;6264.624122552661;5899.380565040609;5981.1028345746745;6038.547108966933;6088.056351265561;6100.267967843887;6127.234095738033;6142.447179753844;6145.907811382922;6150.723217455315;6152.938470615237;5886.941130588811;6039.245094363205;6113.23584551931;6119.076065312483;6133.578370171964 09:09:11 INFO - PROCESS | 2626 | |1;ext.html;488.8435700575815;513.5532087084238;522.0446582753561;530.2496966791988;537.4732761893345;32625.83687081564;33033.66966330336;33176.33647327055;41418.96452588687;43177.56822431775;44078.33882491757;44540.55459445404;44573.21127704141;44687.77656111715;44924.32613510792;10026.348287361316;10130.189584833233;10217.795644087113;10228.53971571281;10234.9488252559;9316.487593182372;9517.333786634937;9898.158656514204;10029.398236105857;12192.390380480985;12320.876791232107;12552.937235313857;12571.49714011443;12620.179688320275;12635.684107897285;12546.749065018694;12597.74804503914;12631.36843157843;12632.68418289541;12636.49454021838;12373.752524949541;12437.75124497505;12450.688732781662;12462.189957652814;12462.376881155906;41945;42298;42333;42365.57634423647;42392.78803605993;3471.5313432686517;3675;3731.6641502264924;3964.345882929313;4146.295129827937;30880.073597792103;31048.53427198594;32551.674483255338;33561.83219083914;33790.49314260288;3314.171457135716;3369.073504786179;3461.6192218855904;3503.562054743157;3503.667151620592;507727;512014;512776.4889404419;513558;516128;29388.412231755672;34555.30889382198;61085;61668.374871884786;61686;36099.81950090285;36368.63631363706;36430.81784591113;36513.81743091321;36549.26901461956;15668.843311566967;15848.52454426369;15888.76166857498;15894.046357218604;15904;13309;13328.400221990034;13341.599752007456;13424.328783560783;13428.597142085753;7542.434317426105;7699.230076992368;7956;8087.312578430781;8113.918860811316;3329.20099176196;3385.2213990782257;3394.4399174136483;3402.0984439123654;3412.931741365159;879.76246413468;1044.8587414246504;1046.895310468947;1058.4919238765435;1089.8801131875487;30997.845010775254;31151.22121946924;31323.590438430325;31615.944963577294;31793.046208613778;1065.1851333729703;1082.8971247731454;1125.831125331207;1162.657016180212;1222.0468034932767;13945.790813137812;16321.51035468914;16324;16394.672106557802;16576.6684666306;704462;704923;705022;705863;706259;61170;61836.690816545626;61868.381316187166;61878.38121618726;62004;1291.2833377475404;1317.236003118189;1414.5756273118022;1419.4109444580383;1440.7478691229203;28218.85890570534;28402;32390.514142288357;32442.351152976335;33010.17474563155;51107;51677.708057297365;51705.482945170064;51712;51973.74013130061;543856;547376;547478;547896;801896;23476.53046939086;27230.183094507196;27817.721822781514;28421.721022554448;28475.291482511115;48664;49094.77263068452;49310.75344623254;49556;49686.75156624194;31666;39240.26628606816;40181.598184018956;40986.79506602448;41984.79007604942;36351.63648363482;40349;40385.798071010635;41401.55094571676;41647.95880103022;39225.607743923334;39907.2018559633;40378.79810600928;40520.594794052864;40617.1876562473;33381.49927751037;35345.64654353423;35446;35725.28549429049;35897.28205435824;26200.34499137537;26482.735172648798;26777.86611066932;26998.865005674845;27165.456690866467 09:09:11 INFO - PROCESS | 2626 | |2;jquery.html;375.80645967326825;381.748046289449;391.2898089966711;403.796082978096;412.51323438342763;14978.85021149791;20400;21383.786162138374;21466.356009319745;22175.891205439722;16358;19800.504987375323;20503.897480512613;21093.15627374903;21415.678764818542;5395.514403703666;6029.276486821587;6340.492760579165;6353.714082866282;6379.489640828746;6020.45815876571;6216.347283535209;6221.502279817604;6283.811485655415;6293.433590976834;6225.2529696436495;6234.064890266451;6237.3450787667325;6243.750249989995;6244.687765611724;6064.151018857364;6113.480354169901;6128.908066379008;6200.255969283692;6266.717997690069;5194.740262986873;5448.264484294609;5458.754356053947;5467.726613669301;5473.781048758085;26157;26336.34159146037;26734.46531069368;26883.193504194904;27077.323066923287;2236.329101269629;2280.2589158523547;2293.736220334666;2409.5662780699467;3168.651448340681;15065.849341506664;15233.542993710207;15237.923810380988;16573.337066517324;16573.50279491617;1850.5928695686928;1904.5525400695433;1918.5875036867;1932.072605149536;1934.974463534329;84676;119512.80487195191;119555.4022229892;119678.80321196764;120262.59474810542;9112.49881256524;10522.000409961041;10706.839397409045;10766.039339181787;11222.102231821435;13947.16317020982;13949.95375346853;13971.58085257444;13981.79027314591;13983.860161398256;6499.54503184782;8256.298214651822;8278.296344810758;8371.623276952552;8531.573421328909;7745.535267883945;8376.706815261437;8842.602082906285;8894;8990.910090899139;6006.2191915051635;6273.400282927824;6545.0182472629485;6671.86656266872;6697.6986035628515;1844.9354272600394;1868.859835512342;1888.1314595286049;1892.7917929027797;1917.980820191808;738.5236522442995;865.5931712095305;939.3377668743519;952.2334520710756;1021.279997601689;22179.223727169472;22290.99690513931;22728.318150455514;22933.426664333525;23196.53606927852;850.4004676702909;1005.492226425665;1014.4471263161595;1016.2479764973866;1034.9896501035043;8806.823863522694;11865.110116741278;11965.46155423008;12060.691356305508;12196.268223906416;624003;631699;635213;648689;652802;72694.63652681703;123529.38235308765;123924;125578;128804.71195288115;1010.8786945566579;1016.1464369929295;1051.8632577764995;1053.4522048534718;1054.6097943760858;19481.415557533295;19764.901175494604;20046.39860804178;20046.49883752918;20123.698144527552;53626;54961.25193740377;55203.44796552144;55401.722991384784;55912;75144;77479.61260193663;77856.61071694606;79301.67332430242;80593.59703201447;6151.84620384494;7194.136703595393;7264.564126152448;7483.438742094256;7645;9845.556949937127;12860;12917.160384574972;13037.934810326267;13358.933205333911;11212.654481462278;11744.94127529357;11784.70538236551;11825.940870295593;11827.349495777815;11000.174986876176;11073.778524429628;11121.16591255643;11172.938570835757;11507.769844603228;9108.360495110943;11092.778144437227;11683.766324673628;11950.701232469259;11972.64082077539;6428.55000149985;7370.152432470334;7440.619001919334;7592.278733520307;7803.0636323639255;9001.864972025556;9691.224702023681;10268.332558383681;11681.766364672829;11773.88226117728 09:09:11 INFO - PROCESS | 2626 | |3;mootools.html;1399.839018512871;1533.9923300383496;1749.9212535435904;1926.229508196722;1940.3790786948182;6131.969340153299;9288.767780805483;9291.303152263581;9293.070692930703;9301.162895339417;8066.878996815038;8268.793280167998;8661.133886611351;8862.335324850646;9047.954760226206;2041.4488088216174;2435.7077150741893;2455.0793452455327;2473.307473907309;2474.1216868011866;2419.8064154867657;2442.3894026493376;2463.963040554384;2464.852108873464;2469.6789417375717;2435.1233555919853;2450.8774561271953;2457.6559281700575;2460.188137914493;2460.9138680146198;2417.8549287042833;2424.9393765155837;2437.2688193541953;2438.500107477963;2443.3280847766828;2414.2515820095828;2433.1605596069326;2439.1584903208363;2444.6821913151352;2445.2664200739705;8992.730218093468;8998.730038098867;9102.954485227598;9118;9123.224525915306;5372;5543.1408131739245;5547.25112109864;5550.805721799758;5554.888902221933;3567.928641427157;3631.7457777955556;3679.7240206984316;3694.7598406103516;3715.1826598148364;985.2807450561058;1087.6628245243999;1091.1761619976946;1093.8569195191044;1104.447776111944;11956.222845515014;11989.040876729841;12073.758524829454;12097.758044839142;12098.637040888787;4531.776420366483;4570.588647021784;4758.738269395148;4759.357486739315;4761.428628564525;9327.113924177193;9338.813223735488;9339.252859771203;9349.39228950116;9355.578998945064;4477.485089214717;5418.458154184629;5421.159720243369;5425.430329815392;5449.04641687703;4386.583274588909;4580.038191979722;4714.764261786897;5037.395512538519;5056.494350564914;3638.308721342936;3699.9075023124637;3844.826982785781;3851.2297540492013;4023.6177563131455;1124.8537690100234;1168.8772678868766;1194.170051813981;1205.73473835756;1207.987920120805;736.8010637127945;905.1853332001251;933.8373724712776;934.1825902335456;945.4847108325979;5813.09896965971;5891.941080589225;5938.138969849348;6108.5723999319625;6143.600665956698;449.49431889124736;451.33653529312517;460.99308510372373;463.4994206257301;472.5180316077582;3362.7814192077435;3804.2581696569455;4018;4052.63526282636;4064.146529228836;10694.625688101034;11189.832152517718;11215.046721028804;11228.989390954854;11236;10703.411312377739;10974.561017559208;11162.497687603915;11192.272502287326;11194.328340299446;8434.915650843413;8493.745187644381;8510.276626486819;8513.361497887683;8517.23344898962;5876.500497457764;5920.496757775637;6014.007688731311;6027.457528822427;6078.179445774764;9870.407775533491;10147.18822494184;10205.489725513844;10275.253206954985;10430.687079387328;10389.584416623251;10544.947275263574;10552.944705529386;10574.365538067741;10579.836218015858;7560.092788865371;7609.505382150142;7701.730439434817;7726.575038372944;7735.6905723770415;8778.780530486789;8819.162179592928;8821.823563528822;8826.91173088261;8830.337724670804;6760.18877734675;7623.275788800055;7736;7792.2986931176465;7865.370770338473;6418.390252925965;7409.814754630962;7609.619519024137;7643.617819109134;7779.299863012356;7170.498065135599;7179.533330333512;7243.601601911735;7254.927450725636;7262.164851042197;4340;5155.200943853709;5162.97418512905;5169.896602067863;5235.267062611314;5027.664538371339;5043.697378157322;5046.747662616928;5298.125809241432;5360.0083984463 09:09:11 INFO - PROCESS | 2626 | |4;prototype.html;310.1146227520429;311.89239712299263;319.2625036166456;323.2855389589008;324.3351130183124;4809.1343558159515;5276.7889284428575;5429.918551221725;5646.7176641167935;5662.745176467059;4962.826301079463;4971.544776380417;5270.736463176835;5375.75809088591;5557.194206840016;4217.481706585627;4217.620414162725;4249.4475718156755;4256.744595324282;4282.74303541787;4200.957990420103;4223.788810559475;4234.936475952848;4265.613675555442;4301.225779359714;4073.307537718595;4200.815575900529;4208.978955105235;4217.831286748542;4236.682248831335;3808.9619103808886;3882.49527561418;4226.767527785971;4231.788410579458;4250.681198910079;3312.0726196664973;3605.963940360589;3653.671169594723;3683.373826449483;3702.2965636529243;5137.6403651744395;5255.5795536357;5466.863328416822;5475.233467314579;5580.358258800249;4867.785157753214;4874.341963834908;4878.609711223094;4933.975330123362;4949.257611358289;5157.974210128926;5788.305403351583;5811.27359080115;5820.30156381237;5875.500582450497;3714.888553343404;3817.4464702618243;3878.2437424702193;4008.977710683786;4065.6544193743566;5699.943000569982;6184.5052395808225;6196.81409557714;6209.441150296495;6209.844753881144;3486.651334866544;3579.979705783839;3935.5670876203594;4075.5924407559005;4085.4484644573195;3386.5258863759095;3390.423627983249;4159.355299928516;4166.167006435592;4169.228692691861;3765.4938024790304;4355.1725172217175;4739.7630118493935;4753.33453316536;4780.665353425296;4634.629229661619;4853.9029219415415;5834.708264586839;5897.380775018647;5942.732577034044;1324.5231566803138;1378.9241591712553;1412.3644360037817;1413.8939579531577;1417.9574612761633;717.720089165226;808.8988876390451;836.6070492629825;850.9446885952393;851.948883067018;4140.288111287112;4166.58334166587;4324.194708656362;4589.760764593608;4644.9767751161025;4687.460941991646;5013.39839219296;5020.322256495399;5041.823536176216;5050.974745126251;3940.349842275992;4235.767032813224;4379;4498.8425405110665;4708.4462127497845;2090.811826935583;2236.3897993444693;2390.2112302939986;2679.9682122383024;2684.5302072137297;4553.134904368159;4809.422869255642;5100.311457953203;5179.741012949337;5195.428502864682;5115.769790359368;5164.837911469889;5182.300389447451;5658.490735833712;6316.810495685137;6275.529335299871;6357.7139028742895;6366.363363663597;6390.0734393512685;6403.519736019817;4831.444383895757;5341;5804.1293805929445;6118.541109416722;6170.043643235305;4924.433690125681;4970.453250142409;6030.698465076816;6046.5767396281835;6054.545909056927;5145.845624631267;5252.474752524717;6267.874642507216;6354.3963323484195;6424.325445828121;3839.9808000959815;4064.4309796627904;4101.589841015874;4112.362583799516;4128.339465685476;5531.81920395766;5869.970650146722;6005.117543579194;6103.429493746208;6110.877782444238;5552.500274975271;5935.614185077956;5946.494547963472;6036.185115009417;6064.484518815773;4896.212882297865;5307.150855863043;5326.920096198638;5331.707365832729;5975.40245975399;4809.759512024455;5120.820771272987;5523.950449414599;5724.198612194213;5816.76732930678;4760.000399916056;5112;5394;5847.590668653153;5870.21164946664;4857.174280372275;5691.317041954826;5769.30768307789;5769.91345129815;5813.186153938367 09:09:11 INFO - PROCESS | 2626 | |5;yui.html;746.4252525555322;799.9400793948021;830.4477522447572;845.2392846438205;868.6395146014404;16474.83525164748;17347;17556.999999999985;18294;18402.539936501595;17456.650866982654;17638.91180544099;17658.028808415533;17669.64660706785;17678.292868285287;881.6958149438434;884.933629977751;896.5562046786818;909.3498148823589;914.7713071732067;902.9954850225739;905.42053086025;905.4431524612381;906.727981605519;906.755176102452;957.6265256549916;958.1185309515228;958.4967891856761;959.0074273127315;959.9952000239989;951.6859436385976;951.7525443384701;952.8284908716428;953.6614501851847;953.9856902146473;700.3906601256888;703.0789665538161;703.3494018033299;703.5110598134298;703.736098962889;16302.021878687317;16345.83654163455;16357.754633680504;16369.017858928384;16380.508584742358;14496.56510304682;14535.345909434101;14847.480338188112;14858;14949.177795221258;11656.766864662744;11857.881421185764;11886.524539018428;11918.165728399015;11921.463534140985;3781.5462144542557;3851.094992676719;3876.2053778975524;4062.1672557125717;4068.2270368629866;140257.8961315581;145159;145661;145828;145894;10071.395716257048;10982.575768854695;11248.887511124947;11429.657110286706;11957.70105747346;21308.467288317606;21433.035513401934;23338;23574.410639734146;24038.278851634128;8305.792355191168;8326.70856520019;8330.333573314121;8363.16368363171;8405.495670259805;4543.409356783597;4586.220342541776;4689.343491911135;4795.95204047962;4846.684965477232;3716;3741.3639681254253;3805.296020236265;3825.254075455315;3832.7508711933633;669.7622344067884;675.1830285354678;687.1067612104245;693.2512886083018;694.035290945586;613.1997742945409;626.4800215820858;629.8362425769333;663.7245543099559;671.8980871370956;7389.261073892568;9762.019195037326;9782.266330025277;9816.705498835046;9827.31208815376;665.6172700697118;666.1240468783534;680.251723104581;688.8450098727747;705.4250785609712;4497.482789479186;4720.716756994591;4721.362616046858;4750.881227969328;4754.976225118921;147121.26439367735;177133;177340;177431;185723;108751.45624271828;151813;154071;156844;157481.2125939363;97822.51088744654;127706;127918;136084;137173.6282637161;7462.738804141829;9031.864522032043;9089.772755680897;9119.316051296046;9364.986527896535;58133.70933145307;58594;61556;65387;67869.3213067863;63970;66212.66893665501;89277;89437;98400.01599983909;13534;13723.588292351245;13778.931105344409;13785.51750688721;14069.648258793612;14797;15350.539483815503;15402.610256077412;15909.284082216096;16850.66298674044;14202.431902723776;14551.41794328215;14755.483558075415;15096;15639.687206255583;14731.558053258419;14842.851571484147;15070.397184112951;15252.694946101237;15407.84592154109;12071.57749478764;13582.524611638546;14404.063735857555;14498;14652.560423187322;11755.647330580096;12215;12280.447379868107;12305.56930507428;12396;11663.650090497298;11905.890571592594;11915.761684766083;12148.635540933787;12425 09:09:11 INFO - PROCESS | 2626 | __end_tp_report 09:09:11 INFO - PROCESS | 2626 | __start_cc_report 09:09:11 INFO - PROCESS | 2626 | _x_x_mozilla_cycle_collect,1167 09:09:11 INFO - PROCESS | 2626 | __end_cc_report 09:09:11 INFO - PROCESS | 2626 | __startTimestamp1480612151493__endTimestamp 09:09:11 INFO - PROCESS | 2626 | 09:09:11 INFO - PROCESS | 2626 | ------- Summary: start ------- 09:09:11 INFO - PROCESS | 2626 | Number of tests: 6 09:09:11 INFO - PROCESS | 2626 | 09:09:11 INFO - PROCESS | 2626 | [#0] dojo.html Cycles:165 Average:5797.64 Median:6038.55 stddev:622.31 (10.3%) stddev-sans-first:595.22 09:09:11 INFO - PROCESS | 2626 | Values: 3404.5 3447.3 3462.6 3488.7 3510.8 5763.6 5830.7 5885.6 5893.9 5912.1 5773.8 5791.4 5879.1 5889.3 5912.7 5265.4 5289.8 5360.7 5366.2 5372.5 5221.5 5226.1 5237.1 5377.0 5396.0 5204.1 5275.0 5300.7 5303.1 5308.2 5275.2 5303.9 5344.4 5366.9 5384.2 5122.0 5210.7 5309.3 5311.0 5334.2 5692.6 5704.8 5729.9 5741.1 5773.2 6215.3 6281.3 6304.8 6322.5 6337.5 6276.5 6278.4 6283.5 6293.3 6295.7 5759.2 5776.1 5786.3 5801.4 5820.9 6298.0 6299.6 6328.4 6329.0 6337.3 6231.6 6244.2 6246.1 6255.3 6258.1 6202.7 6216.6 6232.0 6268.8 6282.8 6289.9 6290.4 6302.1 6309.7 6309.7 6201.5 6262.7 6299.9 6310.5 6324.3 4891.7 4948.2 4958.2 4987.7 5000.2 4568.1 4569.2 4595.0 4621.7 4625.9 5790.0 5792.1 5797.3 5804.4 5836.8 6182.8 6217.1 6223.7 6251.6 6275.0 5710.7 5711.9 5716.3 5747.9 5776.5 5410.1 5435.9 5436.9 5456.7 5464.2 6200.7 6242.7 6243.4 6267.5 6339.2 6268.4 6293.7 6300.7 6301.0 6301.3 5578.4 6350.4 6363.7 6367.1 6378.7 5509.9 6258.6 6270.0 6295.5 6334.1 5621.6 6167.0 6204.0 6225.4 6297.4 4895.8 6233.1 6239.2 6240.5 6271.3 6174.1 6212.7 6221.9 6237.2 6264.6 5899.4 5981.1 6038.5 6088.1 6100.3 6127.2 6142.4 6145.9 6150.7 6152.9 5886.9 6039.2 6113.2 6119.1 6133.6 09:09:11 INFO - PROCESS | 2626 | 09:09:11 INFO - PROCESS | 2626 | [#1] ext.html Cycles:180 Average:72662.79 Median:3466.58 stddev:164400.92 (4742.5%) stddev-sans-first:164772.80 09:09:11 INFO - PROCESS | 2626 | Values: 488.8 513.6 522.0 530.2 537.5 32625.8 33033.7 33176.3 41419.0 43177.6 44078.3 44540.6 44573.2 44687.8 44924.3 10026.3 10130.2 10217.8 10228.5 10234.9 9316.5 9517.3 9898.2 10029.4 12192.4 12320.9 12552.9 12571.5 12620.2 12635.7 12546.7 12597.7 12631.4 12632.7 12636.5 12373.8 12437.8 12450.7 12462.2 12462.4 41945.0 42298.0 42333.0 42365.6 42392.8 3471.5 3675.0 3731.7 3964.3 4146.3 30880.1 31048.5 32551.7 33561.8 33790.5 3314.2 3369.1 3461.6 3503.6 3503.7 507727.0 512014.0 512776.5 513558.0 516128.0 29388.4 34555.3 61085.0 61668.4 61686.0 36099.8 36368.6 36430.8 36513.8 36549.3 15668.8 15848.5 15888.8 15894.0 15904.0 13309.0 13328.4 13341.6 13424.3 13428.6 7542.4 7699.2 7956.0 8087.3 8113.9 3329.2 3385.2 3394.4 3402.1 3412.9 879.8 1044.9 1046.9 1058.5 1089.9 30997.8 31151.2 31323.6 31615.9 31793.0 1065.2 1082.9 1125.8 1162.7 1222.0 13945.8 16321.5 16324.0 16394.7 16576.7 704462.0 704923.0 705022.0 705863.0 706259.0 61170.0 61836.7 61868.4 61878.4 62004.0 1291.3 1317.2 1414.6 1419.4 1440.7 28218.9 28402.0 32390.5 32442.4 33010.2 51107.0 51677.7 51705.5 51712.0 51973.7 543856.0 547376.0 547478.0 547896.0 801896.0 23476.5 27230.2 27817.7 28421.7 28475.3 48664.0 49094.8 49310.8 49556.0 49686.8 31666.0 39240.3 40181.6 40986.8 41984.8 36351.6 40349.0 40385.8 41401.6 41648.0 39225.6 39907.2 40378.8 40520.6 40617.2 33381.5 35345.6 35446.0 35725.3 35897.3 26200.3 26482.7 26777.9 26998.9 27165.5 09:09:11 INFO - PROCESS | 2626 | 09:09:11 INFO - PROCESS | 2626 | [#2] jquery.html Cycles:180 Average:35943.00 Median:14283.28 stddev:105861.50 (741.2%) stddev-sans-first:106124.78 09:09:11 INFO - PROCESS | 2626 | Values: 375.8 381.7 391.3 403.8 412.5 14978.9 20400.0 21383.8 21466.4 22175.9 16358.0 19800.5 20503.9 21093.2 21415.7 5395.5 6029.3 6340.5 6353.7 6379.5 6020.5 6216.3 6221.5 6283.8 6293.4 6225.3 6234.1 6237.3 6243.8 6244.7 6064.2 6113.5 6128.9 6200.3 6266.7 5194.7 5448.3 5458.8 5467.7 5473.8 26157.0 26336.3 26734.5 26883.2 27077.3 2236.3 2280.3 2293.7 2409.6 3168.7 15065.8 15233.5 15237.9 16573.3 16573.5 1850.6 1904.6 1918.6 1932.1 1935.0 84676.0 119512.8 119555.4 119678.8 120262.6 9112.5 10522.0 10706.8 10766.0 11222.1 13947.2 13950.0 13971.6 13981.8 13983.9 6499.5 8256.3 8278.3 8371.6 8531.6 7745.5 8376.7 8842.6 8894.0 8990.9 6006.2 6273.4 6545.0 6671.9 6697.7 1844.9 1868.9 1888.1 1892.8 1918.0 738.5 865.6 939.3 952.2 1021.3 22179.2 22291.0 22728.3 22933.4 23196.5 850.4 1005.5 1014.4 1016.2 1035.0 8806.8 11865.1 11965.5 12060.7 12196.3 624003.0 631699.0 635213.0 648689.0 652802.0 72694.6 123529.4 123924.0 125578.0 128804.7 1010.9 1016.1 1051.9 1053.5 1054.6 19481.4 19764.9 20046.4 20046.5 20123.7 53626.0 54961.3 55203.4 55401.7 55912.0 75144.0 77479.6 77856.6 79301.7 80593.6 6151.8 7194.1 7264.6 7483.4 7645.0 9845.6 12860.0 12917.2 13037.9 13358.9 11212.7 11744.9 11784.7 11825.9 11827.3 11000.2 11073.8 11121.2 11172.9 11507.8 9108.4 11092.8 11683.8 11950.7 11972.6 6428.6 7370.2 7440.6 7592.3 7803.1 9001.9 9691.2 10268.3 11681.8 11773.9 09:09:11 INFO - PROCESS | 2626 | 09:09:11 INFO - PROCESS | 2626 | [#3] mootools.html Cycles:180 Average:5799.97 Median:4759.05 stddev:3307.71 (69.5%) stddev-sans-first:3300.46 09:09:11 INFO - PROCESS | 2626 | Values: 1399.8 1534.0 1749.9 1926.2 1940.4 6132.0 9288.8 9291.3 9293.1 9301.2 8066.9 8268.8 8661.1 8862.3 9048.0 2041.4 2435.7 2455.1 2473.3 2474.1 2419.8 2442.4 2464.0 2464.9 2469.7 2435.1 2450.9 2457.7 2460.2 2460.9 2417.9 2424.9 2437.3 2438.5 2443.3 2414.3 2433.2 2439.2 2444.7 2445.3 8992.7 8998.7 9103.0 9118.0 9123.2 5372.0 5543.1 5547.3 5550.8 5554.9 3567.9 3631.7 3679.7 3694.8 3715.2 985.3 1087.7 1091.2 1093.9 1104.4 11956.2 11989.0 12073.8 12097.8 12098.6 4531.8 4570.6 4758.7 4759.4 4761.4 9327.1 9338.8 9339.3 9349.4 9355.6 4477.5 5418.5 5421.2 5425.4 5449.0 4386.6 4580.0 4714.8 5037.4 5056.5 3638.3 3699.9 3844.8 3851.2 4023.6 1124.9 1168.9 1194.2 1205.7 1208.0 736.8 905.2 933.8 934.2 945.5 5813.1 5891.9 5938.1 6108.6 6143.6 449.5 451.3 461.0 463.5 472.5 3362.8 3804.3 4018.0 4052.6 4064.1 10694.6 11189.8 11215.0 11229.0 11236.0 10703.4 10974.6 11162.5 11192.3 11194.3 8434.9 8493.7 8510.3 8513.4 8517.2 5876.5 5920.5 6014.0 6027.5 6078.2 9870.4 10147.2 10205.5 10275.3 10430.7 10389.6 10544.9 10552.9 10574.4 10579.8 7560.1 7609.5 7701.7 7726.6 7735.7 8778.8 8819.2 8821.8 8826.9 8830.3 6760.2 7623.3 7736.0 7792.3 7865.4 6418.4 7409.8 7609.6 7643.6 7779.3 7170.5 7179.5 7243.6 7254.9 7262.2 4340.0 5155.2 5163.0 5169.9 5235.3 5027.7 5043.7 5046.7 5298.1 5360.0 09:09:11 INFO - PROCESS | 2626 | 09:09:11 INFO - PROCESS | 2626 | [#4] prototype.html Cycles:180 Average:4575.64 Median:4941.62 stddev:1443.46 (29.2%) stddev-sans-first:1411.55 09:09:11 INFO - PROCESS | 2626 | Values: 310.1 311.9 319.3 323.3 324.3 4809.1 5276.8 5429.9 5646.7 5662.7 4962.8 4971.5 5270.7 5375.8 5557.2 4217.5 4217.6 4249.4 4256.7 4282.7 4201.0 4223.8 4234.9 4265.6 4301.2 4073.3 4200.8 4209.0 4217.8 4236.7 3809.0 3882.5 4226.8 4231.8 4250.7 3312.1 3606.0 3653.7 3683.4 3702.3 5137.6 5255.6 5466.9 5475.2 5580.4 4867.8 4874.3 4878.6 4934.0 4949.3 5158.0 5788.3 5811.3 5820.3 5875.5 3714.9 3817.4 3878.2 4009.0 4065.7 5699.9 6184.5 6196.8 6209.4 6209.8 3486.7 3580.0 3935.6 4075.6 4085.4 3386.5 3390.4 4159.4 4166.2 4169.2 3765.5 4355.2 4739.8 4753.3 4780.7 4634.6 4853.9 5834.7 5897.4 5942.7 1324.5 1378.9 1412.4 1413.9 1418.0 717.7 808.9 836.6 850.9 851.9 4140.3 4166.6 4324.2 4589.8 4645.0 4687.5 5013.4 5020.3 5041.8 5051.0 3940.3 4235.8 4379.0 4498.8 4708.4 2090.8 2236.4 2390.2 2680.0 2684.5 4553.1 4809.4 5100.3 5179.7 5195.4 5115.8 5164.8 5182.3 5658.5 6316.8 6275.5 6357.7 6366.4 6390.1 6403.5 4831.4 5341.0 5804.1 6118.5 6170.0 4924.4 4970.5 6030.7 6046.6 6054.5 5145.8 5252.5 6267.9 6354.4 6424.3 3840.0 4064.4 4101.6 4112.4 4128.3 5531.8 5870.0 6005.1 6103.4 6110.9 5552.5 5935.6 5946.5 6036.2 6064.5 4896.2 5307.2 5326.9 5331.7 5975.4 4809.8 5120.8 5524.0 5724.2 5816.8 4760.0 5112.0 5394.0 5847.6 5870.2 4857.2 5691.3 5769.3 5769.9 5813.2 09:09:11 INFO - PROCESS | 2626 | 09:09:11 INFO - PROCESS | 2626 | [#5] yui.html Cycles:180 Average:27573.98 Median:3761.46 stddev:45902.75 (1220.3%) stddev-sans-first:45987.32 09:09:11 INFO - PROCESS | 2626 | Values: 746.4 799.9 830.4 845.2 868.6 16474.8 17347.0 17557.0 18294.0 18402.5 17456.7 17638.9 17658.0 17669.6 17678.3 881.7 884.9 896.6 909.3 914.8 903.0 905.4 905.4 906.7 906.8 957.6 958.1 958.5 959.0 960.0 951.7 951.8 952.8 953.7 954.0 700.4 703.1 703.3 703.5 703.7 16302.0 16345.8 16357.8 16369.0 16380.5 14496.6 14535.3 14847.5 14858.0 14949.2 11656.8 11857.9 11886.5 11918.2 11921.5 3781.5 3851.1 3876.2 4062.2 4068.2 140257.9 145159.0 145661.0 145828.0 145894.0 10071.4 10982.6 11248.9 11429.7 11957.7 21308.5 21433.0 23338.0 23574.4 24038.3 8305.8 8326.7 8330.3 8363.2 8405.5 4543.4 4586.2 4689.3 4796.0 4846.7 3716.0 3741.4 3805.3 3825.3 3832.8 669.8 675.2 687.1 693.3 694.0 613.2 626.5 629.8 663.7 671.9 7389.3 9762.0 9782.3 9816.7 9827.3 665.6 666.1 680.3 688.8 705.4 4497.5 4720.7 4721.4 4750.9 4755.0 147121.3 177133.0 177340.0 177431.0 185723.0 108751.5 151813.0 154071.0 156844.0 157481.2 97822.5 127706.0 127918.0 136084.0 137173.6 7462.7 9031.9 9089.8 9119.3 9365.0 58133.7 58594.0 61556.0 65387.0 67869.3 63970.0 66212.7 89277.0 89437.0 98400.0 13534.0 13723.6 13778.9 13785.5 14069.6 14797.0 15350.5 15402.6 15909.3 16850.7 14202.4 14551.4 14755.5 15096.0 15639.7 14731.6 14842.9 15070.4 15252.7 15407.8 12071.6 13582.5 14404.1 14498.0 14652.6 11755.6 12215.0 12280.4 12305.6 12396.0 11663.7 11905.9 11915.8 12148.6 12425.0 09:09:11 INFO - PROCESS | 2626 | -------- Summary: end -------- 09:09:11 INFO - PROCESS | 2626 | 09:09:12 INFO - TEST-INFO | 2626: exit 0 09:09:12 INFO - TEST-OK | dromaeo_css | took 1114996ms 09:09:12 INFO - TEST-START | kraken 09:09:12 INFO - operating with platform_type : mac_ 09:09:12 INFO - Initialising browser for kraken test... 09:09:12 INFO - TEST-INFO | started process 2628 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/tmpZ_5aLa/profile http://localhost:52935/getInfo.html) 09:09:14 INFO - PROCESS | 2628 | __metrics Screen width/height:1600/1200 09:09:14 INFO - PROCESS | 2628 | colorDepth:24 09:09:14 INFO - PROCESS | 2628 | Browser inner width/height: 1024/689 09:09:14 INFO - PROCESS | 2628 | __metrics 09:09:14 INFO - PROCESS | 2628 | 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:09:14 INFO - PROCESS | 2628 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:09:14 INFO - TEST-INFO | 2628: exit 0 09:09:14 INFO - Browser initialized. 09:09:14 INFO - Running cycle 1/1 for kraken test... 09:09:14 INFO - TEST-INFO | started process 2630 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/tmpZ_5aLa/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:09:26 INFO - PROCESS | 2630 | RSS: Main: 168894464 09:09:26 INFO - PROCESS | 2630 | 09:09:29 INFO - PROCESS | 2630 | Cycle 1(1): loaded http://localhost:52935/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52935/tests/kraken/driver.html?testName=audio-beat-detection) 09:09:30 INFO - PROCESS | 2630 | RSS: Main: 218939392 09:09:30 INFO - PROCESS | 2630 | 09:09:33 INFO - PROCESS | 2630 | Cycle 1(1): loaded http://localhost:52935/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52935/tests/kraken/driver.html?testName=audio-dft) 09:09:33 INFO - PROCESS | 2630 | RSS: Main: 232726528 09:09:33 INFO - PROCESS | 2630 | 09:09:37 INFO - PROCESS | 2630 | Cycle 1(1): loaded http://localhost:52935/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52935/tests/kraken/driver.html?testName=audio-fft) 09:09:37 INFO - PROCESS | 2630 | RSS: Main: 329871360 09:09:37 INFO - PROCESS | 2630 | 09:09:39 INFO - PROCESS | 2630 | Cycle 1(1): loaded http://localhost:52935/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52935/tests/kraken/driver.html?testName=audio-oscillator) 09:09:40 INFO - PROCESS | 2630 | RSS: Main: 229879808 09:09:40 INFO - PROCESS | 2630 | 09:09:42 INFO - PROCESS | 2630 | Cycle 1(1): loaded http://localhost:52935/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52935/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:09:42 INFO - PROCESS | 2630 | RSS: Main: 230178816 09:09:42 INFO - PROCESS | 2630 | 09:09:45 INFO - PROCESS | 2630 | Cycle 1(1): loaded http://localhost:52935/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52935/tests/kraken/driver.html?testName=imaging-darkroom) 09:09:46 INFO - PROCESS | 2630 | RSS: Main: 267534336 09:09:46 INFO - PROCESS | 2630 | 09:09:49 INFO - PROCESS | 2630 | Cycle 1(1): loaded http://localhost:52935/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52935/tests/kraken/driver.html?testName=imaging-desaturate) 09:09:49 INFO - PROCESS | 2630 | RSS: Main: 269049856 09:09:49 INFO - PROCESS | 2630 | 09:09:52 INFO - PROCESS | 2630 | Cycle 1(1): loaded http://localhost:52935/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52935/tests/kraken/driver.html?testName=json-parse-financial) 09:09:53 INFO - PROCESS | 2630 | RSS: Main: 270168064 09:09:53 INFO - PROCESS | 2630 | 09:09:54 INFO - PROCESS | 2630 | Cycle 1(1): loaded http://localhost:52935/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52935/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:09:55 INFO - PROCESS | 2630 | RSS: Main: 240406528 09:09:55 INFO - PROCESS | 2630 | 09:09:57 INFO - PROCESS | 2630 | Cycle 1(1): loaded http://localhost:52935/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52935/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:09:57 INFO - PROCESS | 2630 | RSS: Main: 245305344 09:09:57 INFO - PROCESS | 2630 | 09:09:59 INFO - PROCESS | 2630 | Cycle 1(1): loaded http://localhost:52935/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52935/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:10:00 INFO - PROCESS | 2630 | RSS: Main: 253112320 09:10:00 INFO - PROCESS | 2630 | 09:10:03 INFO - PROCESS | 2630 | Cycle 1(1): loaded http://localhost:52935/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52935/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:10:04 INFO - PROCESS | 2630 | RSS: Main: 277463040 09:10:04 INFO - PROCESS | 2630 | 09:10:06 INFO - PROCESS | 2630 | Cycle 1(1): loaded http://localhost:52935/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52935/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:10:07 INFO - PROCESS | 2630 | RSS: Main: 266166272 09:10:07 INFO - PROCESS | 2630 | 09:10:09 INFO - PROCESS | 2630 | Cycle 1(1): loaded http://localhost:52935/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52935/tests/kraken/driver.html?testName=ai-astar) 09:10:09 INFO - PROCESS | 2630 | RSS: Main: 310378496 09:10:09 INFO - PROCESS | 2630 | 09:10:09 INFO - PROCESS | 2630 | __start_tp_report 09:10:09 INFO - PROCESS | 2630 | _x_x_mozilla_page_load 09:10:09 INFO - PROCESS | 2630 | _x_x_mozilla_page_load_details 09:10:09 INFO - PROCESS | 2630 | |i|pagename|runs| 09:10:09 INFO - PROCESS | 2630 | |0;ai-astar;116;114;122;168;154;112;113;113;113;113 09:10:09 INFO - PROCESS | 2630 | |1;audio-beat-detection;145;112;134;167;109;109;108;109;138;107 09:10:09 INFO - PROCESS | 2630 | |2;audio-dft;184;183;187;183;184;181;183;184;186;184 09:10:09 INFO - PROCESS | 2630 | |3;audio-fft;84;58;58;90;59;59;58;58;86;74 09:10:09 INFO - PROCESS | 2630 | |4;audio-oscillator;82;70;93;70;68;68;92;67;67;89 09:10:09 INFO - PROCESS | 2630 | |5;imaging-gaussian-blur;91;88;90;87;90;87;92;88;88;86 09:10:09 INFO - PROCESS | 2630 | |6;imaging-darkroom;96;95;95;95;94;95;95;95;95;95 09:10:09 INFO - PROCESS | 2630 | |7;imaging-desaturate;84;84;83;85;85;101;133;142;86;85 09:10:09 INFO - PROCESS | 2630 | |8;json-parse-financial;57;55;56;53;54;57;58;57;57;56 09:10:09 INFO - PROCESS | 2630 | |9;json-stringify-tinderbox;63;66;75;75;69;67;68;68;68;70 09:10:09 INFO - PROCESS | 2630 | |10;stanford-crypto-aes;83;84;84;83;81;84;86;87;83;100 09:10:09 INFO - PROCESS | 2630 | |11;stanford-crypto-ccm;150;152;149;134;132;132;136;137;139;152 09:10:09 INFO - PROCESS | 2630 | |12;stanford-crypto-pbkdf2;164;162;163;161;162;175;161;158;159;160 09:10:09 INFO - PROCESS | 2630 | |13;stanford-crypto-sha256-iterative;69;66;64;66;65;65;66;66;70;88 09:10:09 INFO - PROCESS | 2630 | __end_tp_report 09:10:09 INFO - PROCESS | 2630 | __start_cc_report 09:10:09 INFO - PROCESS | 2630 | _x_x_mozilla_cycle_collect,2031 09:10:09 INFO - PROCESS | 2630 | __end_cc_report 09:10:09 INFO - PROCESS | 2630 | __startTimestamp1480612209419__endTimestamp 09:10:09 INFO - PROCESS | 2630 | 09:10:09 INFO - PROCESS | 2630 | ------- Summary: start ------- 09:10:09 INFO - PROCESS | 2630 | Number of tests: 14 09:10:09 INFO - PROCESS | 2630 | 09:10:09 INFO - PROCESS | 2630 | [#0] ai-astar Cycles:10 Average:123.80 Median:115.00 stddev:20.09 (17.5%) stddev-sans-first:21.11 09:10:09 INFO - PROCESS | 2630 | Values: 116.0 114.0 122.0 168.0 154.0 112.0 113.0 113.0 113.0 113.0 09:10:09 INFO - PROCESS | 2630 | 09:10:09 INFO - PROCESS | 2630 | [#1] audio-beat-detection Cycles:10 Average:123.80 Median:123.00 stddev:20.95 (17.0%) stddev-sans-first:20.77 09:10:09 INFO - PROCESS | 2630 | Values: 145.0 112.0 134.0 167.0 109.0 109.0 108.0 109.0 138.0 107.0 09:10:09 INFO - PROCESS | 2630 | 09:10:09 INFO - PROCESS | 2630 | [#2] audio-dft Cycles:10 Average:183.90 Median:184.00 stddev:1.66 (0.9%) stddev-sans-first:1.76 09:10:09 INFO - PROCESS | 2630 | Values: 184.0 183.0 187.0 183.0 184.0 181.0 183.0 184.0 186.0 184.0 09:10:09 INFO - PROCESS | 2630 | 09:10:09 INFO - PROCESS | 2630 | [#3] audio-fft Cycles:10 Average:68.40 Median:66.50 stddev:13.58 (20.4%) stddev-sans-first:13.18 09:10:09 INFO - PROCESS | 2630 | Values: 84.0 58.0 58.0 90.0 59.0 59.0 58.0 58.0 86.0 74.0 09:10:09 INFO - PROCESS | 2630 | 09:10:09 INFO - PROCESS | 2630 | [#4] audio-oscillator Cycles:10 Average:76.60 Median:76.00 stddev:11.10 (14.6%) stddev-sans-first:11.60 09:10:09 INFO - PROCESS | 2630 | Values: 82.0 70.0 93.0 70.0 68.0 68.0 92.0 67.0 67.0 89.0 09:10:09 INFO - PROCESS | 2630 | 09:10:09 INFO - PROCESS | 2630 | [#5] imaging-gaussian-blur Cycles:10 Average:88.70 Median:89.00 stddev:1.95 (2.2%) stddev-sans-first:1.88 09:10:09 INFO - PROCESS | 2630 | Values: 91.0 88.0 90.0 87.0 90.0 87.0 92.0 88.0 88.0 86.0 09:10:09 INFO - PROCESS | 2630 | 09:10:09 INFO - PROCESS | 2630 | [#6] imaging-darkroom Cycles:10 Average:95.00 Median:95.00 stddev:0.47 (0.5%) stddev-sans-first:0.33 09:10:09 INFO - PROCESS | 2630 | Values: 96.0 95.0 95.0 95.0 94.0 95.0 95.0 95.0 95.0 95.0 09:10:09 INFO - PROCESS | 2630 | 09:10:09 INFO - PROCESS | 2630 | [#7] imaging-desaturate Cycles:10 Average:96.80 Median:84.50 stddev:22.17 (26.2%) stddev-sans-first:23.03 09:10:09 INFO - PROCESS | 2630 | Values: 84.0 84.0 83.0 85.0 85.0 101.0 133.0 142.0 86.0 85.0 09:10:09 INFO - PROCESS | 2630 | 09:10:09 INFO - PROCESS | 2630 | [#8] json-parse-financial Cycles:10 Average:56.00 Median:57.00 stddev:1.56 (2.7%) stddev-sans-first:1.62 09:10:09 INFO - PROCESS | 2630 | Values: 57.0 55.0 56.0 53.0 54.0 57.0 58.0 57.0 57.0 56.0 09:10:09 INFO - PROCESS | 2630 | 09:10:09 INFO - PROCESS | 2630 | [#9] json-stringify-tinderbox Cycles:10 Average:68.90 Median:68.50 stddev:3.73 (5.4%) stddev-sans-first:3.28 09:10:09 INFO - PROCESS | 2630 | Values: 63.0 66.0 75.0 75.0 69.0 67.0 68.0 68.0 68.0 70.0 09:10:09 INFO - PROCESS | 2630 | 09:10:09 INFO - PROCESS | 2630 | [#10] stanford-crypto-aes Cycles:10 Average:85.50 Median:84.00 stddev:5.36 (6.4%) stddev-sans-first:5.61 09:10:09 INFO - PROCESS | 2630 | Values: 83.0 84.0 84.0 83.0 81.0 84.0 86.0 87.0 83.0 100.0 09:10:09 INFO - PROCESS | 2630 | 09:10:09 INFO - PROCESS | 2630 | [#11] stanford-crypto-ccm Cycles:10 Average:141.30 Median:144.00 stddev:8.45 (5.9%) stddev-sans-first:8.35 09:10:09 INFO - PROCESS | 2630 | Values: 150.0 152.0 149.0 134.0 132.0 132.0 136.0 137.0 139.0 152.0 09:10:09 INFO - PROCESS | 2630 | 09:10:09 INFO - PROCESS | 2630 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.50 Median:162.00 stddev:4.74 (2.9%) stddev-sans-first:5.00 09:10:09 INFO - PROCESS | 2630 | Values: 164.0 162.0 163.0 161.0 162.0 175.0 161.0 158.0 159.0 160.0 09:10:09 INFO - PROCESS | 2630 | 09:10:09 INFO - PROCESS | 2630 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.50 Median:66.00 stddev:7.09 (10.7%) stddev-sans-first:7.52 09:10:09 INFO - PROCESS | 2630 | Values: 69.0 66.0 64.0 66.0 65.0 65.0 66.0 66.0 70.0 88.0 09:10:09 INFO - PROCESS | 2630 | -------- Summary: end -------- 09:10:09 INFO - PROCESS | 2630 | 09:10:10 INFO - TEST-INFO | 2630: exit 0 09:10:10 INFO - TEST-OK | kraken | took 58205ms 09:10:10 INFO - SUITE-END | took 1173s 09:10:10 INFO - Completed test suite (00:19:33) 09:10:10 INFO - javascript benchmark 09:10:10 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3404.5233667286584, 3447.2588393495394, 3462.619111897691, 3488.668576485233, 3510.771799833011, 5763.56773242007, 5830.6501609903435, 5885.558583106263, 5893.911591326134, 5912.142739302799, 5773.797917072903, 5791.391903850098, 5879.11813228016, 5889.263842019747, 5912.704364781765, 5265.420803711599, 5289.761960711778, 5360.731963401814, 5366.221897824813, 5372.54333381663, 5221.530062294392, 5226.08543504887, 5237.057329680656, 5376.973115134419, 5396.028714831329, 5204.1413166827615, 5274.971380580789, 5300.708461034642, 5303.098473259555, 5308.203769434577, 5275.182346736262, 5303.893922121536, 5344.412114667383, 5366.9463305366835, 5384.219288203189, 5122.0, 5210.739463026834, 5309.309789727349, 5311.0, 5334.1732031535175, 5692.6299790513485, 5704.828855134353, 5729.856753581152, 5741.052726300156, 5773.191753154561, 6215.316315205324, 6281.309056003882, 6304.7793327233785, 6322.4942004639515, 6337.524685648595, 6276.466500347476, 6278.40355166263, 6283.465905398047, 6293.30773614902, 6295.653739044351, 5759.1937128802, 5776.104703770922, 5786.334571524244, 5801.390853960358, 5820.912686309709, 6298.02380631003, 6299.622022678563, 6328.430441260309, 6329.019002054597, 6337.33457986914, 6231.563790534619, 6244.188255526843, 6246.063090536365, 6255.311915689271, 6258.123862659231, 6202.689865506797, 6216.627002379872, 6232.0, 6268.811935641938, 6282.842928926722, 6289.937100629027, 6290.402411770874, 6302.149209856702, 6309.684515774193, 6309.684515774193, 6201.472874805602, 6262.655553944577, 6299.874002520016, 6310.5267104967315, 6324.33594472583, 4891.682040667345, 4948.158813001798, 4958.206686930074, 4987.725675087905, 5000.2499625056535, 4568.063546972929, 4569.200389931749, 4594.95405045952, 4621.722696638212, 4625.930611040837, 5790.044642634002, 5792.073268277056, 5797.333306669787, 5804.4195580442465, 5836.824895253149, 6182.783602573978, 6217.129601855744, 6223.719932603044, 6251.562390632612, 6275.02737075754, 5710.7430165642645, 5711.942880571141, 5716.314042314865, 5747.942520574825, 5776.508996735324, 5410.1343784994215, 5435.891282174334, 5436.91844622331, 5456.727163641802, 5464.23500709901, 6200.658963757037, 6242.687865606792, 6243.37566243372, 6267.4986001119805, 6339.175907132043, 6268.404501572343, 6293.748250070129, 6300.716467759054, 6301.0, 6301.338359472373, 5578.442155784389, 6350.396712312323, 6363.681815909279, 6367.140436041261, 6378.712957916812, 5509.917351239815, 6258.624482531062, 6270.0, 6295.464885484602, 6334.081558174131, 5621.55027597783, 6166.969165154145, 6203.976343903206, 6225.408586184305, 6297.433231009231, 4895.779689914034, 6233.065040244, 6239.220097487814, 6240.500759939103, 6271.310155882758, 6174.104754810437, 6212.720427580679, 6221.9377806223165, 6237.1891654084675, 6264.624122552661, 5899.380565040609, 5981.1028345746745, 6038.547108966933, 6088.056351265561, 6100.267967843887, 6127.234095738033, 6142.447179753844, 6145.907811382922, 6150.723217455315, 6152.938470615237, 5886.941130588811, 6039.245094363205, 6113.23584551931, 6119.076065312483, 6133.578370171964], "value": 5759.959441546457, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [488.8435700575815, 513.5532087084238, 522.0446582753561, 530.2496966791988, 537.4732761893345, 32625.83687081564, 33033.66966330336, 33176.33647327055, 41418.96452588687, 43177.56822431775, 44078.33882491757, 44540.55459445404, 44573.21127704141, 44687.77656111715, 44924.32613510792, 10026.348287361316, 10130.189584833233, 10217.795644087113, 10228.53971571281, 10234.9488252559, 9316.487593182372, 9517.333786634937, 9898.158656514204, 10029.398236105857, 12192.390380480985, 12320.876791232107, 12552.937235313857, 12571.49714011443, 12620.179688320275, 12635.684107897285, 12546.749065018694, 12597.74804503914, 12631.36843157843, 12632.68418289541, 12636.49454021838, 12373.752524949541, 12437.75124497505, 12450.688732781662, 12462.189957652814, 12462.376881155906, 41945.0, 42298.0, 42333.0, 42365.57634423647, 42392.78803605993, 3471.5313432686517, 3675.0, 3731.6641502264924, 3964.345882929313, 4146.295129827937, 30880.073597792103, 31048.53427198594, 32551.674483255338, 33561.83219083914, 33790.49314260288, 3314.171457135716, 3369.073504786179, 3461.6192218855904, 3503.562054743157, 3503.667151620592, 507727.0, 512014.0, 512776.4889404419, 513558.0, 516128.0, 29388.412231755672, 34555.30889382198, 61085.0, 61668.374871884786, 61686.0, 36099.81950090285, 36368.63631363706, 36430.81784591113, 36513.81743091321, 36549.26901461956, 15668.843311566967, 15848.52454426369, 15888.76166857498, 15894.046357218604, 15904.0, 13309.0, 13328.400221990034, 13341.599752007456, 13424.328783560783, 13428.597142085753, 7542.434317426105, 7699.230076992368, 7956.0, 8087.312578430781, 8113.918860811316, 3329.20099176196, 3385.2213990782257, 3394.4399174136483, 3402.0984439123654, 3412.931741365159, 879.76246413468, 1044.8587414246504, 1046.895310468947, 1058.4919238765435, 1089.8801131875487, 30997.845010775254, 31151.22121946924, 31323.590438430325, 31615.944963577294, 31793.046208613778, 1065.1851333729703, 1082.8971247731454, 1125.831125331207, 1162.657016180212, 1222.0468034932767, 13945.790813137812, 16321.51035468914, 16324.0, 16394.672106557802, 16576.6684666306, 704462.0, 704923.0, 705022.0, 705863.0, 706259.0, 61170.0, 61836.690816545626, 61868.381316187166, 61878.38121618726, 62004.0, 1291.2833377475404, 1317.236003118189, 1414.5756273118022, 1419.4109444580383, 1440.7478691229203, 28218.85890570534, 28402.0, 32390.514142288357, 32442.351152976335, 33010.17474563155, 51107.0, 51677.708057297365, 51705.482945170064, 51712.0, 51973.74013130061, 543856.0, 547376.0, 547478.0, 547896.0, 801896.0, 23476.53046939086, 27230.183094507196, 27817.721822781514, 28421.721022554448, 28475.291482511115, 48664.0, 49094.77263068452, 49310.75344623254, 49556.0, 49686.75156624194, 31666.0, 39240.26628606816, 40181.598184018956, 40986.79506602448, 41984.79007604942, 36351.63648363482, 40349.0, 40385.798071010635, 41401.55094571676, 41647.95880103022, 39225.607743923334, 39907.2018559633, 40378.79810600928, 40520.594794052864, 40617.1876562473, 33381.49927751037, 35345.64654353423, 35446.0, 35725.28549429049, 35897.28205435824, 26200.34499137537, 26482.735172648798, 26777.86611066932, 26998.865005674845, 27165.456690866467], "value": 19726.06414993735, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [375.80645967326825, 381.748046289449, 391.2898089966711, 403.796082978096, 412.51323438342763, 14978.85021149791, 20400.0, 21383.786162138374, 21466.356009319745, 22175.891205439722, 16358.0, 19800.504987375323, 20503.897480512613, 21093.15627374903, 21415.678764818542, 5395.514403703666, 6029.276486821587, 6340.492760579165, 6353.714082866282, 6379.489640828746, 6020.45815876571, 6216.347283535209, 6221.502279817604, 6283.811485655415, 6293.433590976834, 6225.2529696436495, 6234.064890266451, 6237.3450787667325, 6243.750249989995, 6244.687765611724, 6064.151018857364, 6113.480354169901, 6128.908066379008, 6200.255969283692, 6266.717997690069, 5194.740262986873, 5448.264484294609, 5458.754356053947, 5467.726613669301, 5473.781048758085, 26157.0, 26336.34159146037, 26734.46531069368, 26883.193504194904, 27077.323066923287, 2236.329101269629, 2280.2589158523547, 2293.736220334666, 2409.5662780699467, 3168.651448340681, 15065.849341506664, 15233.542993710207, 15237.923810380988, 16573.337066517324, 16573.50279491617, 1850.5928695686928, 1904.5525400695433, 1918.5875036867, 1932.072605149536, 1934.974463534329, 84676.0, 119512.80487195191, 119555.4022229892, 119678.80321196764, 120262.59474810542, 9112.49881256524, 10522.000409961041, 10706.839397409045, 10766.039339181787, 11222.102231821435, 13947.16317020982, 13949.95375346853, 13971.58085257444, 13981.79027314591, 13983.860161398256, 6499.54503184782, 8256.298214651822, 8278.296344810758, 8371.623276952552, 8531.573421328909, 7745.535267883945, 8376.706815261437, 8842.602082906285, 8894.0, 8990.910090899139, 6006.2191915051635, 6273.400282927824, 6545.0182472629485, 6671.86656266872, 6697.6986035628515, 1844.9354272600394, 1868.859835512342, 1888.1314595286049, 1892.7917929027797, 1917.980820191808, 738.5236522442995, 865.5931712095305, 939.3377668743519, 952.2334520710756, 1021.279997601689, 22179.223727169472, 22290.99690513931, 22728.318150455514, 22933.426664333525, 23196.53606927852, 850.4004676702909, 1005.492226425665, 1014.4471263161595, 1016.2479764973866, 1034.9896501035043, 8806.823863522694, 11865.110116741278, 11965.46155423008, 12060.691356305508, 12196.268223906416, 624003.0, 631699.0, 635213.0, 648689.0, 652802.0, 72694.63652681703, 123529.38235308765, 123924.0, 125578.0, 128804.71195288115, 1010.8786945566579, 1016.1464369929295, 1051.8632577764995, 1053.4522048534718, 1054.6097943760858, 19481.415557533295, 19764.901175494604, 20046.39860804178, 20046.49883752918, 20123.698144527552, 53626.0, 54961.25193740377, 55203.44796552144, 55401.722991384784, 55912.0, 75144.0, 77479.61260193663, 77856.61071694606, 79301.67332430242, 80593.59703201447, 6151.84620384494, 7194.136703595393, 7264.564126152448, 7483.438742094256, 7645.0, 9845.556949937127, 12860.0, 12917.160384574972, 13037.934810326267, 13358.933205333911, 11212.654481462278, 11744.94127529357, 11784.70538236551, 11825.940870295593, 11827.349495777815, 11000.174986876176, 11073.778524429628, 11121.16591255643, 11172.938570835757, 11507.769844603228, 9108.360495110943, 11092.778144437227, 11683.766324673628, 11950.701232469259, 11972.64082077539, 6428.55000149985, 7370.152432470334, 7440.619001919334, 7592.278733520307, 7803.0636323639255, 9001.864972025556, 9691.224702023681, 10268.332558383681, 11681.766364672829, 11773.88226117728], "value": 9807.336978153558, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1399.839018512871, 1533.9923300383496, 1749.9212535435904, 1926.229508196722, 1940.3790786948182, 6131.969340153299, 9288.767780805483, 9291.303152263581, 9293.070692930703, 9301.162895339417, 8066.878996815038, 8268.793280167998, 8661.133886611351, 8862.335324850646, 9047.954760226206, 2041.4488088216174, 2435.7077150741893, 2455.0793452455327, 2473.307473907309, 2474.1216868011866, 2419.8064154867657, 2442.3894026493376, 2463.963040554384, 2464.852108873464, 2469.6789417375717, 2435.1233555919853, 2450.8774561271953, 2457.6559281700575, 2460.188137914493, 2460.9138680146198, 2417.8549287042833, 2424.9393765155837, 2437.2688193541953, 2438.500107477963, 2443.3280847766828, 2414.2515820095828, 2433.1605596069326, 2439.1584903208363, 2444.6821913151352, 2445.2664200739705, 8992.730218093468, 8998.730038098867, 9102.954485227598, 9118.0, 9123.224525915306, 5372.0, 5543.1408131739245, 5547.25112109864, 5550.805721799758, 5554.888902221933, 3567.928641427157, 3631.7457777955556, 3679.7240206984316, 3694.7598406103516, 3715.1826598148364, 985.2807450561058, 1087.6628245243999, 1091.1761619976946, 1093.8569195191044, 1104.447776111944, 11956.222845515014, 11989.040876729841, 12073.758524829454, 12097.758044839142, 12098.637040888787, 4531.776420366483, 4570.588647021784, 4758.738269395148, 4759.357486739315, 4761.428628564525, 9327.113924177193, 9338.813223735488, 9339.252859771203, 9349.39228950116, 9355.578998945064, 4477.485089214717, 5418.458154184629, 5421.159720243369, 5425.430329815392, 5449.04641687703, 4386.583274588909, 4580.038191979722, 4714.764261786897, 5037.395512538519, 5056.494350564914, 3638.308721342936, 3699.9075023124637, 3844.826982785781, 3851.2297540492013, 4023.6177563131455, 1124.8537690100234, 1168.8772678868766, 1194.170051813981, 1205.73473835756, 1207.987920120805, 736.8010637127945, 905.1853332001251, 933.8373724712776, 934.1825902335456, 945.4847108325979, 5813.09896965971, 5891.941080589225, 5938.138969849348, 6108.5723999319625, 6143.600665956698, 449.49431889124736, 451.33653529312517, 460.99308510372373, 463.4994206257301, 472.5180316077582, 3362.7814192077435, 3804.2581696569455, 4018.0, 4052.63526282636, 4064.146529228836, 10694.625688101034, 11189.832152517718, 11215.046721028804, 11228.989390954854, 11236.0, 10703.411312377739, 10974.561017559208, 11162.497687603915, 11192.272502287326, 11194.328340299446, 8434.915650843413, 8493.745187644381, 8510.276626486819, 8513.361497887683, 8517.23344898962, 5876.500497457764, 5920.496757775637, 6014.007688731311, 6027.457528822427, 6078.179445774764, 9870.407775533491, 10147.18822494184, 10205.489725513844, 10275.253206954985, 10430.687079387328, 10389.584416623251, 10544.947275263574, 10552.944705529386, 10574.365538067741, 10579.836218015858, 7560.092788865371, 7609.505382150142, 7701.730439434817, 7726.575038372944, 7735.6905723770415, 8778.780530486789, 8819.162179592928, 8821.823563528822, 8826.91173088261, 8830.337724670804, 6760.18877734675, 7623.275788800055, 7736.0, 7792.2986931176465, 7865.370770338473, 6418.390252925965, 7409.814754630962, 7609.619519024137, 7643.617819109134, 7779.299863012356, 7170.498065135599, 7179.533330333512, 7243.601601911735, 7254.927450725636, 7262.164851042197, 4340.0, 5155.200943853709, 5162.97418512905, 5169.896602067863, 5235.267062611314, 5027.664538371339, 5043.697378157322, 5046.747662616928, 5298.125809241432, 5360.0083984463], "value": 4566.258572403027, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [310.1146227520429, 311.89239712299263, 319.2625036166456, 323.2855389589008, 324.3351130183124, 4809.1343558159515, 5276.7889284428575, 5429.918551221725, 5646.7176641167935, 5662.745176467059, 4962.826301079463, 4971.544776380417, 5270.736463176835, 5375.75809088591, 5557.194206840016, 4217.481706585627, 4217.620414162725, 4249.4475718156755, 4256.744595324282, 4282.74303541787, 4200.957990420103, 4223.788810559475, 4234.936475952848, 4265.613675555442, 4301.225779359714, 4073.307537718595, 4200.815575900529, 4208.978955105235, 4217.831286748542, 4236.682248831335, 3808.9619103808886, 3882.49527561418, 4226.767527785971, 4231.788410579458, 4250.681198910079, 3312.0726196664973, 3605.963940360589, 3653.671169594723, 3683.373826449483, 3702.2965636529243, 5137.6403651744395, 5255.5795536357, 5466.863328416822, 5475.233467314579, 5580.358258800249, 4867.785157753214, 4874.341963834908, 4878.609711223094, 4933.975330123362, 4949.257611358289, 5157.974210128926, 5788.305403351583, 5811.27359080115, 5820.30156381237, 5875.500582450497, 3714.888553343404, 3817.4464702618243, 3878.2437424702193, 4008.977710683786, 4065.6544193743566, 5699.943000569982, 6184.5052395808225, 6196.81409557714, 6209.441150296495, 6209.844753881144, 3486.651334866544, 3579.979705783839, 3935.5670876203594, 4075.5924407559005, 4085.4484644573195, 3386.5258863759095, 3390.423627983249, 4159.355299928516, 4166.167006435592, 4169.228692691861, 3765.4938024790304, 4355.1725172217175, 4739.7630118493935, 4753.33453316536, 4780.665353425296, 4634.629229661619, 4853.9029219415415, 5834.708264586839, 5897.380775018647, 5942.732577034044, 1324.5231566803138, 1378.9241591712553, 1412.3644360037817, 1413.8939579531577, 1417.9574612761633, 717.720089165226, 808.8988876390451, 836.6070492629825, 850.9446885952393, 851.948883067018, 4140.288111287112, 4166.58334166587, 4324.194708656362, 4589.760764593608, 4644.9767751161025, 4687.460941991646, 5013.39839219296, 5020.322256495399, 5041.823536176216, 5050.974745126251, 3940.349842275992, 4235.767032813224, 4379.0, 4498.8425405110665, 4708.4462127497845, 2090.811826935583, 2236.3897993444693, 2390.2112302939986, 2679.9682122383024, 2684.5302072137297, 4553.134904368159, 4809.422869255642, 5100.311457953203, 5179.741012949337, 5195.428502864682, 5115.769790359368, 5164.837911469889, 5182.300389447451, 5658.490735833712, 6316.810495685137, 6275.529335299871, 6357.7139028742895, 6366.363363663597, 6390.0734393512685, 6403.519736019817, 4831.444383895757, 5341.0, 5804.1293805929445, 6118.541109416722, 6170.043643235305, 4924.433690125681, 4970.453250142409, 6030.698465076816, 6046.5767396281835, 6054.545909056927, 5145.845624631267, 5252.474752524717, 6267.874642507216, 6354.3963323484195, 6424.325445828121, 3839.9808000959815, 4064.4309796627904, 4101.589841015874, 4112.362583799516, 4128.339465685476, 5531.81920395766, 5869.970650146722, 6005.117543579194, 6103.429493746208, 6110.877782444238, 5552.500274975271, 5935.614185077956, 5946.494547963472, 6036.185115009417, 6064.484518815773, 4896.212882297865, 5307.150855863043, 5326.920096198638, 5331.707365832729, 5975.40245975399, 4809.759512024455, 5120.820771272987, 5523.950449414599, 5724.198612194213, 5816.76732930678, 4760.000399916056, 5112.0, 5394.0, 5847.590668653153, 5870.21164946664, 4857.174280372275, 5691.317041954826, 5769.30768307789, 5769.91345129815, 5813.186153938367], "value": 4114.884353757428, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [746.4252525555322, 799.9400793948021, 830.4477522447572, 845.2392846438205, 868.6395146014404, 16474.83525164748, 17347.0, 17556.999999999985, 18294.0, 18402.539936501595, 17456.650866982654, 17638.91180544099, 17658.028808415533, 17669.64660706785, 17678.292868285287, 881.6958149438434, 884.933629977751, 896.5562046786818, 909.3498148823589, 914.7713071732067, 902.9954850225739, 905.42053086025, 905.4431524612381, 906.727981605519, 906.755176102452, 957.6265256549916, 958.1185309515228, 958.4967891856761, 959.0074273127315, 959.9952000239989, 951.6859436385976, 951.7525443384701, 952.8284908716428, 953.6614501851847, 953.9856902146473, 700.3906601256888, 703.0789665538161, 703.3494018033299, 703.5110598134298, 703.736098962889, 16302.021878687317, 16345.83654163455, 16357.754633680504, 16369.017858928384, 16380.508584742358, 14496.56510304682, 14535.345909434101, 14847.480338188112, 14858.0, 14949.177795221258, 11656.766864662744, 11857.881421185764, 11886.524539018428, 11918.165728399015, 11921.463534140985, 3781.5462144542557, 3851.094992676719, 3876.2053778975524, 4062.1672557125717, 4068.2270368629866, 140257.8961315581, 145159.0, 145661.0, 145828.0, 145894.0, 10071.395716257048, 10982.575768854695, 11248.887511124947, 11429.657110286706, 11957.70105747346, 21308.467288317606, 21433.035513401934, 23338.0, 23574.410639734146, 24038.278851634128, 8305.792355191168, 8326.70856520019, 8330.333573314121, 8363.16368363171, 8405.495670259805, 4543.409356783597, 4586.220342541776, 4689.343491911135, 4795.95204047962, 4846.684965477232, 3716.0, 3741.3639681254253, 3805.296020236265, 3825.254075455315, 3832.7508711933633, 669.7622344067884, 675.1830285354678, 687.1067612104245, 693.2512886083018, 694.035290945586, 613.1997742945409, 626.4800215820858, 629.8362425769333, 663.7245543099559, 671.8980871370956, 7389.261073892568, 9762.019195037326, 9782.266330025277, 9816.705498835046, 9827.31208815376, 665.6172700697118, 666.1240468783534, 680.251723104581, 688.8450098727747, 705.4250785609712, 4497.482789479186, 4720.716756994591, 4721.362616046858, 4750.881227969328, 4754.976225118921, 147121.26439367735, 177133.0, 177340.0, 177431.0, 185723.0, 108751.45624271828, 151813.0, 154071.0, 156844.0, 157481.2125939363, 97822.51088744654, 127706.0, 127918.0, 136084.0, 137173.6282637161, 7462.738804141829, 9031.864522032043, 9089.772755680897, 9119.316051296046, 9364.986527896535, 58133.70933145307, 58594.0, 61556.0, 65387.0, 67869.3213067863, 63970.0, 66212.66893665501, 89277.0, 89437.0, 98400.01599983909, 13534.0, 13723.588292351245, 13778.931105344409, 13785.51750688721, 14069.648258793612, 14797.0, 15350.539483815503, 15402.610256077412, 15909.284082216096, 16850.66298674044, 14202.431902723776, 14551.41794328215, 14755.483558075415, 15096.0, 15639.687206255583, 14731.558053258419, 14842.851571484147, 15070.397184112951, 15252.694946101237, 15407.84592154109, 12071.57749478764, 13582.524611638546, 14404.063735857555, 14498.0, 14652.560423187322, 11755.647330580096, 12215.0, 12280.447379868107, 12305.56930507428, 12396.0, 11663.650090497298, 11905.890571592594, 11915.761684766083, 12148.635540933787, 12425.0], "value": 8342.519904253708, "unit": "score"}], "name": "dromaeo_css", "value": 7476.735861925792, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 114.0, 122.0, 168.0, 154.0, 112.0, 113.0, 113.0, 113.0, 113.0], "value": 123.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 112.0, 134.0, 167.0, 109.0, 109.0, 108.0, 109.0, 138.0, 107.0], "value": 123.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 183.0, 187.0, 183.0, 184.0, 181.0, 183.0, 184.0, 186.0, 184.0], "value": 183.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 58.0, 58.0, 90.0, 59.0, 59.0, 58.0, 58.0, 86.0, 74.0], "value": 68.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 70.0, 93.0, 70.0, 68.0, 68.0, 92.0, 67.0, 67.0, 89.0], "value": 76.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 88.0, 90.0, 87.0, 90.0, 87.0, 92.0, 88.0, 88.0, 86.0], "value": 88.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 83.0, 85.0, 85.0, 101.0, 133.0, 142.0, 86.0, 85.0], "value": 96.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 55.0, 56.0, 53.0, 54.0, 57.0, 58.0, 57.0, 57.0, 56.0], "value": 56.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 66.0, 75.0, 75.0, 69.0, 67.0, 68.0, 68.0, 68.0, 70.0], "value": 68.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 84.0, 83.0, 81.0, 84.0, 86.0, 87.0, 83.0, 100.0], "value": 85.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 152.0, 149.0, 134.0, 132.0, 132.0, 136.0, 137.0, 139.0, 152.0], "value": 141.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 162.0, 163.0, 161.0, 162.0, 175.0, 161.0, 158.0, 159.0, 160.0], "value": 162.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 66.0, 64.0, 66.0, 65.0, 65.0, 66.0, 66.0, 70.0, 88.0], "value": 68.5, "unit": "score"}], "name": "kraken", "value": 1439.7, "alertThreshold": 2.0}]} 09:10:10 INFO - Return code: 0 09:10:10 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:10:10 INFO - # TBPL SUCCESS # 09:10:10 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:10:10 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:10:10 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:10:10 INFO - 2016-12-01 09:10:10.690 screenresolution[2634:295553] starting screenresolution argv=screenresolution get 09:10:10 INFO - 2016-12-01 09:10:10.693 screenresolution[2634:295553] Display 0: 1600x1200x32@60 09:10:10 INFO - 2016-12-01 09:10:10.699 screenresolution[2635:295556] starting screenresolution argv=screenresolution list 09:10:10 INFO - Available Modes on Display 0 09:10:10 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:10:10 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:10:10 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:10:10 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:10:10 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:10:10 INFO - Intel Iris: 09:10:10 INFO - Chipset Model: Intel Iris 09:10:10 INFO - Type: GPU 09:10:10 INFO - Bus: Built-In 09:10:10 INFO - VRAM (Dynamic, Max): 1536 MB 09:10:10 INFO - Vendor: Intel (0x8086) 09:10:10 INFO - Device ID: 0x0a2e 09:10:10 INFO - Revision ID: 0x0009 09:10:10 INFO - Displays: 09:10:10 INFO - Display: 09:10:10 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:10:10 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:10:10 INFO - Display Serial Number: 1600x1200 60 09:10:10 INFO - Main Display: Yes 09:10:10 INFO - Mirror: Off 09:10:10 INFO - Online: Yes 09:10:10 INFO - Rotation: Supported 09:10:10 INFO - Return code: 0 09:10:10 INFO - Running post-action listener: _resource_record_post_action 09:10:10 INFO - [mozharness: 2016-12-01 17:10:10.934595Z] Finished run-tests step (success) 09:10:10 INFO - Running post-run listener: _resource_record_post_run 09:10:10 INFO - Total resource usage - Wall time: 1196s; CPU: 53.0%; Read bytes: 704512; Write bytes: 494979584; Read time: 5; Write time: 1558 09:10:10 INFO - TinderboxPrint: CPU usage
53.2% 09:10:10 INFO - TinderboxPrint: I/O read bytes / time
704,512 / 5 09:10:10 INFO - TinderboxPrint: I/O write bytes / time
494,979,584 / 1,558 09:10:10 INFO - TinderboxPrint: CPU idle
2,238.1 (46.8%) 09:10:10 INFO - TinderboxPrint: CPU system
958.1 (20.0%) 09:10:10 INFO - TinderboxPrint: CPU user
1,589.5 (33.2%) 09:10:10 INFO - TinderboxPrint: Swap in / out
209,403,904 / 0 09:10:10 INFO - install - Wall time: 23s; CPU: 54.0%; Read bytes: 187974144; Write bytes: 187561984; Read time: 17605; Write time: 413 09:10:11 INFO - run-tests - Wall time: 1174s; CPU: 53.0%; Read bytes: 704512; Write bytes: 297251328; Read time: 5; Write time: 1114 09:10:11 INFO - Running post-run listener: _upload_blobber_files 09:10:11 INFO - Blob upload gear active. 09:10:11 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:10:11 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:10:11 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:10:11 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:10:11 INFO - (blobuploader) - INFO - Open directory for files ... 09:10:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:10:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:10:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:10:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:10:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:10:13 INFO - (blobuploader) - INFO - Done attempting. 09:10:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:10:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:10:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:10:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:10:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:10:14 INFO - (blobuploader) - INFO - Done attempting. 09:10:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:10:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:10:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:10:16 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:10:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:10:16 INFO - (blobuploader) - INFO - Done attempting. 09:10:16 INFO - (blobuploader) - INFO - Iteration through files over. 09:10:16 INFO - Return code: 0 09:10:16 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:10:16 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:10:16 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/43c828ad211d6eab1e67c8cc8c645b313f55d1eeaff0558d95c70291c01ea3cf78a5e723c89c034d534851b3b17306eed55bf4c12143b99d46f6258c890200eb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b85169ed6574294155bb3019d4bd2f78c1bc5fbe44d07f6a659f0e4bb2fcf95dd1c10fa96046d504e673611fb667be0c3d6e66916e80d8ff63248daa50ef635a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/926f0376ad4ff178b6e352524b6ff6fdcf4d558a4a7bc634f3d02a2c20cf45cd03488016fe706674e2ff0b71d63a3f00f7996ba0acb6ad98426accc713990bbd"} 09:10:16 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:10:16 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:10:16 INFO - Contents: 09:10:16 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/43c828ad211d6eab1e67c8cc8c645b313f55d1eeaff0558d95c70291c01ea3cf78a5e723c89c034d534851b3b17306eed55bf4c12143b99d46f6258c890200eb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b85169ed6574294155bb3019d4bd2f78c1bc5fbe44d07f6a659f0e4bb2fcf95dd1c10fa96046d504e673611fb667be0c3d6e66916e80d8ff63248daa50ef635a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/926f0376ad4ff178b6e352524b6ff6fdcf4d558a4a7bc634f3d02a2c20cf45cd03488016fe706674e2ff0b71d63a3f00f7996ba0acb6ad98426accc713990bbd"} 09:10:16 INFO - Running post-run listener: copy_logs_to_upload_dir 09:10:16 INFO - Copying logs to upload dir... 09:10:16 INFO - mkdir: /builds/slave/test/build/upload/logs 09:10:16 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1255.679812 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2016-12-01 09:10:16.638694) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-01 09:10:16.642117) ========= 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.N9LfoUeDAN/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.0e06HXg8cb/Listeners TMPDIR=/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/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/43c828ad211d6eab1e67c8cc8c645b313f55d1eeaff0558d95c70291c01ea3cf78a5e723c89c034d534851b3b17306eed55bf4c12143b99d46f6258c890200eb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b85169ed6574294155bb3019d4bd2f78c1bc5fbe44d07f6a659f0e4bb2fcf95dd1c10fa96046d504e673611fb667be0c3d6e66916e80d8ff63248daa50ef635a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/926f0376ad4ff178b6e352524b6ff6fdcf4d558a4a7bc634f3d02a2c20cf45cd03488016fe706674e2ff0b71d63a3f00f7996ba0acb6ad98426accc713990bbd"} build_url:https://queue.taskcluster.net/v1/task/Jq0CJMX0RJW1dK38kXe2BQ/artifacts/public/build/firefox-51.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011214 build_url: 'https://queue.taskcluster.net/v1/task/Jq0CJMX0RJW1dK38kXe2BQ/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/43c828ad211d6eab1e67c8cc8c645b313f55d1eeaff0558d95c70291c01ea3cf78a5e723c89c034d534851b3b17306eed55bf4c12143b99d46f6258c890200eb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b85169ed6574294155bb3019d4bd2f78c1bc5fbe44d07f6a659f0e4bb2fcf95dd1c10fa96046d504e673611fb667be0c3d6e66916e80d8ff63248daa50ef635a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/926f0376ad4ff178b6e352524b6ff6fdcf4d558a4a7bc634f3d02a2c20cf45cd03488016fe706674e2ff0b71d63a3f00f7996ba0acb6ad98426accc713990bbd"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-01 09:10:16.675797) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-01 09:10:16.676134) ========= 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.N9LfoUeDAN/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.0e06HXg8cb/Listeners TMPDIR=/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/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.005342 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-01 09:10:16.725542) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-01 09:10:16.725861) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-01 09:10:16.726170) ========= ========= Total master_lag: 0.18 =========