builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0341 starttime: 1481731388.17 results: success (0) buildid: 20161214050001 builduid: 3315a2ab10354e4f8b0cce4d1f2c435f revision: ecdf085419775e4c24ae07b32967bc9ebf47b8f1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-14 08:03:08.167616) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-14 08:03:08.168136) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-14 08:03:08.168425) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-14 08:03:08.192843) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-14 08:03:08.193248) ========= 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.k8sAEIh0YK/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.WfRmT7XbWL/Listeners TMPDIR=/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/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-14 08:03:08-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 157M=0s 2016-12-14 08:03:08 (157 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.102448 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-14 08:03:08.319759) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-14 08:03:08.320082) ========= 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.k8sAEIh0YK/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.WfRmT7XbWL/Listeners TMPDIR=/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/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.024767 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-14 08:03:08.368974) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-14 08:03:08.369343) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev ecdf085419775e4c24ae07b32967bc9ebf47b8f1 --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 ecdf085419775e4c24ae07b32967bc9ebf47b8f1 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.k8sAEIh0YK/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.WfRmT7XbWL/Listeners TMPDIR=/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/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-14 08:03:08,464 truncating revision to first 12 chars 2016-12-14 08:03:08,464 Setting DEBUG logging. 2016-12-14 08:03:08,464 attempt 1/10 2016-12-14 08:03:08,464 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/ecdf08541977?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-14 08:03:09,525 unpacking tar archive at: mozilla-beta-ecdf08541977/testing/mozharness/ program finished with exit code 0 elapsedTime=1.342371 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-14 08:03:09.735507) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-14 08:03:09.735828) ========= script_repo_revision: ecdf085419775e4c24ae07b32967bc9ebf47b8f1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-14 08:03:09.736239) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-14 08:03:09.736510) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-14 08:03:09.757000) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2016-12-14 08:03:09.757368) ========= /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.k8sAEIh0YK/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.WfRmT7XbWL/Listeners TMPDIR=/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/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:03:09 INFO - MultiFileLogger online at 20161214 08:03:09 in /builds/slave/test 08:03:09 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:03:09 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:03:09 INFO - {'append_to_log': False, 08:03:09 INFO - 'base_work_dir': '/builds/slave/test', 08:03:09 INFO - 'blob_upload_branch': 'Mozilla-Beta', 08:03:09 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:03:09 INFO - 'branch': 'Mozilla-Beta', 08:03:09 INFO - 'buildbot_json_path': 'buildprops.json', 08:03:09 INFO - 'config_files': ('talos/mac_config.py',), 08:03:09 INFO - 'default_actions': ('clobber', 08:03:09 INFO - 'read-buildbot-config', 08:03:09 INFO - 'download-and-extract', 08:03:09 INFO - 'populate-webroot', 08:03:09 INFO - 'create-virtualenv', 08:03:09 INFO - 'install', 08:03:09 INFO - 'run-tests'), 08:03:09 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:03:09 INFO - 'download_minidump_stackwalk': True, 08:03:09 INFO - 'download_symbols': 'ondemand', 08:03:09 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:03:09 INFO - 'tooltool.py': '/tools/tooltool.py', 08:03:09 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:03:09 INFO - '/tools/misc-python/virtualenv.py')}, 08:03:09 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:03:09 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:03:09 INFO - 'installer_path': 'installer.exe', 08:03:09 INFO - 'log_level': 'info', 08:03:09 INFO - 'log_name': 'talos', 08:03:09 INFO - 'log_to_console': True, 08:03:09 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:03:09 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:03:09 INFO - 'opt_config_files': (), 08:03:09 INFO - 'pip_index': False, 08:03:09 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:03:09 INFO - 'cmd': ('bash', 08:03:09 INFO - '-c', 08:03:09 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:03:09 INFO - 'enabled': True, 08:03:09 INFO - 'halt_on_failure': False, 08:03:09 INFO - 'name': 'check_screen_resolution'},), 08:03:09 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:03:09 INFO - 'cmd': ('bash', 08:03:09 INFO - '-c', 08:03:09 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:03:09 INFO - 'enabled': True, 08:03:09 INFO - 'halt_on_failure': False, 08:03:09 INFO - 'name': 'check_screen_resolution'},), 08:03:09 INFO - 'run_cmd_checks_enabled': True, 08:03:09 INFO - 'sps_profile': False, 08:03:09 INFO - 'sps_profile_interval': 0, 08:03:09 INFO - 'suite': 'dromaeojs', 08:03:09 INFO - 'system_bits': '32', 08:03:09 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:03:09 INFO - 'title': 't-yosemite-r7-0341', 08:03:09 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:03:09 INFO - 'use_talos_json': True, 08:03:09 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:03:09 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:03:09 INFO - 'work_dir': 'build'} 08:03:09 INFO - [mozharness: 2016-12-14 16:03:09.968251Z] Running clobber step. 08:03:09 INFO - Running pre-action listener: _resource_record_pre_action 08:03:09 INFO - Running main action method: clobber 08:03:09 INFO - rmtree: /builds/slave/test/build 08:03:09 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:03:12 INFO - Running post-action listener: _resource_record_post_action 08:03:12 INFO - [mozharness: 2016-12-14 16:03:12.397881Z] Finished clobber step (success) 08:03:12 INFO - [mozharness: 2016-12-14 16:03:12.398080Z] Running read-buildbot-config step. 08:03:12 INFO - Running pre-action listener: _resource_record_pre_action 08:03:12 INFO - Running main action method: read_buildbot_config 08:03:12 INFO - Using buildbot properties: 08:03:12 INFO - { 08:03:12 INFO - "project": "", 08:03:12 INFO - "product": "firefox", 08:03:12 INFO - "script_repo_revision": "production", 08:03:12 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 08:03:12 INFO - "repository": "", 08:03:12 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 08:03:12 INFO - "buildid": "20161214050001", 08:03:12 INFO - "pgo_build": "False", 08:03:12 INFO - "basedir": "/builds/slave/test", 08:03:12 INFO - "buildnumber": 83, 08:03:12 INFO - "slavename": "t-yosemite-r7-0341", 08:03:12 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 08:03:12 INFO - "platform": "yosemite_r7", 08:03:12 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 08:03:12 INFO - "branch": "mozilla-beta", 08:03:12 INFO - "repo_path": "releases/mozilla-beta", 08:03:12 INFO - "revision": "ecdf085419775e4c24ae07b32967bc9ebf47b8f1", 08:03:12 INFO - "stage_platform": "macosx64", 08:03:12 INFO - "builduid": "3315a2ab10354e4f8b0cce4d1f2c435f", 08:03:12 INFO - "slavebuilddir": "test" 08:03:12 INFO - } 08:03:12 INFO - Found installer url https://queue.taskcluster.net/v1/task/Zezw4-f8RR6ywDZ_S_sYLg/artifacts/public/build/firefox-51.0.en-US.mac.dmg. 08:03:12 INFO - Running post-action listener: _resource_record_post_action 08:03:12 INFO - [mozharness: 2016-12-14 16:03:12.402116Z] Finished read-buildbot-config step (success) 08:03:12 INFO - [mozharness: 2016-12-14 16:03:12.402283Z] Running download-and-extract step. 08:03:12 INFO - Running pre-action listener: _resource_record_pre_action 08:03:12 INFO - Running main action method: download_and_extract 08:03:12 INFO - mkdir: /builds/slave/test/build/tests 08:03: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:03:12 INFO - trying https://queue.taskcluster.net/v1/task/Zezw4-f8RR6ywDZ_S_sYLg/artifacts/public/build/firefox-51.0.en-US.mac.test_packages.json 08:03:12 INFO - Downloading https://queue.taskcluster.net/v1/task/Zezw4-f8RR6ywDZ_S_sYLg/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:03:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Zezw4-f8RR6ywDZ_S_sYLg/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:03:12 INFO - Downloaded 1165 bytes. 08:03:12 INFO - Reading from file /builds/slave/test/build/firefox-51.0.en-US.mac.test_packages.json 08:03:12 INFO - Using the following test package requirements: 08:03:12 INFO - {u'common': [u'firefox-51.0.en-US.mac.common.tests.zip'], 08:03:12 INFO - u'cppunittest': [u'firefox-51.0.en-US.mac.common.tests.zip', 08:03:12 INFO - u'firefox-51.0.en-US.mac.cppunittest.tests.zip'], 08:03:12 INFO - u'gtest': [u'firefox-51.0.en-US.mac.common.tests.zip', 08:03:12 INFO - u'firefox-51.0.en-US.mac.gtest.tests.zip'], 08:03:12 INFO - u'jittest': [u'firefox-51.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 08:03:12 INFO - u'mochitest': [u'firefox-51.0.en-US.mac.common.tests.zip', 08:03:12 INFO - u'firefox-51.0.en-US.mac.mochitest.tests.zip'], 08:03:12 INFO - u'mozbase': [u'firefox-51.0.en-US.mac.common.tests.zip'], 08:03:12 INFO - u'reftest': [u'firefox-51.0.en-US.mac.common.tests.zip', 08:03:12 INFO - u'firefox-51.0.en-US.mac.reftest.tests.zip'], 08:03:12 INFO - u'talos': [u'firefox-51.0.en-US.mac.common.tests.zip', 08:03:12 INFO - u'firefox-51.0.en-US.mac.talos.tests.zip'], 08:03:12 INFO - u'web-platform': [u'firefox-51.0.en-US.mac.common.tests.zip', 08:03:12 INFO - u'firefox-51.0.en-US.mac.web-platform.tests.zip'], 08:03:12 INFO - u'xpcshell': [u'firefox-51.0.en-US.mac.common.tests.zip', 08:03:12 INFO - u'firefox-51.0.en-US.mac.xpcshell.tests.zip']} 08:03:12 INFO - Downloading packages: [u'firefox-51.0.en-US.mac.common.tests.zip'] for test suite category: common 08:03:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Zezw4-f8RR6ywDZ_S_sYLg/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip 08:03:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Zezw4-f8RR6ywDZ_S_sYLg/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip'}, attempt #1 08:03:12 INFO - Fetch https://queue.taskcluster.net/v1/task/Zezw4-f8RR6ywDZ_S_sYLg/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip into memory 08:03:13 INFO - Expected file size: 16232529 08:03:20 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:03:20 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Zezw4-f8RR6ywDZ_S_sYLg/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip 08:03:20 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Zezw4-f8RR6ywDZ_S_sYLg/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip'}, attempt #1 08:03:20 INFO - Fetch https://queue.taskcluster.net/v1/task/Zezw4-f8RR6ywDZ_S_sYLg/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip into memory 08:03:20 INFO - Expected file size: 16232529 08:03:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Zezw4-f8RR6ywDZ_S_sYLg/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip 08:03:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Zezw4-f8RR6ywDZ_S_sYLg/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip'}, attempt #1 08:03:27 INFO - Fetch https://queue.taskcluster.net/v1/task/Zezw4-f8RR6ywDZ_S_sYLg/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip into memory 08:03:28 INFO - Expected file size: 14414089 08:03:28 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:03:28 INFO - trying https://queue.taskcluster.net/v1/task/Zezw4-f8RR6ywDZ_S_sYLg/artifacts/public/build/firefox-51.0.en-US.mac.dmg 08:03:28 INFO - Downloading https://queue.taskcluster.net/v1/task/Zezw4-f8RR6ywDZ_S_sYLg/artifacts/public/build/firefox-51.0.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0.en-US.mac.dmg 08:03:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Zezw4-f8RR6ywDZ_S_sYLg/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:03:31 INFO - Downloaded 86073969 bytes. 08:03:31 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Zezw4-f8RR6ywDZ_S_sYLg/artifacts/public/build/firefox-51.0.en-US.mac.dmg 08:03:31 INFO - mkdir: /builds/slave/test/properties 08:03:31 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:03:31 INFO - Writing to file /builds/slave/test/properties/build_url 08:03:31 INFO - Contents: 08:03:31 INFO - build_url:https://queue.taskcluster.net/v1/task/Zezw4-f8RR6ywDZ_S_sYLg/artifacts/public/build/firefox-51.0.en-US.mac.dmg 08:03:31 INFO - Running post-action listener: _resource_record_post_action 08:03:31 INFO - Running post-action listener: set_extra_try_arguments 08:03:31 INFO - [mozharness: 2016-12-14 16:03:31.937954Z] Finished download-and-extract step (success) 08:03:31 INFO - [mozharness: 2016-12-14 16:03:31.938087Z] Running populate-webroot step. 08:03:31 INFO - Running pre-action listener: _resource_record_pre_action 08:03:31 INFO - Running main action method: populate_webroot 08:03:31 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:03:31 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:03:31 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:03:31 INFO - '--tppagecycles', 08:03:31 INFO - '7'], 08:03:31 INFO - 'tests': ['tsvgm']}}, 08:03:31 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:03:31 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:03:31 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:03:31 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:03:31 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:03:31 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:03:31 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:03:31 INFO - 'talos_options': ['--disable-e10s'], 08:03:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:03:31 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:03:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:03:31 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:03:31 INFO - 'talos_options': ['--disable-e10s'], 08:03:31 INFO - 'tests': ['damp', 'tps']}, 08:03:31 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:03:31 INFO - 'tests': ['damp', 'tps']}, 08:03:31 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:03:31 INFO - 'tests': ['dromaeo_dom']}, 08:03:31 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:03:31 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:03:31 INFO - 'tests': ['basic_compositor_video']}, 08:03:31 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:03:31 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:03:31 INFO - 'tests': ['a11yr', 08:03:31 INFO - 'ts_paint', 08:03:31 INFO - 'tpaint', 08:03:31 INFO - 'sessionrestore', 08:03:31 INFO - 'sessionrestore_no_auto_restore', 08:03:31 INFO - 'tabpaint']}, 08:03:31 INFO - 'other-e10s': {'tests': ['a11yr', 08:03:31 INFO - 'ts_paint', 08:03:31 INFO - 'tpaint', 08:03:31 INFO - 'sessionrestore', 08:03:31 INFO - 'sessionrestore_no_auto_restore', 08:03:31 INFO - 'tabpaint']}, 08:03:31 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:03:31 INFO - 'ts_paint', 08:03:31 INFO - 'tpaint', 08:03:31 INFO - 'sessionrestore', 08:03:31 INFO - 'sessionrestore_no_auto_restore', 08:03:31 INFO - 'tabpaint']}, 08:03:31 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:03:31 INFO - 'ts_paint', 08:03:31 INFO - 'tpaint', 08:03:31 INFO - 'sessionrestore', 08:03:31 INFO - 'sessionrestore_no_auto_restore', 08:03:31 INFO - 'tabpaint']}, 08:03:31 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:03:31 INFO - 'tests': ['a11yr', 08:03:31 INFO - 'ts_paint', 08:03:31 INFO - 'tpaint', 08:03:31 INFO - 'sessionrestore', 08:03:31 INFO - 'sessionrestore_no_auto_restore', 08:03:31 INFO - 'tabpaint']}, 08:03:31 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:03:31 INFO - 'tests': ['a11yr', 08:03:31 INFO - 'ts_paint', 08:03:31 INFO - 'tpaint', 08:03:31 INFO - 'sessionrestore', 08:03:31 INFO - 'sessionrestore_no_auto_restore', 08:03:31 INFO - 'tabpaint']}, 08:03:31 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:03:31 INFO - 'tests': ['tsvgx', 08:03:31 INFO - 'tsvgr_opacity', 08:03:31 INFO - 'tart', 08:03:31 INFO - 'tscrollx', 08:03:31 INFO - 'cart']}, 08:03:31 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:03:31 INFO - 'tsvgr_opacity', 08:03:31 INFO - 'tart', 08:03:31 INFO - 'tscrollx', 08:03:31 INFO - 'cart']}, 08:03:31 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:03:31 INFO - 'talos_options': ['--disable-e10s'], 08:03:31 INFO - 'tests': ['tp5o']}, 08:03:31 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:03:31 INFO - 'tests': ['tp5o']}, 08:03:31 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:03:31 INFO - 'talos_options': ['--disable-e10s', 08:03:31 INFO - '--xperf_path', 08:03:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:03:31 INFO - 'tests': ['tp5n']}, 08:03:31 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:03:31 INFO - 'talos_options': ['--xperf_path', 08:03:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:03:31 INFO - 'tests': ['tp5n']}}, 08:03:31 INFO - 'talos.zip': {'path': '', 08:03:31 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:03:31 INFO - Running post-action listener: _resource_record_post_action 08:03:31 INFO - [mozharness: 2016-12-14 16:03:31.956611Z] Finished populate-webroot step (success) 08:03:31 INFO - [mozharness: 2016-12-14 16:03:31.956720Z] Running create-virtualenv step. 08:03:31 INFO - Running pre-action listener: _resource_record_pre_action 08:03:31 INFO - Running main action method: create_virtualenv 08:03:31 INFO - Creating virtualenv /builds/slave/test/build/venv 08:03:31 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:03:31 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:03:32 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:03:32 INFO - Using real prefix '/tools/python27' 08:03:32 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:03:32 INFO - Installing distribute.............................................................................................................................................................................................done. 08:03:35 INFO - Installing pip.................done. 08:03:35 INFO - Return code: 0 08:03:35 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:03:35 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:03:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:03:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:03:35 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:03:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:03:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:03:35 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 0x10ddb6490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dd2c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe43ac92f30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dbcad30>, '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 0x10da30db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dbc2b20>, '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.k8sAEIh0YK/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.WfRmT7XbWL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/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:03:35 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:03:35 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:03:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.k8sAEIh0YK/Render', 08:03:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:03:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:03:35 INFO - 'HOME': '/Users/cltbld', 08:03:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:03:35 INFO - 'LOGNAME': 'cltbld', 08:03:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:03:35 INFO - 'MOZ_NO_REMOTE': '1', 08:03:35 INFO - 'NO_EM_RESTART': '1', 08:03:35 INFO - 'PAGER': '/bin/cat', 08:03:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:03:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:03:35 INFO - 'PWD': '/builds/slave/test', 08:03:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:03:35 INFO - 'SHELL': '/bin/bash', 08:03:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WfRmT7XbWL/Listeners', 08:03:35 INFO - 'TMPDIR': '/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/', 08:03:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:03:35 INFO - 'USER': 'cltbld', 08:03:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:03:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:03:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:03:35 INFO - 'XPC_FLAGS': '0x0', 08:03:35 INFO - 'XPC_SERVICE_NAME': '0', 08:03:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:03:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:03:35 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:03:35 INFO - Cleaning up... 08:03:35 INFO - Return code: 0 08:03:35 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:03:35 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:03:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:03:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:03:35 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:03:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:03:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:03:35 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 0x10ddb6490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dd2c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe43ac92f30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dbcad30>, '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 0x10da30db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dbc2b20>, '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.k8sAEIh0YK/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.WfRmT7XbWL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/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:03:35 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:03:35 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:03:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.k8sAEIh0YK/Render', 08:03:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:03:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:03:35 INFO - 'HOME': '/Users/cltbld', 08:03:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:03:35 INFO - 'LOGNAME': 'cltbld', 08:03:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:03:35 INFO - 'MOZ_NO_REMOTE': '1', 08:03:35 INFO - 'NO_EM_RESTART': '1', 08:03:35 INFO - 'PAGER': '/bin/cat', 08:03:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:03:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:03:35 INFO - 'PWD': '/builds/slave/test', 08:03:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:03:35 INFO - 'SHELL': '/bin/bash', 08:03:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WfRmT7XbWL/Listeners', 08:03:35 INFO - 'TMPDIR': '/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/', 08:03:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:03:35 INFO - 'USER': 'cltbld', 08:03:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:03:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:03:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:03:35 INFO - 'XPC_FLAGS': '0x0', 08:03:35 INFO - 'XPC_SERVICE_NAME': '0', 08:03:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:03:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:03:36 INFO - Downloading/unpacking psutil>=3.1.1 08:03:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:03:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:03:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:03:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:03:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:03:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:03:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:03:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:03:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:03:39 INFO - Installing collected packages: psutil 08:03:39 INFO - Running setup.py install for psutil 08:03:39 INFO - building 'psutil._psutil_osx' extension 08:03:39 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:03:39 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:03:39 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:03:40 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:03:40 INFO - building 'psutil._psutil_posix' extension 08:03:40 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:03:40 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 08:03:40 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 08:03:40 INFO - ^ 08:03:40 INFO - 1 warning generated. 08:03:40 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:03:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:03:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:03:40 INFO - Successfully installed psutil 08:03:40 INFO - Cleaning up... 08:03:40 INFO - Return code: 0 08:03:40 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:03:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:03:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:03:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:03:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:03:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:03:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:03:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ddb6490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dd2c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe43ac92f30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dbcad30>, '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 0x10da30db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dbc2b20>, '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.k8sAEIh0YK/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.WfRmT7XbWL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/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:03:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:03:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 08:03:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.k8sAEIh0YK/Render', 08:03:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:03:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:03:40 INFO - 'HOME': '/Users/cltbld', 08:03:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:03:40 INFO - 'LOGNAME': 'cltbld', 08:03:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:03:40 INFO - 'MOZ_NO_REMOTE': '1', 08:03:40 INFO - 'NO_EM_RESTART': '1', 08:03:40 INFO - 'PAGER': '/bin/cat', 08:03:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:03:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:03:40 INFO - 'PWD': '/builds/slave/test', 08:03:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:03:40 INFO - 'SHELL': '/bin/bash', 08:03:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WfRmT7XbWL/Listeners', 08:03:40 INFO - 'TMPDIR': '/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/', 08:03:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:03:40 INFO - 'USER': 'cltbld', 08:03:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:03:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:03:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:03:40 INFO - 'XPC_FLAGS': '0x0', 08:03:40 INFO - 'XPC_SERVICE_NAME': '0', 08:03:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:03:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:03:40 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:03:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:03:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:03:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:03:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:03:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:03:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:03:43 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:03:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:03:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:03:43 INFO - Installing collected packages: mozsystemmonitor 08:03:43 INFO - Running setup.py install for mozsystemmonitor 08:03:43 INFO - Successfully installed mozsystemmonitor 08:03:43 INFO - Cleaning up... 08:03:43 INFO - Return code: 0 08:03:43 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:03:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:03:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:03:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:03:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:03:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:03:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:03:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10ddb6490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dd2c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe43ac92f30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dbcad30>, '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 0x10da30db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dbc2b20>, '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.k8sAEIh0YK/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.WfRmT7XbWL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/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:03:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:03:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 08:03:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.k8sAEIh0YK/Render', 08:03:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:03:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:03:43 INFO - 'HOME': '/Users/cltbld', 08:03:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:03:43 INFO - 'LOGNAME': 'cltbld', 08:03:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:03:43 INFO - 'MOZ_NO_REMOTE': '1', 08:03:43 INFO - 'NO_EM_RESTART': '1', 08:03:43 INFO - 'PAGER': '/bin/cat', 08:03:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:03:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:03:43 INFO - 'PWD': '/builds/slave/test', 08:03:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:03:43 INFO - 'SHELL': '/bin/bash', 08:03:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WfRmT7XbWL/Listeners', 08:03:43 INFO - 'TMPDIR': '/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/', 08:03:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:03:43 INFO - 'USER': 'cltbld', 08:03:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:03:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:03:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:03:43 INFO - 'XPC_FLAGS': '0x0', 08:03:43 INFO - 'XPC_SERVICE_NAME': '0', 08:03:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:03:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:03:43 INFO - Downloading/unpacking jsonschema==2.5.1 08:03:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:03:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:03:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:03:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:03:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:03:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:03:46 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:03:46 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:03: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:03: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:03: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:03: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:03: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:03: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:03:46 INFO - Downloading functools32-3.2.3-2.tar.gz 08:03:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:03:46 INFO - warning: no files found matching '*.txt' 08:03:46 INFO - no previously-included directories found matching 'build' 08:03:46 INFO - no previously-included directories found matching 'dist' 08:03:46 INFO - no previously-included directories found matching '.git*' 08:03:46 INFO - Installing collected packages: jsonschema, functools32 08:03:46 INFO - Running setup.py install for functools32 08:03:47 INFO - warning: no files found matching '*.txt' 08:03:47 INFO - no previously-included directories found matching 'build' 08:03:47 INFO - no previously-included directories found matching 'dist' 08:03:47 INFO - no previously-included directories found matching '.git*' 08:03:47 INFO - Successfully installed jsonschema functools32 08:03:47 INFO - Cleaning up... 08:03:47 INFO - Return code: 0 08:03:47 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:03:47 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:03:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:03:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:03:47 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:03:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:03:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:03:47 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 0x10ddb6490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dd2c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe43ac92f30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dbcad30>, '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 0x10da30db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dbc2b20>, '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.k8sAEIh0YK/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.WfRmT7XbWL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/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:03:47 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:03:47 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:03:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.k8sAEIh0YK/Render', 08:03:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:03:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:03:47 INFO - 'HOME': '/Users/cltbld', 08:03:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:03:47 INFO - 'LOGNAME': 'cltbld', 08:03:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:03:47 INFO - 'MOZ_NO_REMOTE': '1', 08:03:47 INFO - 'NO_EM_RESTART': '1', 08:03:47 INFO - 'PAGER': '/bin/cat', 08:03:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:03:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:03:47 INFO - 'PWD': '/builds/slave/test', 08:03:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:03:47 INFO - 'SHELL': '/bin/bash', 08:03:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WfRmT7XbWL/Listeners', 08:03:47 INFO - 'TMPDIR': '/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/', 08:03:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:03:47 INFO - 'USER': 'cltbld', 08:03:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:03:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:03:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:03:47 INFO - 'XPC_FLAGS': '0x0', 08:03:47 INFO - 'XPC_SERVICE_NAME': '0', 08:03:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:03:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:03:47 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:03:47 INFO - Cleaning up... 08:03:47 INFO - Return code: 0 08:03:47 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:03:47 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:03:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:03:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:03:47 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:03:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:03:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:03:47 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 0x10ddb6490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dd2c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe43ac92f30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dbcad30>, '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 0x10da30db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dbc2b20>, '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.k8sAEIh0YK/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.WfRmT7XbWL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/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:03:47 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:03:47 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:03:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.k8sAEIh0YK/Render', 08:03:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:03:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:03:47 INFO - 'HOME': '/Users/cltbld', 08:03:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:03:47 INFO - 'LOGNAME': 'cltbld', 08:03:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:03:47 INFO - 'MOZ_NO_REMOTE': '1', 08:03:47 INFO - 'NO_EM_RESTART': '1', 08:03:47 INFO - 'PAGER': '/bin/cat', 08:03:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:03:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:03:47 INFO - 'PWD': '/builds/slave/test', 08:03:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:03:47 INFO - 'SHELL': '/bin/bash', 08:03:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WfRmT7XbWL/Listeners', 08:03:47 INFO - 'TMPDIR': '/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/', 08:03:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:03:47 INFO - 'USER': 'cltbld', 08:03:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:03:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:03:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:03:47 INFO - 'XPC_FLAGS': '0x0', 08:03:47 INFO - 'XPC_SERVICE_NAME': '0', 08:03:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:03:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:03:47 INFO - Downloading/unpacking blobuploader==1.2.4 08:03:47 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:03:47 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:03:47 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:03:47 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:03:47 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:03:47 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:03:50 INFO - Downloading blobuploader-1.2.4.tar.gz 08:03:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:03:50 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:03: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:03: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:03: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:03: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:03: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:03: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:03:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:03:51 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:03:51 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:03:51 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:03:51 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:03:51 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:03:51 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:03:51 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:03:51 INFO - Downloading docopt-0.6.1.tar.gz 08:03:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:03:51 INFO - Installing collected packages: blobuploader, requests, docopt 08:03:51 INFO - Running setup.py install for blobuploader 08:03:51 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:03:51 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:03:51 INFO - Running setup.py install for requests 08:03:52 INFO - Running setup.py install for docopt 08:03:52 INFO - Successfully installed blobuploader requests docopt 08:03:52 INFO - Cleaning up... 08:03:52 INFO - Return code: 0 08:03:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:03:52 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:03:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:03:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:03:52 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:03:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:03:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:03:52 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 0x10ddb6490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dd2c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe43ac92f30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dbcad30>, '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 0x10da30db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dbc2b20>, '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.k8sAEIh0YK/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.WfRmT7XbWL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/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:03:52 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:03:52 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:03:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.k8sAEIh0YK/Render', 08:03:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:03:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:03:52 INFO - 'HOME': '/Users/cltbld', 08:03:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:03:52 INFO - 'LOGNAME': 'cltbld', 08:03:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:03:52 INFO - 'MOZ_NO_REMOTE': '1', 08:03:52 INFO - 'NO_EM_RESTART': '1', 08:03:52 INFO - 'PAGER': '/bin/cat', 08:03:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:03:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:03:52 INFO - 'PWD': '/builds/slave/test', 08:03:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:03:52 INFO - 'SHELL': '/bin/bash', 08:03:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WfRmT7XbWL/Listeners', 08:03:52 INFO - 'TMPDIR': '/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/', 08:03:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:03:52 INFO - 'USER': 'cltbld', 08:03:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:03:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:03:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:03:52 INFO - 'XPC_FLAGS': '0x0', 08:03:52 INFO - 'XPC_SERVICE_NAME': '0', 08:03:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:03:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:03:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:03:52 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-6VD_zJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:03:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:03:52 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-Z90oPB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:03:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:03:52 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-mqe5PJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:03:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:03:53 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-UM7CAf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:03:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:03:53 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-70nakO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:03:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:03:53 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-eAl4vr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:03:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:03:53 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-yU2mX4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:03:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:03:53 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-1nYEBa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:03:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:03:53 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-l2eV9U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:03:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:03:53 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-eihaO9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:03:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:03:53 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-bBec6m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:03:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:03:53 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-EBSdvO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:03:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:03:54 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-Z_Wgwc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:03:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:03:54 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-BP_6jQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:03:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:03:54 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-LkGpvb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:03:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:03:54 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-tQvR7T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:03:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:03:54 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-YCtSmg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:03:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:03:54 INFO - Running setup.py install for manifestparser 08:03:54 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:03:54 INFO - Running setup.py install for mozcrash 08:03:54 INFO - Running setup.py install for mozdebug 08:03:54 INFO - Running setup.py install for mozdevice 08:03:55 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:03:55 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:03:55 INFO - Running setup.py install for mozfile 08:03:55 INFO - Running setup.py install for mozhttpd 08:03:55 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:03:55 INFO - Running setup.py install for mozinfo 08:03:55 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:03:55 INFO - Running setup.py install for mozInstall 08:03:55 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:03:55 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:03:55 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:03:55 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:03:55 INFO - Running setup.py install for mozleak 08:03:55 INFO - Running setup.py install for mozlog 08:03:56 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:03:56 INFO - Running setup.py install for moznetwork 08:03:56 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:03:56 INFO - Running setup.py install for mozprocess 08:03:56 INFO - Running setup.py install for mozprofile 08:03:56 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:03:56 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:03:56 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:03:56 INFO - Running setup.py install for mozrunner 08:03:56 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:03:56 INFO - Running setup.py install for mozscreenshot 08:03:56 INFO - Running setup.py install for moztest 08:03:56 INFO - Running setup.py install for mozversion 08:03:57 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:03:57 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:03:57 INFO - Cleaning up... 08:03:57 INFO - Return code: 0 08:03:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:03: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:03:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:03:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:03: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:03:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:03:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:03:57 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 0x10ddb6490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dd2c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe43ac92f30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dbcad30>, '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 0x10da30db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dbc2b20>, '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.k8sAEIh0YK/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.WfRmT7XbWL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/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:03:57 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:03:57 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:03:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.k8sAEIh0YK/Render', 08:03:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:03:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:03:57 INFO - 'HOME': '/Users/cltbld', 08:03:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:03:57 INFO - 'LOGNAME': 'cltbld', 08:03:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:03:57 INFO - 'MOZ_NO_REMOTE': '1', 08:03:57 INFO - 'NO_EM_RESTART': '1', 08:03:57 INFO - 'PAGER': '/bin/cat', 08:03:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:03:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:03:57 INFO - 'PWD': '/builds/slave/test', 08:03:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:03:57 INFO - 'SHELL': '/bin/bash', 08:03:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WfRmT7XbWL/Listeners', 08:03:57 INFO - 'TMPDIR': '/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/', 08:03:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:03:57 INFO - 'USER': 'cltbld', 08:03:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:03:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:03:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:03:57 INFO - 'XPC_FLAGS': '0x0', 08:03:57 INFO - 'XPC_SERVICE_NAME': '0', 08:03:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:03:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:03:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:03:57 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-nk9MiR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:03:57 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:03:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:03:57 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-iqZWKh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:03:57 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:03:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:03:57 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-akMwsl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:03:57 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:03:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:03:57 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-5ODn50-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:03:57 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:03:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:03:57 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-AwcGQe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:03:57 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:03:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:03:57 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-8IHArw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:03:58 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:03:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:03:58 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-bicFQc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:03:58 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:03:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:03:58 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-GMTuRb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:03:58 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:03:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:03:58 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-5DGODF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:03:58 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:03:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:03:58 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-Y1OT4T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:03:58 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:03:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:03:58 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-MCMVTi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:03:58 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:03:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:03:58 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-yKkgs4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:03:58 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:03:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:03:58 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-tKLLyT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:03:58 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:03:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:03:58 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-kJwqFt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:03:58 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:03:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:03:58 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-CNi0_h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:03:58 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:03:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:03:58 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-Pfu8wu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:03:59 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:03:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:03:59 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-qNkiEh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:03:59 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:03:59 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:03:59 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:03:59 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:03:59 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:03:59 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:03:59 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:03:59 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:03:59 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:03:59 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:03:59 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:03:59 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:03:59 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:04:01 INFO - Downloading blessings-1.6.tar.gz 08:04:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:04:01 INFO - Installing collected packages: blessings 08:04:01 INFO - Running setup.py install for blessings 08:04:02 INFO - Successfully installed blessings 08:04:02 INFO - Cleaning up... 08:04:02 INFO - Return code: 0 08:04:02 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:04:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:04:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:04:02 INFO - Reading from file tmpfile_stdout 08:04:02 INFO - Current package versions: 08:04:02 INFO - blessings == 1.6 08:04:02 INFO - blobuploader == 1.2.4 08:04:02 INFO - docopt == 0.6.1 08:04:02 INFO - functools32 == 3.2.3-2 08:04:02 INFO - jsonschema == 2.5.1 08:04:02 INFO - manifestparser == 1.1 08:04:02 INFO - mozInstall == 1.12 08:04:02 INFO - mozcrash == 0.17 08:04:02 INFO - mozdebug == 0.1 08:04:02 INFO - mozdevice == 0.48 08:04:02 INFO - mozfile == 1.2 08:04:02 INFO - mozhttpd == 0.7 08:04:02 INFO - mozinfo == 0.9 08:04:02 INFO - mozleak == 0.1 08:04:02 INFO - mozlog == 3.4 08:04:02 INFO - moznetwork == 0.27 08:04:02 INFO - mozprocess == 0.23 08:04:02 INFO - mozprofile == 0.28 08:04:02 INFO - mozrunner == 6.12 08:04:02 INFO - mozscreenshot == 0.1 08:04:02 INFO - mozsystemmonitor == 0.3 08:04:02 INFO - moztest == 0.7 08:04:02 INFO - mozversion == 1.4 08:04:02 INFO - psutil == 3.1.1 08:04:02 INFO - requests == 1.2.3 08:04:02 INFO - wsgiref == 0.1.2 08:04:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:04: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:04:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:04:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:04: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:04:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:04:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:04:02 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 0x10ddb6490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dd2c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe43ac92f30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dbcad30>, '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 0x10da30db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dbc2b20>, '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.k8sAEIh0YK/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.WfRmT7XbWL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/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:04:02 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:04:02 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:04:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.k8sAEIh0YK/Render', 08:04:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:04:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:04:02 INFO - 'HOME': '/Users/cltbld', 08:04:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:04:02 INFO - 'LOGNAME': 'cltbld', 08:04:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:04:02 INFO - 'MOZ_NO_REMOTE': '1', 08:04:02 INFO - 'NO_EM_RESTART': '1', 08:04:02 INFO - 'PAGER': '/bin/cat', 08:04:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:04:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:04:02 INFO - 'PWD': '/builds/slave/test', 08:04:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:04:02 INFO - 'SHELL': '/bin/bash', 08:04:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WfRmT7XbWL/Listeners', 08:04:02 INFO - 'TMPDIR': '/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/', 08:04:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:04:02 INFO - 'USER': 'cltbld', 08:04:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:04:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:04:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:04:02 INFO - 'XPC_FLAGS': '0x0', 08:04:02 INFO - 'XPC_SERVICE_NAME': '0', 08:04:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:04:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:04:02 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:04:02 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:04:02 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:04:02 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:04:02 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:04:02 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:04:02 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:04:02 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:04:02 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:04:02 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:04:02 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:04:02 INFO - Cleaning up... 08:04:02 INFO - Return code: 0 08:04:02 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:04: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:04:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:04:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:04: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:04:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:04:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:04:02 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 0x10ddb6490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dd2c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe43ac92f30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dbcad30>, '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 0x10da30db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dbc2b20>, '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.k8sAEIh0YK/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.WfRmT7XbWL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/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:04:02 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:04:02 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:04:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.k8sAEIh0YK/Render', 08:04:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:04:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:04:02 INFO - 'HOME': '/Users/cltbld', 08:04:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:04:02 INFO - 'LOGNAME': 'cltbld', 08:04:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:04:02 INFO - 'MOZ_NO_REMOTE': '1', 08:04:02 INFO - 'NO_EM_RESTART': '1', 08:04:02 INFO - 'PAGER': '/bin/cat', 08:04:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:04:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:04:02 INFO - 'PWD': '/builds/slave/test', 08:04:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:04:02 INFO - 'SHELL': '/bin/bash', 08:04:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WfRmT7XbWL/Listeners', 08:04:02 INFO - 'TMPDIR': '/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/', 08:04:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:04:02 INFO - 'USER': 'cltbld', 08:04:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:04:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:04:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:04:02 INFO - 'XPC_FLAGS': '0x0', 08:04:02 INFO - 'XPC_SERVICE_NAME': '0', 08:04:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:04:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:04:02 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:04:02 INFO - Cleaning up... 08:04:02 INFO - Return code: 0 08:04:02 INFO - Running post-action listener: _resource_record_post_action 08:04:02 INFO - Running post-action listener: _start_resource_monitoring 08:04:02 INFO - Starting resource monitoring. 08:04:02 INFO - [mozharness: 2016-12-14 16:04:02.998955Z] Finished create-virtualenv step (success) 08:04:02 INFO - [mozharness: 2016-12-14 16:04:02.999949Z] Running install step. 08:04:03 INFO - Running pre-action listener: _resource_record_pre_action 08:04:03 INFO - Running main action method: install 08:04:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:04:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:04:03 INFO - Reading from file tmpfile_stdout 08:04:03 INFO - Detecting whether we're running mozinstall >=1.0... 08:04:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:04:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:04:03 INFO - Reading from file tmpfile_stdout 08:04:03 INFO - Output received: 08:04:03 INFO - Usage: mozinstall [options] installer 08:04:03 INFO - Options: 08:04:03 INFO - -h, --help show this help message and exit 08:04:03 INFO - -d DEST, --destination=DEST 08:04:03 INFO - Directory to install application into. [default: 08:04:03 INFO - "/builds/slave/test"] 08:04:03 INFO - --app=APP Application being installed. [default: firefox] 08:04:03 INFO - mkdir: /builds/slave/test/build/application 08:04:03 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:04:03 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:04:25 INFO - Reading from file tmpfile_stdout 08:04:25 INFO - Output received: 08:04:25 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 08:04:25 INFO - Running post-action listener: _resource_record_post_action 08:04:25 INFO - [mozharness: 2016-12-14 16:04:25.595897Z] Finished install step (success) 08:04:25 INFO - [mozharness: 2016-12-14 16:04:25.596040Z] Running run-tests step. 08:04:25 INFO - Running pre-action listener: _resource_record_pre_action 08:04:25 INFO - Running main action method: run_tests 08:04:25 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:04:25 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:04:25 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:04:25 INFO - 2016-12-14 08:04:25.610 screenresolution[1624:7301] starting screenresolution argv=screenresolution get 08:04:25 INFO - 2016-12-14 08:04:25.613 screenresolution[1624:7301] Display 0: 1600x1200x32@60 08:04:25 INFO - 2016-12-14 08:04:25.618 screenresolution[1625:7303] starting screenresolution argv=screenresolution list 08:04:25 INFO - Available Modes on Display 0 08:04:25 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:04:25 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:04:25 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:04:25 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:04:25 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:04:25 INFO - Intel Iris: 08:04:25 INFO - Chipset Model: Intel Iris 08:04:25 INFO - Type: GPU 08:04:25 INFO - Bus: Built-In 08:04:25 INFO - VRAM (Dynamic, Max): 1536 MB 08:04:25 INFO - Vendor: Intel (0x8086) 08:04:25 INFO - Device ID: 0x0a2e 08:04:25 INFO - Revision ID: 0x0009 08:04:25 INFO - Displays: 08:04:25 INFO - Display: 08:04:25 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:04:25 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:04:25 INFO - Display Serial Number: 1600x1200 60 08:04:25 INFO - Main Display: Yes 08:04:25 INFO - Mirror: Off 08:04:25 INFO - Online: Yes 08:04:25 INFO - Rotation: Supported 08:04:25 INFO - Return code: 0 08:04:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:04:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:04:25 INFO - Python 2.7.3 08:04:25 INFO - Return code: 0 08:04:25 INFO - grabbing minidump binary from tooltool 08:04:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:04:25 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 0x10dbcad30>, '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 0x10da30db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dbc2b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:04:25 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:04:25 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:04:25 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:04:25 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:04:25 INFO - Return code: 0 08:04:25 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 08:04:25 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:04:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:04:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 08:04:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:04:25 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/Zezw4-f8RR6ywDZ_S_sYLg/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0341', '--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:04:25 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/Zezw4-f8RR6ywDZ_S_sYLg/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0341 --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:04:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.k8sAEIh0YK/Render', 08:04:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:04:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:04:25 INFO - 'HOME': '/Users/cltbld', 08:04:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:04:25 INFO - 'LOGNAME': 'cltbld', 08:04:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:04:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 08:04:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:04:25 INFO - 'MOZ_NO_REMOTE': '1', 08:04:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:04:25 INFO - 'NO_EM_RESTART': '1', 08:04:25 INFO - 'PAGER': '/bin/cat', 08:04:25 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:04:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:04:25 INFO - 'PWD': '/builds/slave/test', 08:04:25 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:04:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:04:25 INFO - 'SHELL': '/bin/bash', 08:04:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WfRmT7XbWL/Listeners', 08:04:25 INFO - 'TMPDIR': '/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/', 08:04:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:04:25 INFO - 'USER': 'cltbld', 08:04:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:04:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:04:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:04:25 INFO - 'XPC_FLAGS': '0x0', 08:04:25 INFO - 'XPC_SERVICE_NAME': '0', 08:04:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:04:25 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/Zezw4-f8RR6ywDZ_S_sYLg/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0341', '--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:04:26 INFO - mozversion application_buildid: 20161214050001 08:04:26 INFO - mozversion application_changeset: ecdf085419775e4c24ae07b32967bc9ebf47b8f1 08:04:26 INFO - mozversion application_display_name: Firefox 08:04:26 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:04:26 INFO - mozversion application_name: Firefox 08:04:26 INFO - mozversion application_remotingname: firefox 08:04:26 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 08:04:26 INFO - mozversion application_vendor: Mozilla 08:04:26 INFO - mozversion application_version: 51.0 08:04:26 INFO - mozversion platform_buildid: 20161214050001 08:04:26 INFO - mozversion platform_changeset: ecdf085419775e4c24ae07b32967bc9ebf47b8f1 08:04:26 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 08:04:26 INFO - mozversion platform_version: 51.0 08:04:26 INFO - using testdate: 1481731466 08:04:26 INFO - actual date: 1481731466 08:04:26 INFO - starting webserver on 'localhost:49243' 08:04:26 INFO - SUITE-START | Running 2 tests 08:04:26 INFO - TEST-START | dromaeo_css 08:04:26 INFO - operating with platform_type : mac_ 08:04:26 INFO - Initialising browser for dromaeo_css test... 08:04:26 INFO - TEST-INFO | started process 1635 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/tmpEpesrH/profile http://localhost:49243/getInfo.html) 08:04:28 INFO - PROCESS | 1635 | __metrics Screen width/height:1600/1200 08:04:28 INFO - PROCESS | 1635 | colorDepth:24 08:04:28 INFO - PROCESS | 1635 | Browser inner width/height: 1024/689 08:04:28 INFO - PROCESS | 1635 | __metrics 08:04:28 INFO - PROCESS | 1635 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:04:28 INFO - PROCESS | 1635 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:04:29 INFO - TEST-INFO | 1635: exit 0 08:04:29 INFO - Browser initialized. 08:04:29 INFO - Running cycle 1/1 for dromaeo_css test... 08:04:29 INFO - TEST-INFO | started process 1639 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/tmpEpesrH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:04:41 INFO - PROCESS | 1639 | RSS: Main: 169168896 08:04:41 INFO - PROCESS | 1639 | 08:05:33 INFO - PROCESS | 1639 | 1481731533020 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:07:43 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49243/tests/dromaeo/cssquery-ext.html) 08:07:44 INFO - PROCESS | 1639 | RSS: Main: 297537536 08:07:44 INFO - PROCESS | 1639 | 08:10:47 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-ext.html (next: http://localhost:49243/tests/dromaeo/cssquery-jquery.html) 08:10:47 INFO - PROCESS | 1639 | RSS: Main: 304259072 08:10:47 INFO - PROCESS | 1639 | 08:13:50 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49243/tests/dromaeo/cssquery-mootools.html) 08:13:50 INFO - PROCESS | 1639 | RSS: Main: 278220800 08:13:50 INFO - PROCESS | 1639 | 08:16:53 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49243/tests/dromaeo/cssquery-prototype.html) 08:16:53 INFO - PROCESS | 1639 | RSS: Main: 273518592 08:16:53 INFO - PROCESS | 1639 | 08:19:56 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49243/tests/dromaeo/cssquery-yui.html) 08:19:57 INFO - PROCESS | 1639 | RSS: Main: 266850304 08:19:57 INFO - PROCESS | 1639 | 08:23:00 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-yui.html (next: http://localhost:49243/tests/dromaeo/cssquery-dojo.html) 08:23:00 INFO - PROCESS | 1639 | RSS: Main: 308830208 08:23:00 INFO - PROCESS | 1639 | 08:23:00 INFO - PROCESS | 1639 | __start_tp_report 08:23:00 INFO - PROCESS | 1639 | _x_x_mozilla_page_load 08:23:00 INFO - PROCESS | 1639 | _x_x_mozilla_page_load_details 08:23:00 INFO - PROCESS | 1639 | |i|pagename|runs| 08:23:00 INFO - PROCESS | 1639 | |0;dojo.html;3452.8273586320684;3473.6700013498717;3499.475078738189;3501.509788629594;3509.1227193201717;5814.302283725953;5866.560007999396;5895.351511333755;5921.111833225018;5936.050231962887;4749.643776716743;5722.914156287659;5836.182934389189;5870.354261031283;5895.882082358361;5252.002119597274;5278.3665960084845;5312.256284120226;5327.813526526573;5349.144136938091;5253.080710875601;5267.894642107156;5374.516293533601;5376;5400.91898621521;5274.525292723654;5321.201819727053;5330.546903513206;5331.2269720890445;5341.572674186055;5260.079486089938;5279.102552566073;5305.124654432014;5305.1776974569;5312.681239125664;5192.55863251624;5298.072837253504;5319.707416092114;5331.44019877915;5359.812406565751;5670.801521946753;5847.707614619295;5865.794697185578;5869.972983596119;6001.129836173774;6202.441780239755;6247.5939063960695;6258.405451482102;6291.370862913672;6297.0554416837385;6365.49076073913;6413.935860641381;6438.645874476902;6441.0982462455295;6464.515161362917;5933.19901813254;5938.524918006636;5940.108983652487;5941.2276404067625;5942.257217847769;6311.526635502264;6380.649064301415;6404.135441715402;6407.711652975628;6412.64730439821;6133.334663918993;6177.444030037318;6209.037599172136;6215.689215539205;6251.499880009588;6364.045393190966;6415.711292991827;6422.775202867877;6435.485161187094;6457.61254324742;6371.96814015927;6377;6378.52161087911;6391.616503009835;6392.584482008655;6157.538184636171;6217.533684973645;6218.844528886814;6242.500599951993;6398.360163983564;5017.899642007213;5070.771815268322;5074;5081.0092032054135;5138.023775482647;4509.842155524541;4548.385967894292;4551.749653769009;4560.931586026212;4592.5407459254475;5732.3407808101765;5740.1102829061565;5780.884382312414;5882.411758824169;5920.79277225295;6318.842028949313;6362.331955144643;6383.106365108889;6416.967915160394;6417.358264173638;5867.941320586825;5872.621588256763;5874.618149820248;5879.735411906475;5911;5414.187871819258;5485.396606373296;5499.120140777456;5511.641743286674;5514.6691198528215;6285.685715714105;6305.936940630627;6317.747290108344;6320.715567799552;6366.7771627993725;6349.269833968968;6376.171097757262;6398.072279519537;6417.326180751141;6430.131932189094;6333.778317758856;6365.840853978688;6381.521385895983;6382.648954307372;6391.32891046452;6149.385061493815;6211.223597050369;6252.718627661857;6307.7476900925285;6316.526260530571;6405.295417504164;6424.550281480251;6430.3891130342545;6436.259830119596;6445.967770161119;6250.468710159687;6287.056941458635;6288.65412402304;6290.748370065146;6308.589941653778;5302.575793936553;5999.70001499932;6136.120845438929;6136.171616831849;6155.415235552616;6055.1220073090035;6178.474829639531;6179.660118693335;6181.412765787243;6192.659403732838;5952.613080149949;6261.906071409024;6273.121762953281;6285.057241413824;6288.496920246461;5923.526117910643;5933.199018132497;5974.9402505974385;5980.581359304807;6040.395960403925 08:23:00 INFO - PROCESS | 1639 | |1;ext.html;503.9445660977293;508.7863097499048;509.5083244668894;539.3393093460509;581.3169525807175;32169.678303216962;34022.31955360894;43552.128957420835;43600.3459948101;45825.541744582544;44667.77666111665;44974.32538511917;45093.323600145945;45185.32222016664;45195.77402112985;9337.626494940194;10127.645532406368;10313.484325783718;10318;10326.07065364117;9332.953335233315;9511.09644583767;9522.80954380912;9532.14210721035;11952.94023529881;10714.785704285949;12463;12621.55824546141;12624.99000079996;12628.242305461701;12519.561815336465;12575.245485270867;12576.119671622899;12585.874141258653;12603.306818125;12277.079219058607;12370.567030153901;12375.319357435337;12403.317817520032;12409.441575129142;41693.583064169274;41851.1629767406;41899.7905010476;41956.58043419557;42047.789761051;3422.7946323220685;3500.2474467989505;3546.8758593449106;3712.4988126602834;4014.558398576154;32866.6713332866;33215.83392083024;33315.66737330504;33502.83248583766;33582.49626255608;3370.8314584270934;3379.5944486661756;3452.2922800825772;3523.4186359250693;3525.858965641397;495826;496881;498734;499074;499605;64895;65310;65355.01967470492;65424.672876636265;65433.34566654272;35622;36203.4569481458;36403.817980909924;37762.244755104744;37827.243455130745;18017.369392071476;18200.1809918554;18201.45395638133;18236.088195590168;18263.72604410935;13777.448902044007;13892.888568914463;13899.374528146258;13903.443862245396;13925.930370348286;18078.00570968583;18422.81577184211;20136.899315503328;20527.692084618742;20972.47568810792;7097.503174777819;7442.925570744332;8360.163983601713;8412.411131220755;8541.09602735073;890.8530092534788;1013.1793247469574;1024.5235965276183;1027.8766548014137;1158;32101;32118.678813212035;32225;32435.02694919156;32691;1062.7565748074771;1107.1309022417524;1151.5739176504746;1191.7497325561555;1216.92698438094;14351.928240358731;15815.762763558556;16743.33026678919;16840.578985525215;17111;645297;870037;887631;889115;890742;62983.370166298664;63631.681841591424;63795;63886;64074.35925640777;1296.5591698822445;1337.4583293766234;1395.7696979998593;1434.619825746178;1460.0874453466583;27115.86442067777;31793.841030794698;33265.50101748524;33302.16744581308;33598;47158.05683886372;52895.735521322145;53636.927261455334;53723.925521490135;53756.731216343665;560324;560895;565598.3440165545;567271;572024;20860.37418877436;25821.483570328863;27782.44435111327;27855.303617409725;28777.56833647455;49384.25923611077;49800;49832.75418114576;50276;50357.24464132968;39833.60166398299;41463;41543.37684934668;41620.375694364004;42655;34997.300053999286;35362.46956295709;40475.98810029773;40559.1888162241;41987.580124198365;39682.80158599189;40260;40410.1917961645;40537.59462405338;40922;34755.82622086874;36051.189030637135;36382;36468;36547.26905461929;22526.66210006884;24140.758592414553;26933.3266668327;26950.326241843326;26952.460950781267 08:23:00 INFO - PROCESS | 1639 | |2;jquery.html;318.6128853443067;391.4988814317674;393.9724219304648;403.56818204521136;417.8182490616582;20094.899525502387;21790.782092179074;22367.217147399846;22660.886695566518;22875.542489150208;20379.18483260668;21010.36968890932;21256.78743212571;21470.785292147073;21928.561428771456;5250.842474725764;5501.779928802843;5572.136318870582;5572.359178694442;5575.609707320489;4084.4077608746716;4180.644645205161;5526.171074338841;5611.326640803089;5626.240457538242;4176.749395036308;4234.724742891717;6840;6908.309169083077;6918.65406729664;6135.355787642278;6202.13170156174;6878.690458929335;6889.104416425883;6895.655217239118;6056.485198758067;6063.99944009238;6064.363241859585;6071.241094863142;6073.665948372838;13840.377183026789;25004.749952500424;25561.488770224492;26086.73913260862;26610.33474163142;2143.90968805415;2263.1400067974228;2346.1319311854554;2567.2169988153605;2709.986450067757;9125.361224714272;10188.032136946978;10959.671209863716;11161.888381116247;16666.6666666666;1880.454668146236;1888.424030670645;1954.84361251101;1969.5470041890446;1996.5707372914749;90789.54605226997;96568;124505;136650.3167484166;137752.62247377398;10831.404272764916;11206.327620342805;11391.715207119889;11531.019863311712;11982.940085299517;15215.695686086437;15229.010114342533;15234.771478427832;15244.009139406126;15277.6180595486;7669.808254793563;8765.254953329038;9022.729318120468;9056.547172641473;9150.398680230934;7670.7698769037015;8972.730818075468;9095.135962083592;9097.681581144629;9249.90750092504;4519.570640789119;4606.286025666027;4610.1471227822285;4675.625949923998;4697.976510117427;1533.9386424542893;1714.996726914744;1720.6816738903342;1947.269773834812;1972.6054789042248;806.5725165662209;937.5827756648226;987.4865070163474;1043.0508237503834;1076.7361996310954;20866.895665521577;22006.779932200792;22113.447163821034;22136.778632213794;22185;978.2711879649706;990.8662330585423;996.7856910764076;1007.8740157480315;1043.6295115234134;11171.553137874556;11572.826407603892;11668.008219301284;11681;11682.532698691957;493030;582873;614000;627267;627415;132029;135699.64300357067;135722;137193;138494.61505384816;1013.8783345998528;1044.6448207609296;1058.269793842231;1059.2108878885126;1061.9044286014296;18176.909385436917;18538.351157709956;19386.709199362303;19828.50428739293;19945.301914432926;41011.179776404904;46075;56870;58379.70810145922;58725.706371467866;87102;88812;89696.551517242;89776.10223897677;90487.09512904787;8046.517208967481;8492.598721211178;8559.101294364002;8559.400841941253;8727.083656216006;9671.468069256258;13389.464421423034;13449.731005379643;13609.455621775414;13609.591712248648;11616.709582260512;11858.584949526725;11917.821232681343;11923.880761192277;11929;10264.332818366782;10547.734271887422;11184.328940263611;11503;11522.942385288019;11780.70548236301;11826.231294965799;11941.283522988648;11968.581099661471;12105.81841272364;8265.669373225004;8479.109693482342;8522.806807046894;8721.084286150117;8726.345524085846;11275.718107047389;11448.599299024494;11494.195406321478;11872.109591780823;11985.880141198477 08:23:00 INFO - PROCESS | 1639 | |3;mootools.html;1394.532831501447;1458.5770126663267;1538.3692685998735;1770.4600096970419;1966.2921348314603;8088.191180881909;8650.264727498163;8866.335024873128;9097.181253687168;9114.863277050834;9001.774955626113;9073;9076.818463630723;9086.409383390092;9112.90887091129;2404.0263693204192;2436.6466862304956;2439.0731522021606;2440.9633855492184;2441.865697386643;2406.0255596483453;2422.200673777649;2449.5468338357373;2450.6936632920883;2454.460018795862;2394.38943069517;2410.301012706313;2420.770026847447;2422.9394265143424;2424.7211570669333;2388.988055059731;2400.867952262625;2411.987940060306;2412.5174965006895;2428.9757102428925;2395.6765836612185;2409.72288186859;2439.329184474266;2444.8166387521005;2450.1669432392896;8869.600867960893;9055.592498337524;9175.816483670289;9181;9198.98811130775;5382.2464854920345;5605.159226116074;5607.130894711327;5610.102383618642;5627.2684551008515;3643.6902863256655;3672.797996110213;3684.152644891663;3761.9435708464393;3764.3788774852114;1032.4889179855945;1042.5725452564488;1043.504335440667;1055.37205362809;1070.550368845087;11696;11774.587889423829;11800.114991375596;11834.349110798816;11850.46672899713;4514.277715565559;4553.408056952575;4726.8109275628585;4735.431748190239;4739.218029025173;9336.906630933603;9342;9351.018143095012;9361.251099911991;9384.06159384056;5382;5382.950324686649;5388.8113916013535;5389.865253368619;5398.838034858961;4614.97692511542;4744.786484608132;4926.162552366106;5034.295198672189;5035.144025515671;3892.0853599404118;3908.1402091539817;3991.481107456012;4022.0950286185375;4027.556968733437;1193.886580774825;1207.14292852076;1208.6494916474123;1216.1122380662166;1218.8476440444945;892.1702816380698;915.2997956563235;932.072587775168;935.209747763139;968.8062387522524;5898.439648233411;5939.703014849327;5990.400959903975;6148.44663980244;6346.01636746305;439.73396095362483;451.8915460289507;985.9950700246453;1072.860528131338;1073.1200415659084;4064.9796751016056;4090.9386359204636;4105.3020986432375;4209.536950935456;4231.984323762336;10782.245242833083;11006.944965275123;11122.388268645302;11125.610603628835;11155.609553665583;9251.44491330509;10886.237963342648;10888.29226100301;11061.115110791117;11221.438928053727;8323.209295116954;8368.874466883002;8495.660173592987;8523.573821309034;8528;5998.70006499682;6035.78874739382;6063.787767428119;6159.168512250789;6184.907226391518;10060.849087263843;10108.49457527106;10265.332753371007;10373.429461379395;10463.843042354218;10377.533011014371;10534.473276335999;10550.103241224582;10681.732956676145;10702;7174.067371241706;7366.484346095722;7454.850902982019;7553.357964573072;7684.884726729216;8547.57262136903;8609.880715507195;8618.181272779077;8760.4305720128;8760.956195218983;7680.769576912701;7819.296263336327;7837.333826624573;7963.601819908866;7985.5208687478935;7597.012388389695;7631.618419078913;7736.419768517271;7747.535147891144;7762.689492420466;6037.426444487766;7010.509264351446;7137.357637812622;7138.39323657495;7158.892616610651;4866.732329721899;4966.031623833318;5066;5067.2652465391575;5362.678239305654;4888.169011268022;4921.2864134700985;4970.701757894538;4997.650164488451;5022.045811295842 08:23:00 INFO - PROCESS | 1639 | |4;prototype.html;281.4427433681311;315.4668610049017;317.6712102973422;323.37427078602906;325.890826573098;4761.642876784238;5436.782528698852;5448.37343705474;5448.809291674792;5455.072637651599;4996.925046124302;5192.8701782455455;5355.839324820262;5366.758495867685;5414.810481633143;3113.5641010258523;3209;3588.3361578108;4114.19773144237;4131.607497287753;4102.692298077641;4112.568180341066;4122.093139509303;4145.958540414603;4185.707000509966;3549.189913144302;3553.662402071812;4106.9794651026705;4113.773742444165;4142.286802144585;3913.452116703678;4138.79306034697;4157.230912281238;4161.834686287844;4165.354370072613;2689.367998520346;3161.3835302116095;3396.1509622594353;3594.903554415902;3618.3486972344967;4254.680898932593;4392.626626736699;5224.843254702365;5245;5245.449227831099;4100.425940368351;4115.9176816463805;4333.285007973681;4370.841726942363;4758.382150068993;4910.582600478963;5423.620346575742;5500.6424582402415;5639.295088113986;5670.432956704338;3873.1021799318414;3877.5346958364894;3897.902552436212;3911.432842237888;3933.9968308081257;4826.1795494765975;4867.51324867514;5473.507384335389;5967.761289548413;6048.304444988838;3814.6757525610633;3859.3246181918053;3874.2057878134915;3881.389223472284;3886.2227554489214;3297.7856439331367;3443.483477478348;3809.8666546670734;3887.552931412867;4014.5383280922483;3975.8608448704736;4542.523035081335;4550.29470432077;4568.817247310137;4611.815527378934;4572.428446444194;4642.419697537808;5285.229448134841;5525;5608.439156084441;1134.3080720760329;1353.8849197818295;1356.4845358763607;1358.2733237717773;1361.4418088583832;758.9678037868495;818.9353840008084;841.2134654098315;842.2924743215606;842.6223125190236;4640.466346370211;5095.363079615048;5187.870303242449;5348.331458567679;5391.002664507;5276.28520730764;5754.856128596819;5765.336986246635;5822.417758224228;5837.6941108262845;4121.62905338521;4646.79089440976;5343.919841202385;5390.353157621033;5391.81128660495;2747.2582402751145;3055.358374741285;3055.5263934090253;3055.92360190997;3062;4988.650794444354;5372.140457526777;5736.483716465538;6061.6666083365835;6071.358958852913;5299.49654782795;5944.910826337608;5952.226210592596;5973.1936188614845;6019.006863867413;5349.9300139972165;5553.916691249554;5948.899453601098;6005.798840231883;6038.365971573009;4989.426215985208;5369.838904832861;5482.917756233739;5504.724763761876;5805.680687562224;5020.623453240948;5164.948350516597;5519.813240153226;5794.797182098607;5847.766089356378;5555.722213889208;6093.07532384449;6121.602095863755;6126;6129.632222066691;3543.344481270973;3562.786232826039;3605.8016809075752;3928.980355098206;4119.805256475588;5813.854653633693;5831.825045248649;5842.766289348378;5848.707564621837;5864.237649105589;5707.743151558107;5714.057220545034;5719.256496655408;5749.8275051748515;5772;5335.2263921730355;5339.3058902342445;5553.916691249715;5684.77260909559;5727.255456790591;4880.780364883518;5402.783888644411;5421.045530186137;5614.943850561605;5653.180288858175;5442.482964118402;5589.301337332833;5636.549076073986;5662.754194077296;5724.570657200643;4850.175470170009;5529.778808847601;5573.832785016456;5587.804426845203;5613.971930140487 08:23:00 INFO - PROCESS | 1639 | |5;yui.html;726.9563826170427;776.1850057439686;784.8234147316855;800.6597196191619;861.9310455163587;14027.859721402783;15773.842261577382;17024.744628830576;17055.061971591556;17146.48560543184;15149.394024239018;15281.388744450236;15282.617934551641;15294.847051529481;15304.081755094674;723.884178531435;744.2483092077014;889.0398369760643;892.6652505310509;913.968011119611;900.0819164452255;906.3564868943058;914.8902131744167;915.3958387464274;916.4776077635751;970.9174270688167;971.0241207586366;973.2019743810079;973.4645944730405;974.6296407365227;964.2767924056957;964.8745663063827;964.9517524123801;967.0764419978904;969.1616751509964;717.1967396515884;717.6555253478307;720.9531380460253;721.1922646635749;724.2142275630947;15150.696986060328;15208;15219.315130819139;15225.238738063052;15228.619284517865;11874.703132421671;14149.292535373294;14746.447060704766;14910.552683419515;14997.850021499864;12067.698307542294;12226.266424014588;12774.808377874338;12826.551070712574;13448.798268025987;3939.527256729211;3991.201759648082;4055.6755459563165;4064.268431682296;4101.610347017028;118180.40909795482;119240.21139682912;119377;121061.39469302597;121480.78519214872;11348.432578371214;11797.233179843282;11816.350100744541;11930.284182949052;11935.701607459883;24659.136930207715;25210;25581.744182557937;25626.23121306364;25691;8580.613872375758;8659.653613855502;8712.433691810013;8728.738137855875;8807.691730789391;4048.514178298623;4593.150267200579;4673.322368256584;4814.325994360793;4863.221884498534;3726.366517691999;3848.634379733921;3849.4225866119746;3851.8459261629223;3863.671587915059;690.547691262214;691.5366704308126;698.068079114388;699.8845190543503;724.6231959381198;612.745710530125;634.3941535833268;635.8982562789931;657.8815813153583;716.716896825751;9395;9874.358166719141;9916.305858589829;9968.40189588627;10041.497925103715;629.9857229859922;655.8393193667487;715.8067321823079;731.129955353128;732.6593134192626;4492.618127459203;4783.928241076386;4784;4794.880127996758;4811.855644330606;100865;147126.7930981036;167625;168345;169809;140003;146414.26792865968;147517;149120.25439872732;151239;122521;125365;127089.36455317664;128108.99999999814;129973.35013325061;8759.474431533874;9167.193717225213;9245.167934885892;9248.121428464285;9328.906710932804;63891.04163437645;67140.32859671341;67670;68572.657136714;69530.60938781095;95706.56440153542;103492;106331.93668063529;106963.4651826736;106992.46503767431;12618.053645976772;12643.747125057263;12674.556390526288;12752.936235319135;12937.159084659466;13405.66485837862;13736.244506552235;14053.789193162314;14065.718685626434;14109.153450792985;12043.09676774228;12346.777580035321;12365.639779624054;12460.87539124597;12475.93762031184;12088.274703517465;12670.493180273055;12734.490620375082;12755.808662869878;13367.532136375181;11941.820872686743;12410.875891240972;12489.875101248872;12548.623541293775;12702.428390722254;8853.291736660924;10743.301685390425;10905;11275.943620281847;11286.379249141048;10915.72215790227;10980.396078215455;11039.227254092137;11191.832122518332;11203.60787372438 08:23:00 INFO - PROCESS | 1639 | __end_tp_report 08:23:00 INFO - PROCESS | 1639 | __start_cc_report 08:23:00 INFO - PROCESS | 1639 | _x_x_mozilla_cycle_collect,1160 08:23:00 INFO - PROCESS | 1639 | __end_cc_report 08:23:00 INFO - PROCESS | 1639 | __startTimestamp1481732580621__endTimestamp 08:23:00 INFO - PROCESS | 1639 | 08:23:00 INFO - PROCESS | 1639 | ------- Summary: start ------- 08:23:00 INFO - PROCESS | 1639 | Number of tests: 6 08:23:00 INFO - PROCESS | 1639 | 08:23:00 INFO - PROCESS | 1639 | [#0] dojo.html Cycles:165 Average:5853.38 Median:6040.40 stddev:643.00 (10.6%) stddev-sans-first:616.78 08:23:00 INFO - PROCESS | 1639 | Values: 3452.8 3473.7 3499.5 3501.5 3509.1 5814.3 5866.6 5895.4 5921.1 5936.1 4749.6 5722.9 5836.2 5870.4 5895.9 5252.0 5278.4 5312.3 5327.8 5349.1 5253.1 5267.9 5374.5 5376.0 5400.9 5274.5 5321.2 5330.5 5331.2 5341.6 5260.1 5279.1 5305.1 5305.2 5312.7 5192.6 5298.1 5319.7 5331.4 5359.8 5670.8 5847.7 5865.8 5870.0 6001.1 6202.4 6247.6 6258.4 6291.4 6297.1 6365.5 6413.9 6438.6 6441.1 6464.5 5933.2 5938.5 5940.1 5941.2 5942.3 6311.5 6380.6 6404.1 6407.7 6412.6 6133.3 6177.4 6209.0 6215.7 6251.5 6364.0 6415.7 6422.8 6435.5 6457.6 6372.0 6377.0 6378.5 6391.6 6392.6 6157.5 6217.5 6218.8 6242.5 6398.4 5017.9 5070.8 5074.0 5081.0 5138.0 4509.8 4548.4 4551.7 4560.9 4592.5 5732.3 5740.1 5780.9 5882.4 5920.8 6318.8 6362.3 6383.1 6417.0 6417.4 5867.9 5872.6 5874.6 5879.7 5911.0 5414.2 5485.4 5499.1 5511.6 5514.7 6285.7 6305.9 6317.7 6320.7 6366.8 6349.3 6376.2 6398.1 6417.3 6430.1 6333.8 6365.8 6381.5 6382.6 6391.3 6149.4 6211.2 6252.7 6307.7 6316.5 6405.3 6424.6 6430.4 6436.3 6446.0 6250.5 6287.1 6288.7 6290.7 6308.6 5302.6 5999.7 6136.1 6136.2 6155.4 6055.1 6178.5 6179.7 6181.4 6192.7 5952.6 6261.9 6273.1 6285.1 6288.5 5923.5 5933.2 5974.9 5980.6 6040.4 08:23:00 INFO - PROCESS | 1639 | 08:23:00 INFO - PROCESS | 1639 | [#1] ext.html Cycles:180 Average:76230.67 Median:19454.67 stddev:175309.98 (901.1%) stddev-sans-first:175709.57 08:23:00 INFO - PROCESS | 1639 | Values: 503.9 508.8 509.5 539.3 581.3 32169.7 34022.3 43552.1 43600.3 45825.5 44667.8 44974.3 45093.3 45185.3 45195.8 9337.6 10127.6 10313.5 10318.0 10326.1 9333.0 9511.1 9522.8 9532.1 11952.9 10714.8 12463.0 12621.6 12625.0 12628.2 12519.6 12575.2 12576.1 12585.9 12603.3 12277.1 12370.6 12375.3 12403.3 12409.4 41693.6 41851.2 41899.8 41956.6 42047.8 3422.8 3500.2 3546.9 3712.5 4014.6 32866.7 33215.8 33315.7 33502.8 33582.5 3370.8 3379.6 3452.3 3523.4 3525.9 495826.0 496881.0 498734.0 499074.0 499605.0 64895.0 65310.0 65355.0 65424.7 65433.3 35622.0 36203.5 36403.8 37762.2 37827.2 18017.4 18200.2 18201.5 18236.1 18263.7 13777.4 13892.9 13899.4 13903.4 13925.9 18078.0 18422.8 20136.9 20527.7 20972.5 7097.5 7442.9 8360.2 8412.4 8541.1 890.9 1013.2 1024.5 1027.9 1158.0 32101.0 32118.7 32225.0 32435.0 32691.0 1062.8 1107.1 1151.6 1191.7 1216.9 14351.9 15815.8 16743.3 16840.6 17111.0 645297.0 870037.0 887631.0 889115.0 890742.0 62983.4 63631.7 63795.0 63886.0 64074.4 1296.6 1337.5 1395.8 1434.6 1460.1 27115.9 31793.8 33265.5 33302.2 33598.0 47158.1 52895.7 53636.9 53723.9 53756.7 560324.0 560895.0 565598.3 567271.0 572024.0 20860.4 25821.5 27782.4 27855.3 28777.6 49384.3 49800.0 49832.8 50276.0 50357.2 39833.6 41463.0 41543.4 41620.4 42655.0 34997.3 35362.5 40476.0 40559.2 41987.6 39682.8 40260.0 40410.2 40537.6 40922.0 34755.8 36051.2 36382.0 36468.0 36547.3 22526.7 24140.8 26933.3 26950.3 26952.5 08:23:00 INFO - PROCESS | 1639 | 08:23:00 INFO - PROCESS | 1639 | [#2] jquery.html Cycles:180 Average:35490.44 Median:12462.01 stddev:99098.30 (795.2%) stddev-sans-first:99341.11 08:23:00 INFO - PROCESS | 1639 | Values: 318.6 391.5 394.0 403.6 417.8 20094.9 21790.8 22367.2 22660.9 22875.5 20379.2 21010.4 21256.8 21470.8 21928.6 5250.8 5501.8 5572.1 5572.4 5575.6 4084.4 4180.6 5526.2 5611.3 5626.2 4176.7 4234.7 6840.0 6908.3 6918.7 6135.4 6202.1 6878.7 6889.1 6895.7 6056.5 6064.0 6064.4 6071.2 6073.7 13840.4 25004.7 25561.5 26086.7 26610.3 2143.9 2263.1 2346.1 2567.2 2710.0 9125.4 10188.0 10959.7 11161.9 16666.7 1880.5 1888.4 1954.8 1969.5 1996.6 90789.5 96568.0 124505.0 136650.3 137752.6 10831.4 11206.3 11391.7 11531.0 11982.9 15215.7 15229.0 15234.8 15244.0 15277.6 7669.8 8765.3 9022.7 9056.5 9150.4 7670.8 8972.7 9095.1 9097.7 9249.9 4519.6 4606.3 4610.1 4675.6 4698.0 1533.9 1715.0 1720.7 1947.3 1972.6 806.6 937.6 987.5 1043.1 1076.7 20866.9 22006.8 22113.4 22136.8 22185.0 978.3 990.9 996.8 1007.9 1043.6 11171.6 11572.8 11668.0 11681.0 11682.5 493030.0 582873.0 614000.0 627267.0 627415.0 132029.0 135699.6 135722.0 137193.0 138494.6 1013.9 1044.6 1058.3 1059.2 1061.9 18176.9 18538.4 19386.7 19828.5 19945.3 41011.2 46075.0 56870.0 58379.7 58725.7 87102.0 88812.0 89696.6 89776.1 90487.1 8046.5 8492.6 8559.1 8559.4 8727.1 9671.5 13389.5 13449.7 13609.5 13609.6 11616.7 11858.6 11917.8 11923.9 11929.0 10264.3 10547.7 11184.3 11503.0 11522.9 11780.7 11826.2 11941.3 11968.6 12105.8 8265.7 8479.1 8522.8 8721.1 8726.3 11275.7 11448.6 11494.2 11872.1 11985.9 08:23:00 INFO - PROCESS | 1639 | 08:23:00 INFO - PROCESS | 1639 | [#3] mootools.html Cycles:180 Average:5828.13 Median:4877.45 stddev:3265.30 (66.9%) stddev-sans-first:3257.45 08:23:00 INFO - PROCESS | 1639 | Values: 1394.5 1458.6 1538.4 1770.5 1966.3 8088.2 8650.3 8866.3 9097.2 9114.9 9001.8 9073.0 9076.8 9086.4 9112.9 2404.0 2436.6 2439.1 2441.0 2441.9 2406.0 2422.2 2449.5 2450.7 2454.5 2394.4 2410.3 2420.8 2422.9 2424.7 2389.0 2400.9 2412.0 2412.5 2429.0 2395.7 2409.7 2439.3 2444.8 2450.2 8869.6 9055.6 9175.8 9181.0 9199.0 5382.2 5605.2 5607.1 5610.1 5627.3 3643.7 3672.8 3684.2 3761.9 3764.4 1032.5 1042.6 1043.5 1055.4 1070.6 11696.0 11774.6 11800.1 11834.3 11850.5 4514.3 4553.4 4726.8 4735.4 4739.2 9336.9 9342.0 9351.0 9361.3 9384.1 5382.0 5383.0 5388.8 5389.9 5398.8 4615.0 4744.8 4926.2 5034.3 5035.1 3892.1 3908.1 3991.5 4022.1 4027.6 1193.9 1207.1 1208.6 1216.1 1218.8 892.2 915.3 932.1 935.2 968.8 5898.4 5939.7 5990.4 6148.4 6346.0 439.7 451.9 986.0 1072.9 1073.1 4065.0 4090.9 4105.3 4209.5 4232.0 10782.2 11006.9 11122.4 11125.6 11155.6 9251.4 10886.2 10888.3 11061.1 11221.4 8323.2 8368.9 8495.7 8523.6 8528.0 5998.7 6035.8 6063.8 6159.2 6184.9 10060.8 10108.5 10265.3 10373.4 10463.8 10377.5 10534.5 10550.1 10681.7 10702.0 7174.1 7366.5 7454.9 7553.4 7684.9 8547.6 8609.9 8618.2 8760.4 8761.0 7680.8 7819.3 7837.3 7963.6 7985.5 7597.0 7631.6 7736.4 7747.5 7762.7 6037.4 7010.5 7137.4 7138.4 7158.9 4866.7 4966.0 5066.0 5067.3 5362.7 4888.2 4921.3 4970.7 4997.7 5022.0 08:23:00 INFO - PROCESS | 1639 | 08:23:00 INFO - PROCESS | 1639 | [#4] prototype.html Cycles:180 Average:4539.98 Median:5208.86 stddev:1424.00 (27.3%) stddev-sans-first:1391.65 08:23:00 INFO - PROCESS | 1639 | Values: 281.4 315.5 317.7 323.4 325.9 4761.6 5436.8 5448.4 5448.8 5455.1 4996.9 5192.9 5355.8 5366.8 5414.8 3113.6 3209.0 3588.3 4114.2 4131.6 4102.7 4112.6 4122.1 4146.0 4185.7 3549.2 3553.7 4107.0 4113.8 4142.3 3913.5 4138.8 4157.2 4161.8 4165.4 2689.4 3161.4 3396.2 3594.9 3618.3 4254.7 4392.6 5224.8 5245.0 5245.4 4100.4 4115.9 4333.3 4370.8 4758.4 4910.6 5423.6 5500.6 5639.3 5670.4 3873.1 3877.5 3897.9 3911.4 3934.0 4826.2 4867.5 5473.5 5967.8 6048.3 3814.7 3859.3 3874.2 3881.4 3886.2 3297.8 3443.5 3809.9 3887.6 4014.5 3975.9 4542.5 4550.3 4568.8 4611.8 4572.4 4642.4 5285.2 5525.0 5608.4 1134.3 1353.9 1356.5 1358.3 1361.4 759.0 818.9 841.2 842.3 842.6 4640.5 5095.4 5187.9 5348.3 5391.0 5276.3 5754.9 5765.3 5822.4 5837.7 4121.6 4646.8 5343.9 5390.4 5391.8 2747.3 3055.4 3055.5 3055.9 3062.0 4988.7 5372.1 5736.5 6061.7 6071.4 5299.5 5944.9 5952.2 5973.2 6019.0 5349.9 5553.9 5948.9 6005.8 6038.4 4989.4 5369.8 5482.9 5504.7 5805.7 5020.6 5164.9 5519.8 5794.8 5847.8 5555.7 6093.1 6121.6 6126.0 6129.6 3543.3 3562.8 3605.8 3929.0 4119.8 5813.9 5831.8 5842.8 5848.7 5864.2 5707.7 5714.1 5719.3 5749.8 5772.0 5335.2 5339.3 5553.9 5684.8 5727.3 4880.8 5402.8 5421.0 5614.9 5653.2 5442.5 5589.3 5636.5 5662.8 5724.6 4850.2 5529.8 5573.8 5587.8 5614.0 08:23:00 INFO - PROCESS | 1639 | 08:23:00 INFO - PROCESS | 1639 | [#5] yui.html Cycles:180 Average:26772.86 Median:25395.87 stddev:43654.51 (171.9%) stddev-sans-first:43733.16 08:23:00 INFO - PROCESS | 1639 | Values: 727.0 776.2 784.8 800.7 861.9 14027.9 15773.8 17024.7 17055.1 17146.5 15149.4 15281.4 15282.6 15294.8 15304.1 723.9 744.2 889.0 892.7 914.0 900.1 906.4 914.9 915.4 916.5 970.9 971.0 973.2 973.5 974.6 964.3 964.9 965.0 967.1 969.2 717.2 717.7 721.0 721.2 724.2 15150.7 15208.0 15219.3 15225.2 15228.6 11874.7 14149.3 14746.4 14910.6 14997.9 12067.7 12226.3 12774.8 12826.6 13448.8 3939.5 3991.2 4055.7 4064.3 4101.6 118180.4 119240.2 119377.0 121061.4 121480.8 11348.4 11797.2 11816.4 11930.3 11935.7 24659.1 25210.0 25581.7 25626.2 25691.0 8580.6 8659.7 8712.4 8728.7 8807.7 4048.5 4593.2 4673.3 4814.3 4863.2 3726.4 3848.6 3849.4 3851.8 3863.7 690.5 691.5 698.1 699.9 724.6 612.7 634.4 635.9 657.9 716.7 9395.0 9874.4 9916.3 9968.4 10041.5 630.0 655.8 715.8 731.1 732.7 4492.6 4783.9 4784.0 4794.9 4811.9 100865.0 147126.8 167625.0 168345.0 169809.0 140003.0 146414.3 147517.0 149120.3 151239.0 122521.0 125365.0 127089.4 128109.0 129973.4 8759.5 9167.2 9245.2 9248.1 9328.9 63891.0 67140.3 67670.0 68572.7 69530.6 95706.6 103492.0 106331.9 106963.5 106992.5 12618.1 12643.7 12674.6 12752.9 12937.2 13405.7 13736.2 14053.8 14065.7 14109.2 12043.1 12346.8 12365.6 12460.9 12475.9 12088.3 12670.5 12734.5 12755.8 13367.5 11941.8 12410.9 12489.9 12548.6 12702.4 8853.3 10743.3 10905.0 11275.9 11286.4 10915.7 10980.4 11039.2 11191.8 11203.6 08:23:00 INFO - PROCESS | 1639 | -------- Summary: end -------- 08:23:00 INFO - PROCESS | 1639 | 08:23:01 INFO - TEST-INFO | 1639: exit 0 08:23:01 INFO - TEST-OK | dromaeo_css | took 1115009ms 08:23:01 INFO - TEST-START | kraken 08:23:01 INFO - operating with platform_type : mac_ 08:23:01 INFO - Initialising browser for kraken test... 08:23:01 INFO - TEST-INFO | started process 1649 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/tmpC2nVR1/profile http://localhost:49243/getInfo.html) 08:23:03 INFO - PROCESS | 1649 | __metrics Screen width/height:1600/1200 08:23:03 INFO - PROCESS | 1649 | colorDepth:24 08:23:03 INFO - PROCESS | 1649 | Browser inner width/height: 1024/689 08:23:03 INFO - PROCESS | 1649 | __metrics 08:23:03 INFO - PROCESS | 1649 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:23:03 INFO - PROCESS | 1649 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:23:04 INFO - TEST-INFO | 1649: exit 0 08:23:04 INFO - Browser initialized. 08:23:04 INFO - Running cycle 1/1 for kraken test... 08:23:04 INFO - TEST-INFO | started process 1651 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/tmpC2nVR1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:23:16 INFO - PROCESS | 1651 | RSS: Main: 168951808 08:23:16 INFO - PROCESS | 1651 | 08:23:18 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-beat-detection) 08:23:19 INFO - PROCESS | 1651 | RSS: Main: 218759168 08:23:19 INFO - PROCESS | 1651 | 08:23:22 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-dft) 08:23:22 INFO - PROCESS | 1651 | RSS: Main: 232267776 08:23:22 INFO - PROCESS | 1651 | 08:23:25 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-fft) 08:23:26 INFO - PROCESS | 1651 | RSS: Main: 329850880 08:23:26 INFO - PROCESS | 1651 | 08:23:28 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-oscillator) 08:23:29 INFO - PROCESS | 1651 | RSS: Main: 227147776 08:23:29 INFO - PROCESS | 1651 | 08:23:31 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:23:31 INFO - PROCESS | 1651 | RSS: Main: 227635200 08:23:31 INFO - PROCESS | 1651 | 08:23:34 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-darkroom) 08:23:35 INFO - PROCESS | 1651 | RSS: Main: 265179136 08:23:35 INFO - PROCESS | 1651 | 08:23:37 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-desaturate) 08:23:38 INFO - PROCESS | 1651 | RSS: Main: 268042240 08:23:38 INFO - PROCESS | 1651 | 08:23:41 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49243/tests/kraken/driver.html?testName=json-parse-financial) 08:23:41 INFO - PROCESS | 1651 | RSS: Main: 264302592 08:23:41 INFO - PROCESS | 1651 | 08:23:43 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49243/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:23:43 INFO - PROCESS | 1651 | RSS: Main: 240201728 08:23:43 INFO - PROCESS | 1651 | 08:23:45 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:23:46 INFO - PROCESS | 1651 | RSS: Main: 245268480 08:23:46 INFO - PROCESS | 1651 | 08:23:48 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:23:49 INFO - PROCESS | 1651 | RSS: Main: 252207104 08:23:49 INFO - PROCESS | 1651 | 08:23:52 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:23:52 INFO - PROCESS | 1651 | RSS: Main: 265379840 08:23:52 INFO - PROCESS | 1651 | 08:23:55 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:23:56 INFO - PROCESS | 1651 | RSS: Main: 259231744 08:23:56 INFO - PROCESS | 1651 | 08:23:58 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49243/tests/kraken/driver.html?testName=ai-astar) 08:23:58 INFO - PROCESS | 1651 | RSS: Main: 303706112 08:23:58 INFO - PROCESS | 1651 | 08:23:58 INFO - PROCESS | 1651 | __start_tp_report 08:23:58 INFO - PROCESS | 1651 | _x_x_mozilla_page_load 08:23:58 INFO - PROCESS | 1651 | _x_x_mozilla_page_load_details 08:23:58 INFO - PROCESS | 1651 | |i|pagename|runs| 08:23:58 INFO - PROCESS | 1651 | |0;ai-astar;113;113;113;112;111;112;111;115;113;112 08:23:58 INFO - PROCESS | 1651 | |1;audio-beat-detection;140;115;139;171;110;109;108;106;135;108 08:23:58 INFO - PROCESS | 1651 | |2;audio-dft;182;181;184;183;181;183;191;257;185;184 08:23:58 INFO - PROCESS | 1651 | |3;audio-fft;80;59;59;87;61;59;58;59;81;58 08:23:58 INFO - PROCESS | 1651 | |4;audio-oscillator;88;71;93;77;68;68;90;69;68;89 08:23:58 INFO - PROCESS | 1651 | |5;imaging-gaussian-blur;89;87;88;86;89;85;91;87;89;85 08:23:58 INFO - PROCESS | 1651 | |6;imaging-darkroom;93;93;94;93;93;107;151;92;100;93 08:23:58 INFO - PROCESS | 1651 | |7;imaging-desaturate;86;83;83;83;85;84;84;83;86;85 08:23:58 INFO - PROCESS | 1651 | |8;json-parse-financial;55;53;55;55;58;57;58;57;56;57 08:23:58 INFO - PROCESS | 1651 | |9;json-stringify-tinderbox;63;76;76;74;71;66;68;68;72;100 08:23:58 INFO - PROCESS | 1651 | |10;stanford-crypto-aes;83;101;101;98;77;83;82;82;87;82 08:23:58 INFO - PROCESS | 1651 | |11;stanford-crypto-ccm;138;133;136;137;129;129;152;155;198;148 08:23:58 INFO - PROCESS | 1651 | |12;stanford-crypto-pbkdf2;158;161;161;159;160;159;157;206;163;161 08:23:58 INFO - PROCESS | 1651 | |13;stanford-crypto-sha256-iterative;66;66;66;65;66;65;65;65;64;64 08:23:58 INFO - PROCESS | 1651 | __end_tp_report 08:23:58 INFO - PROCESS | 1651 | __start_cc_report 08:23:58 INFO - PROCESS | 1651 | _x_x_mozilla_cycle_collect,1922 08:23:58 INFO - PROCESS | 1651 | __end_cc_report 08:23:58 INFO - PROCESS | 1651 | __startTimestamp1481732638276__endTimestamp 08:23:58 INFO - PROCESS | 1651 | 08:23:58 INFO - PROCESS | 1651 | ------- Summary: start ------- 08:23:58 INFO - PROCESS | 1651 | Number of tests: 14 08:23:58 INFO - PROCESS | 1651 | 08:23:58 INFO - PROCESS | 1651 | [#0] ai-astar Cycles:10 Average:112.50 Median:113.00 stddev:1.18 (1.0%) stddev-sans-first:1.24 08:23:58 INFO - PROCESS | 1651 | Values: 113.0 113.0 113.0 112.0 111.0 112.0 111.0 115.0 113.0 112.0 08:23:58 INFO - PROCESS | 1651 | 08:23:58 INFO - PROCESS | 1651 | [#1] audio-beat-detection Cycles:10 Average:124.10 Median:125.00 stddev:21.47 (17.2%) stddev-sans-first:21.99 08:23:58 INFO - PROCESS | 1651 | Values: 140.0 115.0 139.0 171.0 110.0 109.0 108.0 106.0 135.0 108.0 08:23:58 INFO - PROCESS | 1651 | 08:23:58 INFO - PROCESS | 1651 | [#2] audio-dft Cycles:10 Average:191.10 Median:184.00 stddev:23.33 (12.7%) stddev-sans-first:24.51 08:23:58 INFO - PROCESS | 1651 | Values: 182.0 181.0 184.0 183.0 181.0 183.0 191.0 257.0 185.0 184.0 08:23:58 INFO - PROCESS | 1651 | 08:23:58 INFO - PROCESS | 1651 | [#3] audio-fft Cycles:10 Average:66.10 Median:60.00 stddev:11.60 (19.3%) stddev-sans-first:11.16 08:23:58 INFO - PROCESS | 1651 | Values: 80.0 59.0 59.0 87.0 61.0 59.0 58.0 59.0 81.0 58.0 08:23:58 INFO - PROCESS | 1651 | 08:23:58 INFO - PROCESS | 1651 | [#4] audio-oscillator Cycles:10 Average:78.10 Median:82.50 stddev:10.65 (12.9%) stddev-sans-first:10.68 08:23:58 INFO - PROCESS | 1651 | Values: 88.0 71.0 93.0 77.0 68.0 68.0 90.0 69.0 68.0 89.0 08:23:58 INFO - PROCESS | 1651 | 08:23:58 INFO - PROCESS | 1651 | [#5] imaging-gaussian-blur Cycles:10 Average:87.60 Median:88.50 stddev:1.96 (2.2%) stddev-sans-first:2.01 08:23:58 INFO - PROCESS | 1651 | Values: 89.0 87.0 88.0 86.0 89.0 85.0 91.0 87.0 89.0 85.0 08:23:58 INFO - PROCESS | 1651 | 08:23:58 INFO - PROCESS | 1651 | [#6] imaging-darkroom Cycles:10 Average:100.90 Median:93.00 stddev:18.22 (19.6%) stddev-sans-first:19.10 08:23:58 INFO - PROCESS | 1651 | Values: 93.0 93.0 94.0 93.0 93.0 107.0 151.0 92.0 100.0 93.0 08:23:58 INFO - PROCESS | 1651 | 08:23:58 INFO - PROCESS | 1651 | [#7] imaging-desaturate Cycles:10 Average:84.20 Median:84.50 stddev:1.23 (1.5%) stddev-sans-first:1.12 08:23:58 INFO - PROCESS | 1651 | Values: 86.0 83.0 83.0 83.0 85.0 84.0 84.0 83.0 86.0 85.0 08:23:58 INFO - PROCESS | 1651 | 08:23:58 INFO - PROCESS | 1651 | [#8] json-parse-financial Cycles:10 Average:56.10 Median:57.00 stddev:1.60 (2.8%) stddev-sans-first:1.64 08:23:58 INFO - PROCESS | 1651 | Values: 55.0 53.0 55.0 55.0 58.0 57.0 58.0 57.0 56.0 57.0 08:23:58 INFO - PROCESS | 1651 | 08:23:58 INFO - PROCESS | 1651 | [#9] json-stringify-tinderbox Cycles:10 Average:73.40 Median:71.50 stddev:10.28 (14.4%) stddev-sans-first:10.19 08:23:58 INFO - PROCESS | 1651 | Values: 63.0 76.0 76.0 74.0 71.0 66.0 68.0 68.0 72.0 100.0 08:23:58 INFO - PROCESS | 1651 | 08:23:58 INFO - PROCESS | 1651 | [#10] stanford-crypto-aes Cycles:10 Average:87.60 Median:82.50 stddev:8.92 (10.8%) stddev-sans-first:9.31 08:23:58 INFO - PROCESS | 1651 | Values: 83.0 101.0 101.0 98.0 77.0 83.0 82.0 82.0 87.0 82.0 08:23:58 INFO - PROCESS | 1651 | 08:23:58 INFO - PROCESS | 1651 | [#11] stanford-crypto-ccm Cycles:10 Average:145.50 Median:143.00 stddev:20.59 (14.4%) stddev-sans-first:21.66 08:23:58 INFO - PROCESS | 1651 | Values: 138.0 133.0 136.0 137.0 129.0 129.0 152.0 155.0 198.0 148.0 08:23:58 INFO - PROCESS | 1651 | 08:23:58 INFO - PROCESS | 1651 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.50 Median:161.00 stddev:14.68 (9.1%) stddev-sans-first:15.38 08:23:58 INFO - PROCESS | 1651 | Values: 158.0 161.0 161.0 159.0 160.0 159.0 157.0 206.0 163.0 161.0 08:23:58 INFO - PROCESS | 1651 | 08:23:58 INFO - PROCESS | 1651 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.20 Median:65.50 stddev:0.79 (1.2%) stddev-sans-first:0.78 08:23:58 INFO - PROCESS | 1651 | Values: 66.0 66.0 66.0 65.0 66.0 65.0 65.0 65.0 64.0 64.0 08:23:58 INFO - PROCESS | 1651 | -------- Summary: end -------- 08:23:58 INFO - PROCESS | 1651 | 08:23:59 INFO - TEST-INFO | 1651: exit 0 08:23:59 INFO - TEST-OK | kraken | took 57836ms 08:23:59 INFO - SUITE-END | took 1172s 08:23:59 INFO - Completed test suite (00:19:33) 08:23:59 INFO - javascript benchmark 08:23:59 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3452.8273586320684, 3473.6700013498717, 3499.475078738189, 3501.509788629594, 3509.1227193201717, 5814.302283725953, 5866.560007999396, 5895.351511333755, 5921.111833225018, 5936.050231962887, 4749.643776716743, 5722.914156287659, 5836.182934389189, 5870.354261031283, 5895.882082358361, 5252.002119597274, 5278.3665960084845, 5312.256284120226, 5327.813526526573, 5349.144136938091, 5253.080710875601, 5267.894642107156, 5374.516293533601, 5376.0, 5400.91898621521, 5274.525292723654, 5321.201819727053, 5330.546903513206, 5331.2269720890445, 5341.572674186055, 5260.079486089938, 5279.102552566073, 5305.124654432014, 5305.1776974569, 5312.681239125664, 5192.55863251624, 5298.072837253504, 5319.707416092114, 5331.44019877915, 5359.812406565751, 5670.801521946753, 5847.707614619295, 5865.794697185578, 5869.972983596119, 6001.129836173774, 6202.441780239755, 6247.5939063960695, 6258.405451482102, 6291.370862913672, 6297.0554416837385, 6365.49076073913, 6413.935860641381, 6438.645874476902, 6441.0982462455295, 6464.515161362917, 5933.19901813254, 5938.524918006636, 5940.108983652487, 5941.2276404067625, 5942.257217847769, 6311.526635502264, 6380.649064301415, 6404.135441715402, 6407.711652975628, 6412.64730439821, 6133.334663918993, 6177.444030037318, 6209.037599172136, 6215.689215539205, 6251.499880009588, 6364.045393190966, 6415.711292991827, 6422.775202867877, 6435.485161187094, 6457.61254324742, 6371.96814015927, 6377.0, 6378.52161087911, 6391.616503009835, 6392.584482008655, 6157.538184636171, 6217.533684973645, 6218.844528886814, 6242.500599951993, 6398.360163983564, 5017.899642007213, 5070.771815268322, 5074.0, 5081.0092032054135, 5138.023775482647, 4509.842155524541, 4548.385967894292, 4551.749653769009, 4560.931586026212, 4592.5407459254475, 5732.3407808101765, 5740.1102829061565, 5780.884382312414, 5882.411758824169, 5920.79277225295, 6318.842028949313, 6362.331955144643, 6383.106365108889, 6416.967915160394, 6417.358264173638, 5867.941320586825, 5872.621588256763, 5874.618149820248, 5879.735411906475, 5911.0, 5414.187871819258, 5485.396606373296, 5499.120140777456, 5511.641743286674, 5514.6691198528215, 6285.685715714105, 6305.936940630627, 6317.747290108344, 6320.715567799552, 6366.7771627993725, 6349.269833968968, 6376.171097757262, 6398.072279519537, 6417.326180751141, 6430.131932189094, 6333.778317758856, 6365.840853978688, 6381.521385895983, 6382.648954307372, 6391.32891046452, 6149.385061493815, 6211.223597050369, 6252.718627661857, 6307.7476900925285, 6316.526260530571, 6405.295417504164, 6424.550281480251, 6430.3891130342545, 6436.259830119596, 6445.967770161119, 6250.468710159687, 6287.056941458635, 6288.65412402304, 6290.748370065146, 6308.589941653778, 5302.575793936553, 5999.70001499932, 6136.120845438929, 6136.171616831849, 6155.415235552616, 6055.1220073090035, 6178.474829639531, 6179.660118693335, 6181.412765787243, 6192.659403732838, 5952.613080149949, 6261.906071409024, 6273.121762953281, 6285.057241413824, 6288.496920246461, 5923.526117910643, 5933.199018132497, 5974.9402505974385, 5980.581359304807, 6040.395960403925], "value": 5813.003180497351, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [503.9445660977293, 508.7863097499048, 509.5083244668894, 539.3393093460509, 581.3169525807175, 32169.678303216962, 34022.31955360894, 43552.128957420835, 43600.3459948101, 45825.541744582544, 44667.77666111665, 44974.32538511917, 45093.323600145945, 45185.32222016664, 45195.77402112985, 9337.626494940194, 10127.645532406368, 10313.484325783718, 10318.0, 10326.07065364117, 9332.953335233315, 9511.09644583767, 9522.80954380912, 9532.14210721035, 11952.94023529881, 10714.785704285949, 12463.0, 12621.55824546141, 12624.99000079996, 12628.242305461701, 12519.561815336465, 12575.245485270867, 12576.119671622899, 12585.874141258653, 12603.306818125, 12277.079219058607, 12370.567030153901, 12375.319357435337, 12403.317817520032, 12409.441575129142, 41693.583064169274, 41851.1629767406, 41899.7905010476, 41956.58043419557, 42047.789761051, 3422.7946323220685, 3500.2474467989505, 3546.8758593449106, 3712.4988126602834, 4014.558398576154, 32866.6713332866, 33215.83392083024, 33315.66737330504, 33502.83248583766, 33582.49626255608, 3370.8314584270934, 3379.5944486661756, 3452.2922800825772, 3523.4186359250693, 3525.858965641397, 495826.0, 496881.0, 498734.0, 499074.0, 499605.0, 64895.0, 65310.0, 65355.01967470492, 65424.672876636265, 65433.34566654272, 35622.0, 36203.4569481458, 36403.817980909924, 37762.244755104744, 37827.243455130745, 18017.369392071476, 18200.1809918554, 18201.45395638133, 18236.088195590168, 18263.72604410935, 13777.448902044007, 13892.888568914463, 13899.374528146258, 13903.443862245396, 13925.930370348286, 18078.00570968583, 18422.81577184211, 20136.899315503328, 20527.692084618742, 20972.47568810792, 7097.503174777819, 7442.925570744332, 8360.163983601713, 8412.411131220755, 8541.09602735073, 890.8530092534788, 1013.1793247469574, 1024.5235965276183, 1027.8766548014137, 1158.0, 32101.0, 32118.678813212035, 32225.0, 32435.02694919156, 32691.0, 1062.7565748074771, 1107.1309022417524, 1151.5739176504746, 1191.7497325561555, 1216.92698438094, 14351.928240358731, 15815.762763558556, 16743.33026678919, 16840.578985525215, 17111.0, 645297.0, 870037.0, 887631.0, 889115.0, 890742.0, 62983.370166298664, 63631.681841591424, 63795.0, 63886.0, 64074.35925640777, 1296.5591698822445, 1337.4583293766234, 1395.7696979998593, 1434.619825746178, 1460.0874453466583, 27115.86442067777, 31793.841030794698, 33265.50101748524, 33302.16744581308, 33598.0, 47158.05683886372, 52895.735521322145, 53636.927261455334, 53723.925521490135, 53756.731216343665, 560324.0, 560895.0, 565598.3440165545, 567271.0, 572024.0, 20860.37418877436, 25821.483570328863, 27782.44435111327, 27855.303617409725, 28777.56833647455, 49384.25923611077, 49800.0, 49832.75418114576, 50276.0, 50357.24464132968, 39833.60166398299, 41463.0, 41543.37684934668, 41620.375694364004, 42655.0, 34997.300053999286, 35362.46956295709, 40475.98810029773, 40559.1888162241, 41987.580124198365, 39682.80158599189, 40260.0, 40410.1917961645, 40537.59462405338, 40922.0, 34755.82622086874, 36051.189030637135, 36382.0, 36468.0, 36547.26905461929, 22526.66210006884, 24140.758592414553, 26933.3266668327, 26950.326241843326, 26952.460950781267], "value": 21129.168482977097, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [318.6128853443067, 391.4988814317674, 393.9724219304648, 403.56818204521136, 417.8182490616582, 20094.899525502387, 21790.782092179074, 22367.217147399846, 22660.886695566518, 22875.542489150208, 20379.18483260668, 21010.36968890932, 21256.78743212571, 21470.785292147073, 21928.561428771456, 5250.842474725764, 5501.779928802843, 5572.136318870582, 5572.359178694442, 5575.609707320489, 4084.4077608746716, 4180.644645205161, 5526.171074338841, 5611.326640803089, 5626.240457538242, 4176.749395036308, 4234.724742891717, 6840.0, 6908.309169083077, 6918.65406729664, 6135.355787642278, 6202.13170156174, 6878.690458929335, 6889.104416425883, 6895.655217239118, 6056.485198758067, 6063.99944009238, 6064.363241859585, 6071.241094863142, 6073.665948372838, 13840.377183026789, 25004.749952500424, 25561.488770224492, 26086.73913260862, 26610.33474163142, 2143.90968805415, 2263.1400067974228, 2346.1319311854554, 2567.2169988153605, 2709.986450067757, 9125.361224714272, 10188.032136946978, 10959.671209863716, 11161.888381116247, 16666.6666666666, 1880.454668146236, 1888.424030670645, 1954.84361251101, 1969.5470041890446, 1996.5707372914749, 90789.54605226997, 96568.0, 124505.0, 136650.3167484166, 137752.62247377398, 10831.404272764916, 11206.327620342805, 11391.715207119889, 11531.019863311712, 11982.940085299517, 15215.695686086437, 15229.010114342533, 15234.771478427832, 15244.009139406126, 15277.6180595486, 7669.808254793563, 8765.254953329038, 9022.729318120468, 9056.547172641473, 9150.398680230934, 7670.7698769037015, 8972.730818075468, 9095.135962083592, 9097.681581144629, 9249.90750092504, 4519.570640789119, 4606.286025666027, 4610.1471227822285, 4675.625949923998, 4697.976510117427, 1533.9386424542893, 1714.996726914744, 1720.6816738903342, 1947.269773834812, 1972.6054789042248, 806.5725165662209, 937.5827756648226, 987.4865070163474, 1043.0508237503834, 1076.7361996310954, 20866.895665521577, 22006.779932200792, 22113.447163821034, 22136.778632213794, 22185.0, 978.2711879649706, 990.8662330585423, 996.7856910764076, 1007.8740157480315, 1043.6295115234134, 11171.553137874556, 11572.826407603892, 11668.008219301284, 11681.0, 11682.532698691957, 493030.0, 582873.0, 614000.0, 627267.0, 627415.0, 132029.0, 135699.64300357067, 135722.0, 137193.0, 138494.61505384816, 1013.8783345998528, 1044.6448207609296, 1058.269793842231, 1059.2108878885126, 1061.9044286014296, 18176.909385436917, 18538.351157709956, 19386.709199362303, 19828.50428739293, 19945.301914432926, 41011.179776404904, 46075.0, 56870.0, 58379.70810145922, 58725.706371467866, 87102.0, 88812.0, 89696.551517242, 89776.10223897677, 90487.09512904787, 8046.517208967481, 8492.598721211178, 8559.101294364002, 8559.400841941253, 8727.083656216006, 9671.468069256258, 13389.464421423034, 13449.731005379643, 13609.455621775414, 13609.591712248648, 11616.709582260512, 11858.584949526725, 11917.821232681343, 11923.880761192277, 11929.0, 10264.332818366782, 10547.734271887422, 11184.328940263611, 11503.0, 11522.942385288019, 11780.70548236301, 11826.231294965799, 11941.283522988648, 11968.581099661471, 12105.81841272364, 8265.669373225004, 8479.109693482342, 8522.806807046894, 8721.084286150117, 8726.345524085846, 11275.718107047389, 11448.599299024494, 11494.195406321478, 11872.109591780823, 11985.880141198477], "value": 9849.452919547684, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1394.532831501447, 1458.5770126663267, 1538.3692685998735, 1770.4600096970419, 1966.2921348314603, 8088.191180881909, 8650.264727498163, 8866.335024873128, 9097.181253687168, 9114.863277050834, 9001.774955626113, 9073.0, 9076.818463630723, 9086.409383390092, 9112.90887091129, 2404.0263693204192, 2436.6466862304956, 2439.0731522021606, 2440.9633855492184, 2441.865697386643, 2406.0255596483453, 2422.200673777649, 2449.5468338357373, 2450.6936632920883, 2454.460018795862, 2394.38943069517, 2410.301012706313, 2420.770026847447, 2422.9394265143424, 2424.7211570669333, 2388.988055059731, 2400.867952262625, 2411.987940060306, 2412.5174965006895, 2428.9757102428925, 2395.6765836612185, 2409.72288186859, 2439.329184474266, 2444.8166387521005, 2450.1669432392896, 8869.600867960893, 9055.592498337524, 9175.816483670289, 9181.0, 9198.98811130775, 5382.2464854920345, 5605.159226116074, 5607.130894711327, 5610.102383618642, 5627.2684551008515, 3643.6902863256655, 3672.797996110213, 3684.152644891663, 3761.9435708464393, 3764.3788774852114, 1032.4889179855945, 1042.5725452564488, 1043.504335440667, 1055.37205362809, 1070.550368845087, 11696.0, 11774.587889423829, 11800.114991375596, 11834.349110798816, 11850.46672899713, 4514.277715565559, 4553.408056952575, 4726.8109275628585, 4735.431748190239, 4739.218029025173, 9336.906630933603, 9342.0, 9351.018143095012, 9361.251099911991, 9384.06159384056, 5382.0, 5382.950324686649, 5388.8113916013535, 5389.865253368619, 5398.838034858961, 4614.97692511542, 4744.786484608132, 4926.162552366106, 5034.295198672189, 5035.144025515671, 3892.0853599404118, 3908.1402091539817, 3991.481107456012, 4022.0950286185375, 4027.556968733437, 1193.886580774825, 1207.14292852076, 1208.6494916474123, 1216.1122380662166, 1218.8476440444945, 892.1702816380698, 915.2997956563235, 932.072587775168, 935.209747763139, 968.8062387522524, 5898.439648233411, 5939.703014849327, 5990.400959903975, 6148.44663980244, 6346.01636746305, 439.73396095362483, 451.8915460289507, 985.9950700246453, 1072.860528131338, 1073.1200415659084, 4064.9796751016056, 4090.9386359204636, 4105.3020986432375, 4209.536950935456, 4231.984323762336, 10782.245242833083, 11006.944965275123, 11122.388268645302, 11125.610603628835, 11155.609553665583, 9251.44491330509, 10886.237963342648, 10888.29226100301, 11061.115110791117, 11221.438928053727, 8323.209295116954, 8368.874466883002, 8495.660173592987, 8523.573821309034, 8528.0, 5998.70006499682, 6035.78874739382, 6063.787767428119, 6159.168512250789, 6184.907226391518, 10060.849087263843, 10108.49457527106, 10265.332753371007, 10373.429461379395, 10463.843042354218, 10377.533011014371, 10534.473276335999, 10550.103241224582, 10681.732956676145, 10702.0, 7174.067371241706, 7366.484346095722, 7454.850902982019, 7553.357964573072, 7684.884726729216, 8547.57262136903, 8609.880715507195, 8618.181272779077, 8760.4305720128, 8760.956195218983, 7680.769576912701, 7819.296263336327, 7837.333826624573, 7963.601819908866, 7985.5208687478935, 7597.012388389695, 7631.618419078913, 7736.419768517271, 7747.535147891144, 7762.689492420466, 6037.426444487766, 7010.509264351446, 7137.357637812622, 7138.39323657495, 7158.892616610651, 4866.732329721899, 4966.031623833318, 5066.0, 5067.2652465391575, 5362.678239305654, 4888.169011268022, 4921.2864134700985, 4970.701757894538, 4997.650164488451, 5022.045811295842], "value": 4659.389312470851, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [281.4427433681311, 315.4668610049017, 317.6712102973422, 323.37427078602906, 325.890826573098, 4761.642876784238, 5436.782528698852, 5448.37343705474, 5448.809291674792, 5455.072637651599, 4996.925046124302, 5192.8701782455455, 5355.839324820262, 5366.758495867685, 5414.810481633143, 3113.5641010258523, 3209.0, 3588.3361578108, 4114.19773144237, 4131.607497287753, 4102.692298077641, 4112.568180341066, 4122.093139509303, 4145.958540414603, 4185.707000509966, 3549.189913144302, 3553.662402071812, 4106.9794651026705, 4113.773742444165, 4142.286802144585, 3913.452116703678, 4138.79306034697, 4157.230912281238, 4161.834686287844, 4165.354370072613, 2689.367998520346, 3161.3835302116095, 3396.1509622594353, 3594.903554415902, 3618.3486972344967, 4254.680898932593, 4392.626626736699, 5224.843254702365, 5245.0, 5245.449227831099, 4100.425940368351, 4115.9176816463805, 4333.285007973681, 4370.841726942363, 4758.382150068993, 4910.582600478963, 5423.620346575742, 5500.6424582402415, 5639.295088113986, 5670.432956704338, 3873.1021799318414, 3877.5346958364894, 3897.902552436212, 3911.432842237888, 3933.9968308081257, 4826.1795494765975, 4867.51324867514, 5473.507384335389, 5967.761289548413, 6048.304444988838, 3814.6757525610633, 3859.3246181918053, 3874.2057878134915, 3881.389223472284, 3886.2227554489214, 3297.7856439331367, 3443.483477478348, 3809.8666546670734, 3887.552931412867, 4014.5383280922483, 3975.8608448704736, 4542.523035081335, 4550.29470432077, 4568.817247310137, 4611.815527378934, 4572.428446444194, 4642.419697537808, 5285.229448134841, 5525.0, 5608.439156084441, 1134.3080720760329, 1353.8849197818295, 1356.4845358763607, 1358.2733237717773, 1361.4418088583832, 758.9678037868495, 818.9353840008084, 841.2134654098315, 842.2924743215606, 842.6223125190236, 4640.466346370211, 5095.363079615048, 5187.870303242449, 5348.331458567679, 5391.002664507, 5276.28520730764, 5754.856128596819, 5765.336986246635, 5822.417758224228, 5837.6941108262845, 4121.62905338521, 4646.79089440976, 5343.919841202385, 5390.353157621033, 5391.81128660495, 2747.2582402751145, 3055.358374741285, 3055.5263934090253, 3055.92360190997, 3062.0, 4988.650794444354, 5372.140457526777, 5736.483716465538, 6061.6666083365835, 6071.358958852913, 5299.49654782795, 5944.910826337608, 5952.226210592596, 5973.1936188614845, 6019.006863867413, 5349.9300139972165, 5553.916691249554, 5948.899453601098, 6005.798840231883, 6038.365971573009, 4989.426215985208, 5369.838904832861, 5482.917756233739, 5504.724763761876, 5805.680687562224, 5020.623453240948, 5164.948350516597, 5519.813240153226, 5794.797182098607, 5847.766089356378, 5555.722213889208, 6093.07532384449, 6121.602095863755, 6126.0, 6129.632222066691, 3543.344481270973, 3562.786232826039, 3605.8016809075752, 3928.980355098206, 4119.805256475588, 5813.854653633693, 5831.825045248649, 5842.766289348378, 5848.707564621837, 5864.237649105589, 5707.743151558107, 5714.057220545034, 5719.256496655408, 5749.8275051748515, 5772.0, 5335.2263921730355, 5339.3058902342445, 5553.916691249715, 5684.77260909559, 5727.255456790591, 4880.780364883518, 5402.783888644411, 5421.045530186137, 5614.943850561605, 5653.180288858175, 5442.482964118402, 5589.301337332833, 5636.549076073986, 5662.754194077296, 5724.570657200643, 4850.175470170009, 5529.778808847601, 5573.832785016456, 5587.804426845203, 5613.971930140487], "value": 4084.0569272375983, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [726.9563826170427, 776.1850057439686, 784.8234147316855, 800.6597196191619, 861.9310455163587, 14027.859721402783, 15773.842261577382, 17024.744628830576, 17055.061971591556, 17146.48560543184, 15149.394024239018, 15281.388744450236, 15282.617934551641, 15294.847051529481, 15304.081755094674, 723.884178531435, 744.2483092077014, 889.0398369760643, 892.6652505310509, 913.968011119611, 900.0819164452255, 906.3564868943058, 914.8902131744167, 915.3958387464274, 916.4776077635751, 970.9174270688167, 971.0241207586366, 973.2019743810079, 973.4645944730405, 974.6296407365227, 964.2767924056957, 964.8745663063827, 964.9517524123801, 967.0764419978904, 969.1616751509964, 717.1967396515884, 717.6555253478307, 720.9531380460253, 721.1922646635749, 724.2142275630947, 15150.696986060328, 15208.0, 15219.315130819139, 15225.238738063052, 15228.619284517865, 11874.703132421671, 14149.292535373294, 14746.447060704766, 14910.552683419515, 14997.850021499864, 12067.698307542294, 12226.266424014588, 12774.808377874338, 12826.551070712574, 13448.798268025987, 3939.527256729211, 3991.201759648082, 4055.6755459563165, 4064.268431682296, 4101.610347017028, 118180.40909795482, 119240.21139682912, 119377.0, 121061.39469302597, 121480.78519214872, 11348.432578371214, 11797.233179843282, 11816.350100744541, 11930.284182949052, 11935.701607459883, 24659.136930207715, 25210.0, 25581.744182557937, 25626.23121306364, 25691.0, 8580.613872375758, 8659.653613855502, 8712.433691810013, 8728.738137855875, 8807.691730789391, 4048.514178298623, 4593.150267200579, 4673.322368256584, 4814.325994360793, 4863.221884498534, 3726.366517691999, 3848.634379733921, 3849.4225866119746, 3851.8459261629223, 3863.671587915059, 690.547691262214, 691.5366704308126, 698.068079114388, 699.8845190543503, 724.6231959381198, 612.745710530125, 634.3941535833268, 635.8982562789931, 657.8815813153583, 716.716896825751, 9395.0, 9874.358166719141, 9916.305858589829, 9968.40189588627, 10041.497925103715, 629.9857229859922, 655.8393193667487, 715.8067321823079, 731.129955353128, 732.6593134192626, 4492.618127459203, 4783.928241076386, 4784.0, 4794.880127996758, 4811.855644330606, 100865.0, 147126.7930981036, 167625.0, 168345.0, 169809.0, 140003.0, 146414.26792865968, 147517.0, 149120.25439872732, 151239.0, 122521.0, 125365.0, 127089.36455317664, 128108.99999999814, 129973.35013325061, 8759.474431533874, 9167.193717225213, 9245.167934885892, 9248.121428464285, 9328.906710932804, 63891.04163437645, 67140.32859671341, 67670.0, 68572.657136714, 69530.60938781095, 95706.56440153542, 103492.0, 106331.93668063529, 106963.4651826736, 106992.46503767431, 12618.053645976772, 12643.747125057263, 12674.556390526288, 12752.936235319135, 12937.159084659466, 13405.66485837862, 13736.244506552235, 14053.789193162314, 14065.718685626434, 14109.153450792985, 12043.09676774228, 12346.777580035321, 12365.639779624054, 12460.87539124597, 12475.93762031184, 12088.274703517465, 12670.493180273055, 12734.490620375082, 12755.808662869878, 13367.532136375181, 11941.820872686743, 12410.875891240972, 12489.875101248872, 12548.623541293775, 12702.428390722254, 8853.291736660924, 10743.301685390425, 10905.0, 11275.943620281847, 11286.379249141048, 10915.72215790227, 10980.396078215455, 11039.227254092137, 11191.832122518332, 11203.60787372438], "value": 8156.10173514055, "unit": "score"}], "name": "dromaeo_css", "value": 7567.301689294342, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 113.0, 112.0, 111.0, 112.0, 111.0, 115.0, 113.0, 112.0], "value": 112.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 115.0, 139.0, 171.0, 110.0, 109.0, 108.0, 106.0, 135.0, 108.0], "value": 124.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 181.0, 184.0, 183.0, 181.0, 183.0, 191.0, 257.0, 185.0, 184.0], "value": 191.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 59.0, 59.0, 87.0, 61.0, 59.0, 58.0, 59.0, 81.0, 58.0], "value": 66.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 71.0, 93.0, 77.0, 68.0, 68.0, 90.0, 69.0, 68.0, 89.0], "value": 78.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 87.0, 88.0, 86.0, 89.0, 85.0, 91.0, 87.0, 89.0, 85.0], "value": 87.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 94.0, 93.0, 93.0, 107.0, 151.0, 92.0, 100.0, 93.0], "value": 100.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 83.0, 83.0, 83.0, 85.0, 84.0, 84.0, 83.0, 86.0, 85.0], "value": 84.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 53.0, 55.0, 55.0, 58.0, 57.0, 58.0, 57.0, 56.0, 57.0], "value": 56.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 76.0, 76.0, 74.0, 71.0, 66.0, 68.0, 68.0, 72.0, 100.0], "value": 73.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 101.0, 101.0, 98.0, 77.0, 83.0, 82.0, 82.0, 87.0, 82.0], "value": 87.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 133.0, 136.0, 137.0, 129.0, 129.0, 152.0, 155.0, 198.0, 148.0], "value": 145.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 161.0, 161.0, 159.0, 160.0, 159.0, 157.0, 206.0, 163.0, 161.0], "value": 164.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 66.0, 65.0, 66.0, 65.0, 65.0, 65.0, 64.0, 64.0], "value": 65.2, "unit": "score"}], "name": "kraken", "value": 1436.9, "alertThreshold": 2.0}]} 08:23:59 INFO - Return code: 0 08:23:59 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:23:59 INFO - # TBPL SUCCESS # 08:23:59 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:23:59 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:23:59 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:23:59 INFO - 2016-12-14 08:23:59.582 screenresolution[1655:9720] starting screenresolution argv=screenresolution get 08:23:59 INFO - 2016-12-14 08:23:59.585 screenresolution[1655:9720] Display 0: 1600x1200x32@60 08:23:59 INFO - 2016-12-14 08:23:59.591 screenresolution[1656:9723] starting screenresolution argv=screenresolution list 08:23:59 INFO - Available Modes on Display 0 08:23:59 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:23:59 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:23:59 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:23:59 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:23:59 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:23:59 INFO - Intel Iris: 08:23:59 INFO - Chipset Model: Intel Iris 08:23:59 INFO - Type: GPU 08:23:59 INFO - Bus: Built-In 08:23:59 INFO - VRAM (Dynamic, Max): 1536 MB 08:23:59 INFO - Vendor: Intel (0x8086) 08:23:59 INFO - Device ID: 0x0a2e 08:23:59 INFO - Revision ID: 0x0009 08:23:59 INFO - Displays: 08:23:59 INFO - Display: 08:23:59 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:23:59 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:23:59 INFO - Display Serial Number: 1600x1200 60 08:23:59 INFO - Main Display: Yes 08:23:59 INFO - Mirror: Off 08:23:59 INFO - Online: Yes 08:23:59 INFO - Rotation: Supported 08:23:59 INFO - Return code: 0 08:23:59 INFO - Running post-action listener: _resource_record_post_action 08:23:59 INFO - [mozharness: 2016-12-14 16:23:59.829912Z] Finished run-tests step (success) 08:23:59 INFO - Running post-run listener: _resource_record_post_run 08:23:59 INFO - Total resource usage - Wall time: 1196s; CPU: 53.0%; Read bytes: 37766144; Write bytes: 493061120; Read time: 244; Write time: 1576 08:23:59 INFO - TinderboxPrint: CPU usage
53.1% 08:23:59 INFO - TinderboxPrint: I/O read bytes / time
37,766,144 / 244 08:23:59 INFO - TinderboxPrint: I/O write bytes / time
493,061,120 / 1,576 08:23:59 INFO - TinderboxPrint: CPU idle
2,242.9 (46.9%) 08:23:59 INFO - TinderboxPrint: CPU system
954.1 (19.9%) 08:23:59 INFO - TinderboxPrint: CPU user
1,588.6 (33.2%) 08:23:59 INFO - TinderboxPrint: Swap in / out
233,140,224 / 0 08:23:59 INFO - install - Wall time: 23s; CPU: 54.0%; Read bytes: 188232192; Write bytes: 185774080; Read time: 17293; Write time: 413 08:23:59 INFO - run-tests - Wall time: 1174s; CPU: 53.0%; Read bytes: 36008960; Write bytes: 296289280; Read time: 229; Write time: 1127 08:24:00 INFO - Running post-run listener: _upload_blobber_files 08:24:00 INFO - Blob upload gear active. 08:24:00 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:24:00 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 08:24:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:24:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:24:00 INFO - (blobuploader) - INFO - Open directory for files ... 08:24:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:24:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:24:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:24:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:24:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:24:01 INFO - (blobuploader) - INFO - Done attempting. 08:24:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:24:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:24:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:24:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:24:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:24:02 INFO - (blobuploader) - INFO - Done attempting. 08:24:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:24:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:24:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:24:06 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:24:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:24:06 INFO - (blobuploader) - INFO - Done attempting. 08:24:06 INFO - (blobuploader) - INFO - Iteration through files over. 08:24:06 INFO - Return code: 0 08:24:06 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:24:06 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:24:06 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/eea1f727d7de21c0796d3e6ffbd76f74be764aa49bbb9b996af9fbec97ca6772450ac494c8bce42971585b4af515f80deff5a8174b22b369203a7bd31d3a1b30", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/cc71f2ceb02c94744e8221e3389b57f306fe847cc1a5486eac70722c897db31e513ef70c2dccad842de7af117ba04890c8cfad11a8eeefcd2f8e9edbbe3ae6ef", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/de9519788d25dc5f7ac0a0574c3f51027a111e97977858d5cab61cc6e18589ad220c67252f22d544eab5ed96f6e330538258d0e26c9f7baac3338a3e469e1adc"} 08:24:06 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:24:06 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:24:06 INFO - Contents: 08:24:06 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/eea1f727d7de21c0796d3e6ffbd76f74be764aa49bbb9b996af9fbec97ca6772450ac494c8bce42971585b4af515f80deff5a8174b22b369203a7bd31d3a1b30", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/cc71f2ceb02c94744e8221e3389b57f306fe847cc1a5486eac70722c897db31e513ef70c2dccad842de7af117ba04890c8cfad11a8eeefcd2f8e9edbbe3ae6ef", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/de9519788d25dc5f7ac0a0574c3f51027a111e97977858d5cab61cc6e18589ad220c67252f22d544eab5ed96f6e330538258d0e26c9f7baac3338a3e469e1adc"} 08:24:06 INFO - Running post-run listener: copy_logs_to_upload_dir 08:24:06 INFO - Copying logs to upload dir... 08:24:06 INFO - mkdir: /builds/slave/test/build/upload/logs 08:24:06 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1256.617808 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2016-12-14 08:24:06.412096) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-14 08:24:06.415474) ========= 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.k8sAEIh0YK/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.WfRmT7XbWL/Listeners TMPDIR=/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/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/eea1f727d7de21c0796d3e6ffbd76f74be764aa49bbb9b996af9fbec97ca6772450ac494c8bce42971585b4af515f80deff5a8174b22b369203a7bd31d3a1b30", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/cc71f2ceb02c94744e8221e3389b57f306fe847cc1a5486eac70722c897db31e513ef70c2dccad842de7af117ba04890c8cfad11a8eeefcd2f8e9edbbe3ae6ef", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/de9519788d25dc5f7ac0a0574c3f51027a111e97977858d5cab61cc6e18589ad220c67252f22d544eab5ed96f6e330538258d0e26c9f7baac3338a3e469e1adc"} build_url:https://queue.taskcluster.net/v1/task/Zezw4-f8RR6ywDZ_S_sYLg/artifacts/public/build/firefox-51.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011008 build_url: 'https://queue.taskcluster.net/v1/task/Zezw4-f8RR6ywDZ_S_sYLg/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/eea1f727d7de21c0796d3e6ffbd76f74be764aa49bbb9b996af9fbec97ca6772450ac494c8bce42971585b4af515f80deff5a8174b22b369203a7bd31d3a1b30", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/cc71f2ceb02c94744e8221e3389b57f306fe847cc1a5486eac70722c897db31e513ef70c2dccad842de7af117ba04890c8cfad11a8eeefcd2f8e9edbbe3ae6ef", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/de9519788d25dc5f7ac0a0574c3f51027a111e97977858d5cab61cc6e18589ad220c67252f22d544eab5ed96f6e330538258d0e26c9f7baac3338a3e469e1adc"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-14 08:24:06.449467) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-14 08:24:06.449814) ========= 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.k8sAEIh0YK/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.WfRmT7XbWL/Listeners TMPDIR=/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/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.005137 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-14 08:24:06.499181) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-14 08:24:06.499591) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-14 08:24:06.500047) ========= ========= Total master_lag: 0.18 =========