builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0367 starttime: 1490825922.54 results: success (0) buildid: 20170329135122 builduid: d83f97dc45d3461b8cc1f2812f3042af revision: 7230f94c609b6a000ad6696f2db85b2f79e36e61 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-29 15:18:42.541567) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-29 15:18:42.542019) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-29 15:18:42.542559) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-29 15:18:42.571037) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-29 15:18:42.571396) ========= 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.QcFmr5Rrnh/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.C0MpvK7zTr/Listeners TMPDIR=/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-03-29 15:18:42-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 168M=0s 2017-03-29 15:18:42 (168 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.148263 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-29 15:18:42.744860) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-29 15:18:42.745181) ========= 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.QcFmr5Rrnh/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.C0MpvK7zTr/Listeners TMPDIR=/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/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.026977 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-29 15:18:42.794583) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-29 15:18:42.794961) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 7230f94c609b6a000ad6696f2db85b2f79e36e61 --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 7230f94c609b6a000ad6696f2db85b2f79e36e61 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.QcFmr5Rrnh/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.C0MpvK7zTr/Listeners TMPDIR=/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-03-29 15:18:42,901 truncating revision to first 12 chars 2017-03-29 15:18:42,902 Setting DEBUG logging. 2017-03-29 15:18:42,902 attempt 1/10 2017-03-29 15:18:42,902 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/7230f94c609b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-29 15:18:44,271 unpacking tar archive at: mozilla-beta-7230f94c609b/testing/mozharness/ program finished with exit code 0 elapsedTime=1.648171 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-29 15:18:44.467697) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-29 15:18:44.468032) ========= script_repo_revision: 7230f94c609b6a000ad6696f2db85b2f79e36e61 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-29 15:18:44.468423) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-29 15:18:44.468713) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-29 15:18:44.489379) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2017-03-29 15:18:44.489731) ========= /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.QcFmr5Rrnh/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.C0MpvK7zTr/Listeners TMPDIR=/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/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 15:18:44 INFO - MultiFileLogger online at 20170329 15:18:44 in /builds/slave/test 15:18:44 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 15:18:44 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:18:44 INFO - {'append_to_log': False, 15:18:44 INFO - 'base_work_dir': '/builds/slave/test', 15:18:44 INFO - 'blob_upload_branch': 'Mozilla-Beta', 15:18:44 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:18:44 INFO - 'branch': 'Mozilla-Beta', 15:18:44 INFO - 'buildbot_json_path': 'buildprops.json', 15:18:44 INFO - 'config_files': ('talos/mac_config.py',), 15:18:44 INFO - 'default_actions': ('clobber', 15:18:44 INFO - 'read-buildbot-config', 15:18:44 INFO - 'download-and-extract', 15:18:44 INFO - 'populate-webroot', 15:18:44 INFO - 'create-virtualenv', 15:18:44 INFO - 'install', 15:18:44 INFO - 'run-tests'), 15:18:44 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:18:44 INFO - 'download_minidump_stackwalk': True, 15:18:44 INFO - 'download_symbols': 'ondemand', 15:18:44 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:18:44 INFO - 'tooltool.py': '/tools/tooltool.py', 15:18:44 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:18:44 INFO - '/tools/misc-python/virtualenv.py')}, 15:18:44 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:18:44 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:18:44 INFO - 'installer_path': 'installer.exe', 15:18:44 INFO - 'log_level': 'info', 15:18:44 INFO - 'log_name': 'talos', 15:18:44 INFO - 'log_to_console': True, 15:18:44 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 15:18:44 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 15:18:44 INFO - 'opt_config_files': (), 15:18:44 INFO - 'pip_index': False, 15:18:44 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:18:44 INFO - 'cmd': ('bash', 15:18:44 INFO - '-c', 15:18:44 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:18:44 INFO - 'enabled': True, 15:18:44 INFO - 'halt_on_failure': False, 15:18:44 INFO - 'name': 'check_screen_resolution'},), 15:18:44 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:18:44 INFO - 'cmd': ('bash', 15:18:44 INFO - '-c', 15:18:44 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:18:44 INFO - 'enabled': True, 15:18:44 INFO - 'halt_on_failure': False, 15:18:44 INFO - 'name': 'check_screen_resolution'},), 15:18:44 INFO - 'run_cmd_checks_enabled': True, 15:18:44 INFO - 'sps_profile': False, 15:18:44 INFO - 'sps_profile_interval': 0, 15:18:44 INFO - 'suite': 'dromaeojs', 15:18:44 INFO - 'system_bits': '32', 15:18:44 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:18:44 INFO - 'title': 't-yosemite-r7-0367', 15:18:44 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:18:44 INFO - 'use_talos_json': True, 15:18:44 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:18:44 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:18:44 INFO - 'work_dir': 'build'} 15:18:44 INFO - [mozharness: 2017-03-29 22:18:44.704313Z] Running clobber step. 15:18:44 INFO - Running pre-action listener: _resource_record_pre_action 15:18:44 INFO - Running main action method: clobber 15:18:44 INFO - rmtree: /builds/slave/test/build 15:18:44 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:18:49 INFO - Running post-action listener: _resource_record_post_action 15:18:49 INFO - [mozharness: 2017-03-29 22:18:49.214507Z] Finished clobber step (success) 15:18:49 INFO - [mozharness: 2017-03-29 22:18:49.214738Z] Running read-buildbot-config step. 15:18:49 INFO - Running pre-action listener: _resource_record_pre_action 15:18:49 INFO - Running main action method: read_buildbot_config 15:18:49 INFO - Using buildbot properties: 15:18:49 INFO - { 15:18:49 INFO - "project": "", 15:18:49 INFO - "product": "firefox", 15:18:49 INFO - "script_repo_revision": "production", 15:18:49 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 15:18:49 INFO - "repository": "", 15:18:49 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 15:18:49 INFO - "buildid": "20170329135122", 15:18:49 INFO - "pgo_build": "False", 15:18:49 INFO - "basedir": "/builds/slave/test", 15:18:49 INFO - "buildnumber": 65, 15:18:49 INFO - "slavename": "t-yosemite-r7-0367", 15:18:49 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 15:18:49 INFO - "platform": "yosemite_r7", 15:18:49 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 15:18:49 INFO - "branch": "mozilla-beta", 15:18:49 INFO - "repo_path": "releases/mozilla-beta", 15:18:49 INFO - "revision": "7230f94c609b6a000ad6696f2db85b2f79e36e61", 15:18:49 INFO - "stage_platform": "macosx64", 15:18:49 INFO - "builduid": "d83f97dc45d3461b8cc1f2812f3042af", 15:18:49 INFO - "slavebuilddir": "test" 15:18:49 INFO - } 15:18:49 INFO - Found installer url https://queue.taskcluster.net/v1/task/D8ypfo99Tp-XInZynU7iFA/artifacts/public/build/firefox-53.0.en-US.mac.dmg. 15:18:49 INFO - Running post-action listener: _resource_record_post_action 15:18:49 INFO - [mozharness: 2017-03-29 22:18:49.220837Z] Finished read-buildbot-config step (success) 15:18:49 INFO - [mozharness: 2017-03-29 22:18:49.221110Z] Running download-and-extract step. 15:18:49 INFO - Running pre-action listener: _resource_record_pre_action 15:18:49 INFO - Running main action method: download_and_extract 15:18:49 INFO - mkdir: /builds/slave/test/build/tests 15:18:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:18:49 INFO - trying https://queue.taskcluster.net/v1/task/D8ypfo99Tp-XInZynU7iFA/artifacts/public/build/firefox-53.0.en-US.mac.test_packages.json 15:18:49 INFO - Downloading https://queue.taskcluster.net/v1/task/D8ypfo99Tp-XInZynU7iFA/artifacts/public/build/firefox-53.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0.en-US.mac.test_packages.json 15:18:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/D8ypfo99Tp-XInZynU7iFA/artifacts/public/build/firefox-53.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0.en-US.mac.test_packages.json'}, attempt #1 15:18:50 INFO - Downloaded 1165 bytes. 15:18:50 INFO - Reading from file /builds/slave/test/build/firefox-53.0.en-US.mac.test_packages.json 15:18:50 INFO - Using the following test package requirements: 15:18:50 INFO - {u'common': [u'firefox-53.0.en-US.mac.common.tests.zip'], 15:18:50 INFO - u'cppunittest': [u'firefox-53.0.en-US.mac.common.tests.zip', 15:18:50 INFO - u'firefox-53.0.en-US.mac.cppunittest.tests.zip'], 15:18:50 INFO - u'gtest': [u'firefox-53.0.en-US.mac.common.tests.zip', 15:18:50 INFO - u'firefox-53.0.en-US.mac.gtest.tests.zip'], 15:18:50 INFO - u'jittest': [u'firefox-53.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 15:18:50 INFO - u'mochitest': [u'firefox-53.0.en-US.mac.common.tests.zip', 15:18:50 INFO - u'firefox-53.0.en-US.mac.mochitest.tests.zip'], 15:18:50 INFO - u'mozbase': [u'firefox-53.0.en-US.mac.common.tests.zip'], 15:18:50 INFO - u'reftest': [u'firefox-53.0.en-US.mac.common.tests.zip', 15:18:50 INFO - u'firefox-53.0.en-US.mac.reftest.tests.zip'], 15:18:50 INFO - u'talos': [u'firefox-53.0.en-US.mac.common.tests.zip', 15:18:50 INFO - u'firefox-53.0.en-US.mac.talos.tests.zip'], 15:18:50 INFO - u'web-platform': [u'firefox-53.0.en-US.mac.common.tests.zip', 15:18:50 INFO - u'firefox-53.0.en-US.mac.web-platform.tests.zip'], 15:18:50 INFO - u'xpcshell': [u'firefox-53.0.en-US.mac.common.tests.zip', 15:18:50 INFO - u'firefox-53.0.en-US.mac.xpcshell.tests.zip']} 15:18:50 INFO - Downloading packages: [u'firefox-53.0.en-US.mac.common.tests.zip'] for test suite category: common 15:18:50 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/D8ypfo99Tp-XInZynU7iFA/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip 15:18:50 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/D8ypfo99Tp-XInZynU7iFA/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip'}, attempt #1 15:18:50 INFO - Fetch https://queue.taskcluster.net/v1/task/D8ypfo99Tp-XInZynU7iFA/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip into memory 15:18:51 INFO - Expected file size: 16108837 15:18:51 INFO - Obtained file size: 16108837 15:18:57 INFO - Downloading packages: [u'firefox-53.0.en-US.mac.common.tests.zip', u'firefox-53.0.en-US.mac.talos.tests.zip'] for test suite category: talos 15:18:57 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/D8ypfo99Tp-XInZynU7iFA/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip 15:18:57 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/D8ypfo99Tp-XInZynU7iFA/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip'}, attempt #1 15:18:57 INFO - Fetch https://queue.taskcluster.net/v1/task/D8ypfo99Tp-XInZynU7iFA/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip into memory 15:18:58 INFO - Expected file size: 16108837 15:18:58 INFO - Obtained file size: 16108837 15:19:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/D8ypfo99Tp-XInZynU7iFA/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip 15:19:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/D8ypfo99Tp-XInZynU7iFA/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip'}, attempt #1 15:19:05 INFO - Fetch https://queue.taskcluster.net/v1/task/D8ypfo99Tp-XInZynU7iFA/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip into memory 15:19:06 INFO - Expected file size: 14403663 15:19:06 INFO - Obtained file size: 14403663 15:19:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:19:06 INFO - trying https://queue.taskcluster.net/v1/task/D8ypfo99Tp-XInZynU7iFA/artifacts/public/build/firefox-53.0.en-US.mac.dmg 15:19:06 INFO - Downloading https://queue.taskcluster.net/v1/task/D8ypfo99Tp-XInZynU7iFA/artifacts/public/build/firefox-53.0.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0.en-US.mac.dmg 15:19:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/D8ypfo99Tp-XInZynU7iFA/artifacts/public/build/firefox-53.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0.en-US.mac.dmg'}, attempt #1 15:19:08 INFO - Downloaded 58690527 bytes. 15:19:08 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/D8ypfo99Tp-XInZynU7iFA/artifacts/public/build/firefox-53.0.en-US.mac.dmg 15:19:08 INFO - mkdir: /builds/slave/test/properties 15:19:08 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:19:08 INFO - Writing to file /builds/slave/test/properties/build_url 15:19:08 INFO - Contents: 15:19:08 INFO - build_url:https://queue.taskcluster.net/v1/task/D8ypfo99Tp-XInZynU7iFA/artifacts/public/build/firefox-53.0.en-US.mac.dmg 15:19:09 INFO - Running post-action listener: _resource_record_post_action 15:19:09 INFO - Running post-action listener: set_extra_try_arguments 15:19:09 INFO - [mozharness: 2017-03-29 22:19:09.191894Z] Finished download-and-extract step (success) 15:19:09 INFO - [mozharness: 2017-03-29 22:19:09.192017Z] Running populate-webroot step. 15:19:09 INFO - Running pre-action listener: _resource_record_pre_action 15:19:09 INFO - Running main action method: populate_webroot 15:19:09 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:19:09 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:19:09 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:19:09 INFO - '--tppagecycles', 15:19:09 INFO - '7'], 15:19:09 INFO - 'tests': ['tsvgm']}}, 15:19:09 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:19:09 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:19:09 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:19:09 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:19:09 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:19:09 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:19:09 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 15:19:09 INFO - 'talos_options': ['--disable-e10s'], 15:19:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:19:09 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 15:19:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:19:09 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 15:19:09 INFO - 'talos_options': ['--disable-e10s'], 15:19:09 INFO - 'tests': ['damp', 'tps']}, 15:19:09 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 15:19:09 INFO - 'tests': ['damp', 'tps']}, 15:19:09 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:19:09 INFO - 'tests': ['dromaeo_dom']}, 15:19:09 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:19:09 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:19:09 INFO - 'tests': ['basic_compositor_video']}, 15:19:09 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:19:09 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:19:09 INFO - 'tests': ['a11yr', 15:19:09 INFO - 'ts_paint', 15:19:09 INFO - 'tpaint', 15:19:09 INFO - 'sessionrestore', 15:19:09 INFO - 'sessionrestore_no_auto_restore', 15:19:09 INFO - 'tabpaint']}, 15:19:09 INFO - 'other-e10s': {'tests': ['a11yr', 15:19:09 INFO - 'ts_paint', 15:19:09 INFO - 'tpaint', 15:19:09 INFO - 'sessionrestore', 15:19:09 INFO - 'sessionrestore_no_auto_restore', 15:19:09 INFO - 'tabpaint']}, 15:19:09 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:19:09 INFO - 'ts_paint', 15:19:09 INFO - 'tpaint', 15:19:09 INFO - 'sessionrestore', 15:19:09 INFO - 'sessionrestore_no_auto_restore', 15:19:09 INFO - 'tabpaint']}, 15:19:09 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:19:09 INFO - 'ts_paint', 15:19:09 INFO - 'tpaint', 15:19:09 INFO - 'sessionrestore', 15:19:09 INFO - 'sessionrestore_no_auto_restore', 15:19:09 INFO - 'tabpaint']}, 15:19:09 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:19:09 INFO - 'tests': ['a11yr', 15:19:09 INFO - 'ts_paint', 15:19:09 INFO - 'tpaint', 15:19:09 INFO - 'sessionrestore', 15:19:09 INFO - 'sessionrestore_no_auto_restore', 15:19:09 INFO - 'tabpaint']}, 15:19:09 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:19:09 INFO - 'tests': ['a11yr', 15:19:09 INFO - 'ts_paint', 15:19:09 INFO - 'tpaint', 15:19:09 INFO - 'sessionrestore', 15:19:09 INFO - 'sessionrestore_no_auto_restore', 15:19:09 INFO - 'tabpaint']}, 15:19:09 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:19:09 INFO - 'tests': ['tsvgx', 15:19:09 INFO - 'tsvgr_opacity', 15:19:09 INFO - 'tart', 15:19:09 INFO - 'tscrollx', 15:19:09 INFO - 'cart', 15:19:09 INFO - 'tsvg_static']}, 15:19:09 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:19:09 INFO - 'tsvgr_opacity', 15:19:09 INFO - 'tart', 15:19:09 INFO - 'tscrollx', 15:19:09 INFO - 'cart', 15:19:09 INFO - 'tsvg_static']}, 15:19:09 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 15:19:09 INFO - 'talos_options': ['--disable-e10s'], 15:19:09 INFO - 'tests': ['tp5o']}, 15:19:09 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 15:19:09 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 15:19:09 INFO - 'talos_options': ['--disable-e10s', 15:19:09 INFO - '--xperf_path', 15:19:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:19:09 INFO - 'tests': ['tp5n']}, 15:19:09 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 15:19:09 INFO - 'talos_options': ['--xperf_path', 15:19:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:19:09 INFO - 'tests': ['tp5n']}}, 15:19:09 INFO - 'talos.zip': {'path': '', 15:19:09 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:19:09 INFO - Running post-action listener: _resource_record_post_action 15:19:09 INFO - [mozharness: 2017-03-29 22:19:09.211264Z] Finished populate-webroot step (success) 15:19:09 INFO - [mozharness: 2017-03-29 22:19:09.211400Z] Running create-virtualenv step. 15:19:09 INFO - Running pre-action listener: _resource_record_pre_action 15:19:09 INFO - Running main action method: create_virtualenv 15:19:09 INFO - Creating virtualenv /builds/slave/test/build/venv 15:19:09 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 15:19:09 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:19:09 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:19:09 INFO - Using real prefix '/tools/python27' 15:19:09 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:19:10 INFO - Installing distribute.............................................................................................................................................................................................done. 15:19:13 INFO - Installing pip.................done. 15:19:13 INFO - Return code: 0 15:19:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 15:19:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 15:19:13 INFO - Reading from file tmpfile_stdout 15:19:13 INFO - Output received: 15:19:13 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 15:19:13 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:19:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:19:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:19:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:19:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:19:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:19:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:19:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10079eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1007a1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe369d6d170>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10057cd30>, '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 0x1004a3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100571be8>, '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.QcFmr5Rrnh/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.C0MpvK7zTr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/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 15:19:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 15:19:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 15:19:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QcFmr5Rrnh/Render', 15:19:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:19:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:19:13 INFO - 'HOME': '/Users/cltbld', 15:19:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:19:13 INFO - 'LOGNAME': 'cltbld', 15:19:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:19:13 INFO - 'MOZ_NO_REMOTE': '1', 15:19:13 INFO - 'NO_EM_RESTART': '1', 15:19:13 INFO - 'PAGER': '/bin/cat', 15:19:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:19:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:19:13 INFO - 'PWD': '/builds/slave/test', 15:19:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:19:13 INFO - 'SHELL': '/bin/bash', 15:19:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.C0MpvK7zTr/Listeners', 15:19:13 INFO - 'TMPDIR': '/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/', 15:19:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:19:13 INFO - 'USER': 'cltbld', 15:19:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:19:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:19:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:19:13 INFO - 'XPC_FLAGS': '0x0', 15:19:13 INFO - 'XPC_SERVICE_NAME': '0', 15:19:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:19:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:19:13 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 15:19:13 INFO - Cleaning up... 15:19:13 INFO - Return code: 0 15:19:13 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:19:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:19:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:19:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:19:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:19:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:19:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:19:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10079eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1007a1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe369d6d170>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10057cd30>, '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 0x1004a3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100571be8>, '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.QcFmr5Rrnh/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.C0MpvK7zTr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/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 15:19:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 15:19:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 15:19:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QcFmr5Rrnh/Render', 15:19:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:19:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:19:13 INFO - 'HOME': '/Users/cltbld', 15:19:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:19:13 INFO - 'LOGNAME': 'cltbld', 15:19:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:19:13 INFO - 'MOZ_NO_REMOTE': '1', 15:19:13 INFO - 'NO_EM_RESTART': '1', 15:19:13 INFO - 'PAGER': '/bin/cat', 15:19:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:19:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:19:13 INFO - 'PWD': '/builds/slave/test', 15:19:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:19:13 INFO - 'SHELL': '/bin/bash', 15:19:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.C0MpvK7zTr/Listeners', 15:19:13 INFO - 'TMPDIR': '/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/', 15:19:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:19:13 INFO - 'USER': 'cltbld', 15:19:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:19:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:19:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:19:13 INFO - 'XPC_FLAGS': '0x0', 15:19:13 INFO - 'XPC_SERVICE_NAME': '0', 15:19:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:19:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:19:13 INFO - Downloading/unpacking psutil>=3.1.1 15:19:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:19:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:19:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:19:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:19:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:19:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:19:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:19:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:19:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:19:17 INFO - Installing collected packages: psutil 15:19:17 INFO - Running setup.py install for psutil 15:19:17 INFO - building 'psutil._psutil_osx' extension 15:19:17 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 15:19:17 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 15:19:18 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 15:19:18 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 15:19:18 INFO - building 'psutil._psutil_posix' extension 15:19:18 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 15:19:18 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 15:19:18 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 15:19:18 INFO - ^ 15:19:18 INFO - 1 warning generated. 15:19:18 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 15:19:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:19:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:19:18 INFO - Successfully installed psutil 15:19:18 INFO - Cleaning up... 15:19:18 INFO - Return code: 0 15:19:18 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:19:18 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')]} 15:19:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:19:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:19:18 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')]} 15:19:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:19:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:19:18 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 0x10079eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1007a1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe369d6d170>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10057cd30>, '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 0x1004a3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100571be8>, '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.QcFmr5Rrnh/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.C0MpvK7zTr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/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 15:19:18 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 15:19:18 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 15:19:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QcFmr5Rrnh/Render', 15:19:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:19:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:19:18 INFO - 'HOME': '/Users/cltbld', 15:19:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:19:18 INFO - 'LOGNAME': 'cltbld', 15:19:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:19:18 INFO - 'MOZ_NO_REMOTE': '1', 15:19:18 INFO - 'NO_EM_RESTART': '1', 15:19:18 INFO - 'PAGER': '/bin/cat', 15:19:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:19:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:19:18 INFO - 'PWD': '/builds/slave/test', 15:19:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:19:18 INFO - 'SHELL': '/bin/bash', 15:19:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.C0MpvK7zTr/Listeners', 15:19:18 INFO - 'TMPDIR': '/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/', 15:19:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:19:18 INFO - 'USER': 'cltbld', 15:19:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:19:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:19:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:19:18 INFO - 'XPC_FLAGS': '0x0', 15:19:18 INFO - 'XPC_SERVICE_NAME': '0', 15:19:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:19:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:19:18 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:19:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:19:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:19:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:19:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:19:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:19:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:19:21 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:19:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:19:21 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:19:21 INFO - Installing collected packages: mozsystemmonitor 15:19:21 INFO - Running setup.py install for mozsystemmonitor 15:19:21 INFO - Successfully installed mozsystemmonitor 15:19:21 INFO - Cleaning up... 15:19:21 INFO - Return code: 0 15:19:21 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:19:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:19:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:19:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:19:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:19:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:19:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:19:21 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 0x10079eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1007a1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe369d6d170>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10057cd30>, '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 0x1004a3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100571be8>, '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.QcFmr5Rrnh/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.C0MpvK7zTr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/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 15:19:21 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 15:19:21 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 15:19:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QcFmr5Rrnh/Render', 15:19:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:19:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:19:21 INFO - 'HOME': '/Users/cltbld', 15:19:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:19:21 INFO - 'LOGNAME': 'cltbld', 15:19:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:19:21 INFO - 'MOZ_NO_REMOTE': '1', 15:19:21 INFO - 'NO_EM_RESTART': '1', 15:19:21 INFO - 'PAGER': '/bin/cat', 15:19:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:19:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:19:21 INFO - 'PWD': '/builds/slave/test', 15:19:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:19:21 INFO - 'SHELL': '/bin/bash', 15:19:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.C0MpvK7zTr/Listeners', 15:19:21 INFO - 'TMPDIR': '/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/', 15:19:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:19:21 INFO - 'USER': 'cltbld', 15:19:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:19:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:19:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:19:21 INFO - 'XPC_FLAGS': '0x0', 15:19:21 INFO - 'XPC_SERVICE_NAME': '0', 15:19:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:19:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:19:22 INFO - Downloading/unpacking jsonschema==2.5.1 15:19:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:19:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:19:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:19:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:19:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:19:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:19:24 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:19:24 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:19:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:19:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:19:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:19:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:19:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:19:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:19:25 INFO - Downloading functools32-3.2.3-2.tar.gz 15:19:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:19:25 INFO - warning: no files found matching '*.txt' 15:19:25 INFO - no previously-included directories found matching 'build' 15:19:25 INFO - no previously-included directories found matching 'dist' 15:19:25 INFO - no previously-included directories found matching '.git*' 15:19:25 INFO - Installing collected packages: jsonschema, functools32 15:19:25 INFO - Running setup.py install for functools32 15:19:25 INFO - warning: no files found matching '*.txt' 15:19:25 INFO - no previously-included directories found matching 'build' 15:19:25 INFO - no previously-included directories found matching 'dist' 15:19:25 INFO - no previously-included directories found matching '.git*' 15:19:25 INFO - Successfully installed jsonschema functools32 15:19:25 INFO - Cleaning up... 15:19:25 INFO - Return code: 0 15:19:25 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:19: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')]} 15:19:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:19:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:19: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')]} 15:19:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:19:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:19:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10079eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1007a1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe369d6d170>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10057cd30>, '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 0x1004a3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100571be8>, '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.QcFmr5Rrnh/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.C0MpvK7zTr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/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 15:19:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 15:19:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 15:19:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QcFmr5Rrnh/Render', 15:19:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:19:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:19:25 INFO - 'HOME': '/Users/cltbld', 15:19:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:19:25 INFO - 'LOGNAME': 'cltbld', 15:19:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:19:25 INFO - 'MOZ_NO_REMOTE': '1', 15:19:25 INFO - 'NO_EM_RESTART': '1', 15:19:25 INFO - 'PAGER': '/bin/cat', 15:19:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:19:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:19:25 INFO - 'PWD': '/builds/slave/test', 15:19:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:19:25 INFO - 'SHELL': '/bin/bash', 15:19:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.C0MpvK7zTr/Listeners', 15:19:25 INFO - 'TMPDIR': '/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/', 15:19:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:19:25 INFO - 'USER': 'cltbld', 15:19:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:19:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:19:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:19:25 INFO - 'XPC_FLAGS': '0x0', 15:19:25 INFO - 'XPC_SERVICE_NAME': '0', 15:19:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:19:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:19:25 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:19:25 INFO - Cleaning up... 15:19:25 INFO - Return code: 0 15:19:25 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:19: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')]} 15:19:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:19:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:19: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')]} 15:19:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:19:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:19:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10079eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1007a1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe369d6d170>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10057cd30>, '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 0x1004a3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100571be8>, '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.QcFmr5Rrnh/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.C0MpvK7zTr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/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 15:19:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 15:19:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 15:19:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QcFmr5Rrnh/Render', 15:19:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:19:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:19:25 INFO - 'HOME': '/Users/cltbld', 15:19:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:19:25 INFO - 'LOGNAME': 'cltbld', 15:19:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:19:25 INFO - 'MOZ_NO_REMOTE': '1', 15:19:25 INFO - 'NO_EM_RESTART': '1', 15:19:25 INFO - 'PAGER': '/bin/cat', 15:19:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:19:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:19:25 INFO - 'PWD': '/builds/slave/test', 15:19:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:19:25 INFO - 'SHELL': '/bin/bash', 15:19:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.C0MpvK7zTr/Listeners', 15:19:25 INFO - 'TMPDIR': '/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/', 15:19:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:19:25 INFO - 'USER': 'cltbld', 15:19:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:19:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:19:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:19:25 INFO - 'XPC_FLAGS': '0x0', 15:19:25 INFO - 'XPC_SERVICE_NAME': '0', 15:19:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:19:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:19:26 INFO - Downloading/unpacking blobuploader==1.2.4 15:19:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:19:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:19:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:19:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:19:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:19:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:19:28 INFO - Downloading blobuploader-1.2.4.tar.gz 15:19:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:19:28 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:19:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:19:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:19:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:19:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:19:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:19:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:19:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:19:29 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:19:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:19:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:19:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:19:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:19:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:19:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:19:29 INFO - Downloading docopt-0.6.1.tar.gz 15:19:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:19:30 INFO - Installing collected packages: blobuploader, requests, docopt 15:19:30 INFO - Running setup.py install for blobuploader 15:19:30 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:19:30 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:19:30 INFO - Running setup.py install for requests 15:19:30 INFO - Running setup.py install for docopt 15:19:30 INFO - Successfully installed blobuploader requests docopt 15:19:30 INFO - Cleaning up... 15:19:30 INFO - Return code: 0 15:19:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:19:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:19:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:19:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:19:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:19:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:19:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:19:30 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 0x10079eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1007a1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe369d6d170>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10057cd30>, '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 0x1004a3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100571be8>, '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.QcFmr5Rrnh/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.C0MpvK7zTr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/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 15:19:30 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 15:19:30 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 15:19:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QcFmr5Rrnh/Render', 15:19:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:19:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:19:30 INFO - 'HOME': '/Users/cltbld', 15:19:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:19:30 INFO - 'LOGNAME': 'cltbld', 15:19:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:19:30 INFO - 'MOZ_NO_REMOTE': '1', 15:19:30 INFO - 'NO_EM_RESTART': '1', 15:19:30 INFO - 'PAGER': '/bin/cat', 15:19:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:19:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:19:30 INFO - 'PWD': '/builds/slave/test', 15:19:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:19:30 INFO - 'SHELL': '/bin/bash', 15:19:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.C0MpvK7zTr/Listeners', 15:19:30 INFO - 'TMPDIR': '/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/', 15:19:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:19:30 INFO - 'USER': 'cltbld', 15:19:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:19:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:19:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:19:30 INFO - 'XPC_FLAGS': '0x0', 15:19:30 INFO - 'XPC_SERVICE_NAME': '0', 15:19:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:19:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:19:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:19:31 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-z562mn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:19:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:19:31 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-E97iUg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:19:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:19:31 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-l528_b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:19:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:19:31 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-ea0aTB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:19:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:19:31 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-aOIZRW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:19:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:19:31 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-KJ9oLG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:19:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:19:31 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-fJj5nI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:19:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:19:31 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-tx_wDT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:19:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:19:32 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-GFhxOO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:19:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:19:32 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-TFTZss-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:19:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:19:32 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-BlTTt2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:19:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:19:32 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-t3SVA4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:19:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:19:32 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-KyKIEB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:19:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:19:32 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-8T_WOc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:19:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:19:32 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-2KpYj1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:19:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:19:32 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-Lxa2Dd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:19:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:19:32 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-vPyDmo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:19:32 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:19:32 INFO - Running setup.py install for manifestparser 15:19:33 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:19:33 INFO - Running setup.py install for mozcrash 15:19:33 INFO - Running setup.py install for mozdebug 15:19:33 INFO - Running setup.py install for mozdevice 15:19:33 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:19:33 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:19:33 INFO - Running setup.py install for mozfile 15:19:33 INFO - Running setup.py install for mozhttpd 15:19:33 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:19:33 INFO - Running setup.py install for mozinfo 15:19:33 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:19:33 INFO - Running setup.py install for mozInstall 15:19:34 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:19:34 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:19:34 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:19:34 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:19:34 INFO - Running setup.py install for mozleak 15:19:34 INFO - Running setup.py install for mozlog 15:19:34 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:19:34 INFO - Running setup.py install for moznetwork 15:19:34 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:19:34 INFO - Running setup.py install for mozprocess 15:19:34 INFO - Running setup.py install for mozprofile 15:19:34 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:19:34 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:19:34 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:19:34 INFO - Running setup.py install for mozrunner 15:19:35 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:19:35 INFO - Running setup.py install for mozscreenshot 15:19:35 INFO - Running setup.py install for moztest 15:19:35 INFO - Running setup.py install for mozversion 15:19:35 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:19:35 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:19:35 INFO - Cleaning up... 15:19:35 INFO - Return code: 0 15:19:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:19: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')]} 15:19:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:19:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:19: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')]} 15:19:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:19:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:19:35 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 0x10079eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1007a1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe369d6d170>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10057cd30>, '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 0x1004a3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100571be8>, '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.QcFmr5Rrnh/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.C0MpvK7zTr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/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 15:19:35 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 15:19:35 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 15:19:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QcFmr5Rrnh/Render', 15:19:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:19:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:19:35 INFO - 'HOME': '/Users/cltbld', 15:19:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:19:35 INFO - 'LOGNAME': 'cltbld', 15:19:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:19:35 INFO - 'MOZ_NO_REMOTE': '1', 15:19:35 INFO - 'NO_EM_RESTART': '1', 15:19:35 INFO - 'PAGER': '/bin/cat', 15:19:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:19:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:19:35 INFO - 'PWD': '/builds/slave/test', 15:19:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:19:35 INFO - 'SHELL': '/bin/bash', 15:19:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.C0MpvK7zTr/Listeners', 15:19:35 INFO - 'TMPDIR': '/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/', 15:19:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:19:35 INFO - 'USER': 'cltbld', 15:19:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:19:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:19:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:19:35 INFO - 'XPC_FLAGS': '0x0', 15:19:35 INFO - 'XPC_SERVICE_NAME': '0', 15:19:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:19:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:19:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:19:35 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-enKkn8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:19:35 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)) 15:19:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:19:35 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-FCN6mH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:19:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 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)) 15:19:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:19:36 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-EBscXx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:19:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 15:19:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:19:36 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-t9ChrN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:19:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 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)) 15:19:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:19:36 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-N8p2Iz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:19:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 15:19:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:19:36 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-6Ly23o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:19:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 15:19:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:19:36 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-J8292Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:19:36 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)) 15:19:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:19:36 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-NG4tid-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:19:36 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)) 15:19:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:19:36 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-mOzZEW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:19:36 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)) 15:19:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:19:36 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-blpNS7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:19:36 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)) 15:19:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:19:36 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-pLE6uO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:19:36 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)) 15:19:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:19:36 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-xxWo_b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:19:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 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)) 15:19:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:19:37 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-mn19Ek-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:19:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 15:19:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:19:37 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-Y31qHa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:19:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 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)) 15:19:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:19:37 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-BS1lHO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:19:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 15:19:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:19:37 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-9vB0NV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:19:37 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 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)) 15:19:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:19:37 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-8G29MY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:19:37 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)) 15:19:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:19:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:19:37 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)) 15:19:37 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:19:37 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:19:37 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:19:37 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 15:19:37 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 15:19:37 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 15:19:37 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 15:19:37 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 15:19:37 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 15:19:40 INFO - Downloading blessings-1.6.tar.gz 15:19:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:19:40 INFO - Installing collected packages: blessings 15:19:40 INFO - Running setup.py install for blessings 15:19:40 INFO - Successfully installed blessings 15:19:40 INFO - Cleaning up... 15:19:41 INFO - Return code: 0 15:19:41 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:19:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:19:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:19:41 INFO - Reading from file tmpfile_stdout 15:19:41 INFO - Current package versions: 15:19:41 INFO - blessings == 1.6 15:19:41 INFO - blobuploader == 1.2.4 15:19:41 INFO - docopt == 0.6.1 15:19:41 INFO - functools32 == 3.2.3-2 15:19:41 INFO - jsonschema == 2.5.1 15:19:41 INFO - manifestparser == 1.1 15:19:41 INFO - mozInstall == 1.12 15:19:41 INFO - mozcrash == 1.0 15:19:41 INFO - mozdebug == 0.1 15:19:41 INFO - mozdevice == 0.49 15:19:41 INFO - mozfile == 1.2 15:19:41 INFO - mozhttpd == 0.7 15:19:41 INFO - mozinfo == 0.9 15:19:41 INFO - mozleak == 0.1 15:19:41 INFO - mozlog == 3.4 15:19:41 INFO - moznetwork == 0.27 15:19:41 INFO - mozprocess == 0.24 15:19:41 INFO - mozprofile == 0.28 15:19:41 INFO - mozrunner == 6.13 15:19:41 INFO - mozscreenshot == 0.1 15:19:41 INFO - mozsystemmonitor == 0.3 15:19:41 INFO - moztest == 0.8 15:19:41 INFO - mozversion == 1.4 15:19:41 INFO - psutil == 3.1.1 15:19:41 INFO - requests == 1.2.3 15:19:41 INFO - wsgiref == 0.1.2 15:19:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:19:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:19:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:19:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:19:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:19:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:19:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:19:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10079eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1007a1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe369d6d170>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10057cd30>, '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 0x1004a3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100571be8>, '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.QcFmr5Rrnh/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.C0MpvK7zTr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/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 15:19:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 15:19:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:19:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QcFmr5Rrnh/Render', 15:19:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:19:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:19:41 INFO - 'HOME': '/Users/cltbld', 15:19:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:19:41 INFO - 'LOGNAME': 'cltbld', 15:19:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:19:41 INFO - 'MOZ_NO_REMOTE': '1', 15:19:41 INFO - 'NO_EM_RESTART': '1', 15:19:41 INFO - 'PAGER': '/bin/cat', 15:19:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:19:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:19:41 INFO - 'PWD': '/builds/slave/test', 15:19:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:19:41 INFO - 'SHELL': '/bin/bash', 15:19:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.C0MpvK7zTr/Listeners', 15:19:41 INFO - 'TMPDIR': '/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/', 15:19:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:19:41 INFO - 'USER': 'cltbld', 15:19:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:19:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:19:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:19:41 INFO - 'XPC_FLAGS': '0x0', 15:19:41 INFO - 'XPC_SERVICE_NAME': '0', 15:19:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:19:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:19:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 15:19:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 15:19:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 15:19:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 15:19:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 15:19:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 15:19:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 15:19:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 15:19:41 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 15:19:41 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 15:19:41 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 15:19:41 INFO - Cleaning up... 15:19:41 INFO - Return code: 0 15:19:41 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:19:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:19:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:19:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:19:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:19:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:19:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:19:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10079eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1007a1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe369d6d170>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10057cd30>, '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 0x1004a3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100571be8>, '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.QcFmr5Rrnh/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.C0MpvK7zTr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/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 15:19:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 15:19:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 15:19:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QcFmr5Rrnh/Render', 15:19:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:19:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:19:41 INFO - 'HOME': '/Users/cltbld', 15:19:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:19:41 INFO - 'LOGNAME': 'cltbld', 15:19:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:19:41 INFO - 'MOZ_NO_REMOTE': '1', 15:19:41 INFO - 'NO_EM_RESTART': '1', 15:19:41 INFO - 'PAGER': '/bin/cat', 15:19:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:19:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:19:41 INFO - 'PWD': '/builds/slave/test', 15:19:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:19:41 INFO - 'SHELL': '/bin/bash', 15:19:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.C0MpvK7zTr/Listeners', 15:19:41 INFO - 'TMPDIR': '/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/', 15:19:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:19:41 INFO - 'USER': 'cltbld', 15:19:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:19:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:19:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:19:41 INFO - 'XPC_FLAGS': '0x0', 15:19:41 INFO - 'XPC_SERVICE_NAME': '0', 15:19:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:19:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:19:42 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:19:42 INFO - Cleaning up... 15:19:42 INFO - Return code: 0 15:19:42 INFO - Running post-action listener: _resource_record_post_action 15:19:42 INFO - Running post-action listener: _start_resource_monitoring 15:19:42 INFO - Starting resource monitoring. 15:19:42 INFO - [mozharness: 2017-03-29 22:19:42.200458Z] Finished create-virtualenv step (success) 15:19:42 INFO - [mozharness: 2017-03-29 22:19:42.201380Z] Running install step. 15:19:42 INFO - Running pre-action listener: _resource_record_pre_action 15:19:42 INFO - Running main action method: install 15:19:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:19:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:19:42 INFO - Reading from file tmpfile_stdout 15:19:42 INFO - Detecting whether we're running mozinstall >=1.0... 15:19:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:19:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:19:42 INFO - Reading from file tmpfile_stdout 15:19:42 INFO - Output received: 15:19:42 INFO - Usage: mozinstall [options] installer 15:19:42 INFO - Options: 15:19:42 INFO - -h, --help show this help message and exit 15:19:42 INFO - -d DEST, --destination=DEST 15:19:42 INFO - Directory to install application into. [default: 15:19:42 INFO - "/builds/slave/test"] 15:19:42 INFO - --app=APP Application being installed. [default: firefox] 15:19:42 INFO - mkdir: /builds/slave/test/build/application 15:19:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 15:19:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0.en-US.mac.dmg --destination /builds/slave/test/build/application 15:19:57 INFO - Reading from file tmpfile_stdout 15:19:57 INFO - Output received: 15:19:57 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 15:19:57 INFO - Running post-action listener: _resource_record_post_action 15:19:57 INFO - [mozharness: 2017-03-29 22:19:57.286447Z] Finished install step (success) 15:19:57 INFO - [mozharness: 2017-03-29 22:19:57.286590Z] Running run-tests step. 15:19:57 INFO - Running pre-action listener: _resource_record_pre_action 15:19:57 INFO - Running main action method: run_tests 15:19:57 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:19:57 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:19:57 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:19:57 INFO - 2017-03-29 15:19:57.301 screenresolution[1632:7384] starting screenresolution argv=screenresolution get 15:19:57 INFO - 2017-03-29 15:19:57.303 screenresolution[1632:7384] Display 0: 1600x1200x32@60 15:19:57 INFO - 2017-03-29 15:19:57.309 screenresolution[1633:7386] starting screenresolution argv=screenresolution list 15:19:57 INFO - Available Modes on Display 0 15:19:57 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:19:57 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:19:57 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:19:57 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:19:57 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:19:57 INFO - Intel Iris: 15:19:57 INFO - Chipset Model: Intel Iris 15:19:57 INFO - Type: GPU 15:19:57 INFO - Bus: Built-In 15:19:57 INFO - VRAM (Dynamic, Max): 1536 MB 15:19:57 INFO - Vendor: Intel (0x8086) 15:19:57 INFO - Device ID: 0x0a2e 15:19:57 INFO - Revision ID: 0x0009 15:19:57 INFO - Displays: 15:19:57 INFO - Display: 15:19:57 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:19:57 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:19:57 INFO - Display Serial Number: 1600x1200 60 15:19:57 INFO - Main Display: Yes 15:19:57 INFO - Mirror: Off 15:19:57 INFO - Online: Yes 15:19:57 INFO - Rotation: Supported 15:19:57 INFO - Return code: 0 15:19:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:19:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:19:57 INFO - Python 2.7.3 15:19:57 INFO - Return code: 0 15:19:57 INFO - grabbing minidump binary from tooltool 15:19: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')]} 15:19:57 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 0x10057cd30>, '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 0x1004a3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100571be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:19:57 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 15:19:57 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 15:19:57 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 15:19:57 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:19:57 INFO - Return code: 0 15:19:57 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 15:19:57 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:19:57 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:19:57 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 15:19:57 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:19:57 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/D8ypfo99Tp-XInZynU7iFA/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0367', '--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 15:19:57 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/D8ypfo99Tp-XInZynU7iFA/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0367 --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 15:19:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QcFmr5Rrnh/Render', 15:19:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:19:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:19:57 INFO - 'HOME': '/Users/cltbld', 15:19:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:19:57 INFO - 'LOGNAME': 'cltbld', 15:19:57 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:19:57 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 15:19:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:19:57 INFO - 'MOZ_NO_REMOTE': '1', 15:19:57 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:19:57 INFO - 'NO_EM_RESTART': '1', 15:19:57 INFO - 'PAGER': '/bin/cat', 15:19:57 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:19:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:19:57 INFO - 'PWD': '/builds/slave/test', 15:19:57 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:19:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:19:57 INFO - 'SHELL': '/bin/bash', 15:19:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.C0MpvK7zTr/Listeners', 15:19:57 INFO - 'TMPDIR': '/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/', 15:19:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:19:57 INFO - 'USER': 'cltbld', 15:19:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:19:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:19:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:19:57 INFO - 'XPC_FLAGS': '0x0', 15:19:57 INFO - 'XPC_SERVICE_NAME': '0', 15:19:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:19:57 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/D8ypfo99Tp-XInZynU7iFA/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0367', '--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 15:19:57 INFO - mozversion application_buildid: 20170329135122 15:19:57 INFO - mozversion application_changeset: 7230f94c609b6a000ad6696f2db85b2f79e36e61 15:19:57 INFO - mozversion application_display_name: Firefox 15:19:57 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:19:57 INFO - mozversion application_name: Firefox 15:19:57 INFO - mozversion application_remotingname: firefox 15:19:57 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 15:19:57 INFO - mozversion application_vendor: Mozilla 15:19:57 INFO - mozversion application_version: 53.0 15:19:57 INFO - mozversion platform_buildid: 20170329135122 15:19:57 INFO - mozversion platform_changeset: 7230f94c609b6a000ad6696f2db85b2f79e36e61 15:19:57 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 15:19:57 INFO - mozversion platform_version: 53.0 15:19:57 INFO - using testdate: 1490825997 15:19:57 INFO - actual date: 1490825997 15:19:57 INFO - starting webserver on 'localhost:49251' 15:19:57 INFO - SUITE-START | Running 2 tests 15:19:57 INFO - TEST-START | dromaeo_css 15:19:57 INFO - operating with platform_type : mac_ 15:19:57 INFO - Initialising browser for dromaeo_css test... 15:19:57 INFO - TEST-INFO | started process 1643 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/tmp1FuOx7/profile http://localhost:49251/getInfo.html) 15:20:00 INFO - PROCESS | 1643 | __metrics Screen width/height:1600/1200 15:20:00 INFO - PROCESS | 1643 | colorDepth:24 15:20:00 INFO - PROCESS | 1643 | Browser inner width/height: 1024/689 15:20:00 INFO - PROCESS | 1643 | __metrics 15:20:00 INFO - PROCESS | 1643 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 15:20:00 INFO - PROCESS | 1643 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:20:01 INFO - TEST-INFO | 1643: exit 0 15:20:01 INFO - Browser initialized. 15:20:01 INFO - Running cycle 1/1 for dromaeo_css test... 15:20:01 INFO - TEST-INFO | started process 1646 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/tmp1FuOx7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:20:13 INFO - PROCESS | 1646 | RSS: Main: 167075840 15:20:13 INFO - PROCESS | 1646 | 15:23:15 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49251/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49251/tests/dromaeo/cssquery-ext.html) 15:23:17 INFO - PROCESS | 1646 | RSS: Main: 318062592 15:23:17 INFO - PROCESS | 1646 | 15:26:20 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49251/tests/dromaeo/cssquery-ext.html (next: http://localhost:49251/tests/dromaeo/cssquery-jquery.html) 15:26:20 INFO - PROCESS | 1646 | RSS: Main: 309035008 15:26:20 INFO - PROCESS | 1646 | 15:29:23 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49251/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49251/tests/dromaeo/cssquery-mootools.html) 15:29:23 INFO - PROCESS | 1646 | RSS: Main: 303169536 15:29:23 INFO - PROCESS | 1646 | 15:32:25 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49251/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49251/tests/dromaeo/cssquery-prototype.html) 15:32:26 INFO - PROCESS | 1646 | RSS: Main: 282267648 15:32:26 INFO - PROCESS | 1646 | 15:35:29 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49251/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49251/tests/dromaeo/cssquery-yui.html) 15:35:30 INFO - PROCESS | 1646 | RSS: Main: 268877824 15:35:30 INFO - PROCESS | 1646 | 15:38:33 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49251/tests/dromaeo/cssquery-yui.html (next: http://localhost:49251/tests/dromaeo/cssquery-dojo.html) 15:38:34 INFO - PROCESS | 1646 | RSS: Main: 449273856 15:38:34 INFO - PROCESS | 1646 | 15:38:34 INFO - PROCESS | 1646 | __start_tp_report 15:38:34 INFO - PROCESS | 1646 | _x_x_mozilla_page_load 15:38:34 INFO - PROCESS | 1646 | _x_x_mozilla_page_load_details 15:38:34 INFO - PROCESS | 1646 | |i|pagename|runs| 15:38:34 INFO - PROCESS | 1646 | |0;dojo.html;3213.9999999999986;3271.7055465008148;3280.5735254416923;3388.8983330500087;3429;5686.4597863203035;5713.542916566675;5741.62679425837;5743.856403589913;5745.770169193227;5566.053770858954;5585.776568937237;5684.744186511606;5741.339745929219;5755.68343741094;5223.112070947929;5253.474652534745;5260.789568417278;5262.184361423985;5307.628466007381;5171.922421163686;5174.09453345663;5174.974125129388;5316.574674026068;5335.599830012765;5229.686218826882;5231.319928409321;5256.395514515842;5276.419593844674;5350.759215835296;5272.947270527284;5276.472352764731;5280.313559237313;5281.551068159211;5286.788528458857;5111.897762044739;5184.611154163415;5250.842474725764;5277.6041796865;5307.416184219733;5592;5613.326400831886;5673.347565030033;5719.885602287973;5724.398938111522;6212.1303017577575;6216.937830621681;6251.624902505864;6259.655718935457;6278.811635650938;6237.438630523275;6275.309715931244;6278.529110316745;6291.370862913718;6308.747650093991;5735.2257445245195;5911.379305172981;5949.940500594982;5961.791337303173;5972.223610930551;6193.938060619426;6241.282252540925;6256.280527739277;6271;6302.023186406114;6188.845278867974;6192.659403732748;6195.101710251988;6199.907001394983;6210;6202.627842329474;6260.906086408708;6272.2159730033745;6285.622862628257;6290.968545157245;6119.877602447926;6128.872947855148;6129.328227221949;6145.139680444741;6230.065490176419;6218.720157592919;6252.843678908063;6273.811785646438;6290.591111577733;6298.244210694655;4604.792784324646;4738.573528382462;5020.899582008413;5025.422076461181;5034.521720436553;4404.647628189801;4454.109178164315;4463.263561512379;4525.547445255514;4532.7280363178315;5582.218489411485;5614.466625670555;5623.550115990711;5637.774489020475;5684.551617199701;6292.590981586182;6300.7479700811455;6302.464290535264;6302.810915672537;6303.401176888188;5584;5632.04255276604;5676.148577713376;5736.942630573641;5759.366469688331;5286.97356513215;5417.539509141767;5446.863828404243;5481.780728770885;5482.862928426742;6238.968805156127;6270.811875643738;6284.962981108158;6289.465395441439;6302.180716506917;6302.873942521032;6304.432601065926;6310.085037669604;6331.778387756406;6357.427831495188;6196.194494715658;6215.285242197205;6243.094751260951;6270.404311590391;6327.367263273636;6153.969230153821;6244.812655620339;6249.156363890998;6253.3121356651645;6258.874822503433;6307.653079080695;6313.021481670348;6320.08358787964;6326;6336.334684858208;6027.035674292268;6092.238470191226;6121.326654068138;6169.907451388322;6208.037754148114;6022.066579680157;6056.273247210363;6080.422359875804;6083.239595050619;6145.217886812774;5986.341502434816;5990.34106248321;5996.580239383201;6022.45797878193;6046.153538504701;5916.526677865846;6075.179850720273;6098.908516372169;6128.111423843428;6188;5853.385394533512;5909.23179986599;5953;5967.880642387215;5981 15:38:34 INFO - PROCESS | 1646 | |1;ext.html;493.51388881951294;513.2788432252685;520.4379270387981;531.6092671886163;556.1907424697066;31707.841460792693;43356.78321608392;45276.320855187114;45322.733863306865;45403;44084.11831763371;44364;44420;44554.55445445544;44601.553984460144;8997.820043599124;9204.125608067223;9500.57247423866;9719.56261968213;9738.610455581804;11591.246568973032;11842.052635789116;11852.7629447411;12012.519499220021;12019.338936358497;11839.408029598486;11859.940700296487;11897.643070707893;11916.344601046982;11972.521099156023;11789.882101179008;11871;11874.881251187508;11876.465559049777;11877.16859819813;11583.362915039754;11654.766904661945;11742.295462272292;11753.588624398191;11756.177067605271;34083.4887476688;41006;41649.1670166598;42019;42033;4030.161594170478;4064.309067458539;4090.2637525245445;4109.630133287988;4129.566395528486;30921.845390773127;31527.84236078828;31743;32785.6721432785;33217.83391083029;3231.337575796956;3309.5366648669205;3360.41192791263;3394.0835974286806;3488.9825550872083;493608.53195734153;494576;494823;495279;495317;58807;60649;61658.38341616616;66902;67052.99420508598;67827.32172678309;67921.66039169772;69770;69870;70068;17290.22194001273;17537.210825512884;17569.385071522436;17602.031888246012;17614.823851761575;12430.813537796941;12658.177218480769;12695.428705708266;13155.473781048842;13252.867471325357;18045;18235.817641823676;18341.7248741269;18354;18439.985800780818;7466.85066298671;7527.435442341846;7532.359749421251;7539.170691223961;7569.772906812805;739.9667014984338;858.7295002074327;859.5100792548187;873.9113518690335;901.1169054326797;30322.393552128833;30374.848125759672;30481.085567433012;30884.53673194904;31047.68952310448;923.9676611318572;1065.648336049102;1072.1958531101673;1108.2187058124002;1180.8996235320094;15935.282912268976;15958;16052.518424447286;16153.273102710406;16400.917995409945;625259;629128;629666;629764;630016;61573.69213153995;61732.38267617267;61819.38180618226;61826.0726089109;61923.761524770154;1336.3318340829585;1393.4078016843005;1439.899207055538;1479.896407251482;1514.7424937760607;30195.61180342223;31809.522857157623;32346.8678596248;32848.671513284564;33199.33601327911;51986.740066299426;52546.73726631342;52782.736086319324;53328.66678333073;53481.465185347646;436362;436712;436987;437315;438542.8072859615;32920;37220.62779372172;37260;38464.61535384722;38620;46902.76548617235;47144.58566243018;47869.76065119652;48618.75690621524;49545;31193;31930.20174495656;32645.510317344782;32956.17609559684;32969.17577060593;26035.349116271485;32758.181045474055;33593.66406336003;34030.65969340374;34228.315433691685;37550.624493754716;38272.808635956644;38836.805815970736;39017;39210.60789392069;32951;32966.34067318688;32967.83516082404;33173.66826331706;34070.14824629404;25534.744652553978;25573.104941326965;25782.613260801478;26105.477890442464;26174 15:38:34 INFO - PROCESS | 1646 | |2;jquery.html;392.5936655561493;396.97419667721596;399.7301821270645;404.2723098422839;425.0797024442083;20692.172313107458;21796.128154873804;22084.558308833835;22089.558208835813;22138.667919981173;22215.22246721365;22237;22673.319800405974;22962.65556016661;23197.652035219486;5356.464353564651;5915.438033386832;6087.11736798164;6221.471174950112;6237.968810155943;5293.8941221175555;5786.392428794979;6109.938900611004;6175.47508461779;6181.783637572686;6127.1728316677345;6134.386561343875;6141.754329826802;6144.2319710036245;6148.6310821350635;5202.687838729688;5839.970800145993;5921.585489015771;6013.338532761437;6154.415330543591;5167.457416971201;5378.650387724785;5383.2732581101445;5384.946150538483;5386.48828361305;26819.865900670567;27020.1893943182;27025.86487067552;27217.45565088687;27351.589726154125;2569.4347243606376;2786.150224181624;2817.9013734519194;2819.84490853003;2820.0411859967503;10195.133413659774;10554.155667546578;10693.732656683567;10751.462426878625;10853.620123295726;1824.4617837737899;1862.6367858267643;1867.6918308479085;1875.4842418334931;1910.5987742573936;129487.35256323752;130899.34550327282;137498;145639;146259;11756;11930.940345298219;12012.399380030964;12041.578544750892;12297.815532767016;16299.103549304902;16331;16356.591085222964;16376.263068161961;16397.344106235618;8993.640254389751;9150.86273705895;9162.770930726785;9185.438475459188;9313.90686093144;9004.234640055538;9006.369554131148;9010.369274150878;9186.724398268063;9206.309526785519;4829.372181616438;4907.435644900882;4908.361912951294;5008.724520151427;5058.544730974157;1965.665836807746;2000.648265888742;2024.5647185854818;2025.908834102469;2035.7149998999855;699.8215455058927;710.8711879656148;790.2690011739119;907.9137481939205;965.2278177458146;21270;22549.323520294416;22760.772392276198;23068.653970190462;23141.305760827203;947.5025611553989;952;965.932384733076;987.4568987057233;998.610541888664;9535.284853636005;9812.067853553901;9898.851517227247;11411.087113030937;11830;562672;597368;762528;799193;807035;164402;167384;173112;177273;180651;1046.8900765419673;1050.76883085721;1103.2332528892503;1104.812181929074;1108.8558487396588;19977.700334495286;19979.900100499406;20597.89701051485;20763.79236207679;20865.89567052155;59545.10682339682;61048.38951610427;61285;61603;61818.763624728155;89594;89942;91709.08290917006;93890;94628;8227.095019547965;8475.237228649452;8549.358798090043;8748.08145144776;8787.604557795043;10414.479276036016;12944.41750121228;12957.416916238602;13044.804327935279;13208.339583021003;11150.386728729673;11210.887891120985;11412.942935285271;11649.708757281136;11687.824682629598;10555.419451930218;10593.205509586658;10702.357858528514;10952;11064.612738554111;6269.717862696099;9328.39365441244;9546.427214366882;11071.1696622752;11165.218434709492;8314;8600.13998600135;8626.094260102598;8785.956070219609;8792.208701216921;9497.335186537153;9842.212622990286;11225.270357426742;11260.831087533857;11545.249558778652 15:38:34 INFO - PROCESS | 1646 | |3;mootools.html;1445.5157522230052;1453.7819327100933;1457.0893191755154;1481.3556103095148;1495.244901324831;8244;8633;8645.956770216157;8649.394542382028;8680.175383338588;7631.694732210705;7857.960710196441;7869.960650196741;7952.880706789403;8459.703910363138;2131.1049359269105;2194.9451263718374;2289.645105008726;2346.061575369857;2368.763123687626;2403.7716416940452;2404.3530181825417;2405.4707964247837;2411.4212588978608;2412.8069754419603;2315.548468048731;2336.2290444153386;2347.1432926981615;2348.7886090251873;2349.166046053652;2001.6196922584663;2322.036354912709;2338.1115176233093;2340.6020976434047;2362.9409264768433;2302.781235782598;2303.9424014399606;2320.756320586348;2333.1367394064137;2336.497653004612;8479.74560763172;8539.444936079135;8570.528620925847;8614.698485553039;8638.870416943751;5125.615578831603;5316.73416329182;5322.441143679896;5325.387580428262;5330.360356757175;3465.4455287154187;3479.9652003479896;3531.7174626030114;3532.4701294805727;3559.537260156189;1210.6973256685828;1211.715246916974;1233.0628722171125;1260.2438536877892;1260.7352455984255;10830.72923176919;11055.72360690981;11145.609903653414;11148.777024459465;11150.609728659458;4430.579094985971;4685.4143232095985;4805.399325084364;4806.7836947337455;4808.3027960946165;9670.178034867115;9674.322797404115;9694.321397502248;9701.17540009093;9703;4570.9314360284625;5247.924175544004;5365.946340536545;5382.67703937765;5394.217838413408;4839.153148199051;4892.168331383673;4965.553100220997;4967.751612419437;4984.7258400788305;3717.1636381814415;3811.8856434306463;3812.8856134316015;3930;3947.763134211899;1265.9177153485177;1266.0631132961726;1268.1756858042347;1279.7248591552675;1284.6916739982523;907.7821322882593;920.889493260813;922.9847168115019;930.9348345615878;954.3033585482636;5609.859753506195;5636.167644443542;5843.415658434123;5881.05903055509;5910.586258961917;965.888922773876;987.6493844685033;1004.4023805835516;1015.0712098430001;1034.4982683398546;3312.3044160726035;3566.375884220251;3733.626637336299;3827.9617203827606;3891.6497515223764;9936;10102;10221.897781022244;10235.181185505142;10252.897471025344;10167.28828981979;10177.694669159937;10192.286539942133;10196.694099177037;10211.132053775513;7558;7949.443538952218;8104.392170587112;8122.147174546588;8141.470804397695;5505.779768809363;5558;5587.217789509553;5670.177824215548;5722.599418040863;9239.676611318571;9335.626574936927;9387.397957661828;9410.623575057194;9475.668351607661;7896.881546776688;9431.434113953184;9666.806663866824;9673.564689589126;9766.36518626287;6804;6838.076859624086;6906.965465172642;6987.9301206987275;6995.055667484824;7261.455390845602;7506.099268087864;7521.924780752122;7914.366850652049;7949.3243074339325;6416.197975253093;6689.49828762835;6887;7003.054587630605;7257.346838784535;5862.443067908542;6849.657517124224;6962.060121883481;6980.650967451708;6991.161060672752;6160.907586386297;6166.691665416801;6234.251889773256;6235.501159907287;6239.75040998355;5010.749462526786;5060.645754797129;5080;5080.187170052922;5092.159793634009;4992.575631071254;5019.347484827095;5146.099432599205;5210.426853046238;5210.6613070150315 15:38:34 INFO - PROCESS | 1646 | |4;prototype.html;362.4653635887065;362.83491011589723;372.29078605256984;380.2243423416231;382.54095085896915;5085.949140508594;5333.466653334664;5401.891962160759;5425.7287135643155;5434.375046869606;4515;4997.475265097167;5229.150113188312;5275.947240527594;5418.756155972981;3308.7518436117266;4188.24611569918;4200.537940826506;4241.766702831343;4248.532661407243;4189.716604450582;4199.9370009449885;4253.914921701564;4265.758023901826;4309.956900430987;3469.8265086745687;3985.60143985602;4178.770167640779;4186.623203911648;4222.68329875259;3914.8042597869994;4156.545209176794;4180.435641188431;4188.497380314382;4189.937150942738;3131.937361252762;3708.592054873962;3716.0524066363173;3722.4602432647384;3734.775913445202;4257.169851878885;5074.238864170367;5241.240020197089;5265.341832270966;5296.92054619181;3572.4105522588743;4176.893123322322;4657.161710892038;4827.468978412372;4838.346823178861;4686.718796872165;5505.284313039279;5641.012822756002;5642.6614403135945;5658.688772117532;3631.7457777955556;4113.526944401402;4125.23683118621;4150.211459822624;4152.418661387408;5576.804811831607;5801.7099145042575;5886;5888.911666325009;5914.704264786787;4197.895052623709;4204.3693445982735;4216.3464662977285;4217.810198541073;4231.894202644897;3921.7254792164276;4260.8721738347895;4282.571742825692;4303.935440968388;4305.268104422255;3770.9832134293006;3834.5973672764517;4712.575868171881;4778.296615581074;4806.303086052503;4715.599174070242;5619.269494965628;5627.861412663244;5644.379118297066;5678.829635110953;1292.1019891175542;1317.7349744245632;1368.9520866769615;1389.298404305819;1398.6782490546336;885.5660726244223;888.9911100889037;926.2775035472342;932.7248461703814;935.8923723771717;4110.759635998388;4543.818247270138;4543.977280113579;4840.080384726891;4927.359443272351;4897.555221209752;5015.097282489114;5074.16276314404;5111.616628752859;5480.301106656949;4793.352897358882;4900.509949005071;4904.779284932187;5126.641135120581;5187.584993200535;2767.9308017299727;2894.6526416830116;2906.302487403008;2908.941821163607;2913.8543072846273;4818.915743957652;5579.218909352694;5618.269624948731;5664.603477756517;5678;4702.8960885815195;5023.538466151633;5610;5618.39875635442;5677.687727174963;4724;4761.643096566603;5454.318210223722;5520.613557051048;5610.887782244414;4390.34144878258;5014.473480284663;5132.3327967364;5490.752916118704;5530.529904958124;4430.734155950653;4797.976010119927;5059.546120131659;5167.32062079818;5241.528262456397;4930.778114984906;5574.888502230014;5589.357223919302;5597.832065038056;5612.7193640317;3219.5331676907185;3314.9502757458176;3530.223350862806;3671.3391589514144;3680.6319368062977;4635.51327110662;4729.69256998294;5445.128779395278;5445.700486473123;5485.424030476743;4664.603508701798;5080.942218401553;5245.816396426107;5290.761915713879;5292.41783403833;4161.91676166481;4562.064776720698;4740.265258884879;4796.56830885222;5175.81884634036;4385.824567017411;5167.509086636764;5189;5207.270982062439;5278.310940499157;4997.8504943863845;5369.167778994262;5421.756020978986;5537.944620553904;5553.583481238842;4345.391645169742;5033.6476446648385;5129.922716229634;5422.834090670524;5453.672779633234 15:38:34 INFO - PROCESS | 1646 | |5;yui.html;717.4798271253338;761.7638532055059;775.0892701076234;792.9444938854281;853.7609469348585;15196.772048419283;15698.76451853223;15719.92140039301;15727.449539266128;15748.842511574867;14340;14343.21112338821;14388.7769539589;14553.199574023425;14675;851.4295422067199;876.027609353617;880.1242763450343;880.2693764175751;880.3089574683875;879.705298724928;882.858742601184;883.3198437203382;884.0187391994881;884.054062153496;748.4461498491105;772.5403384985924;913.118840319092;937.386012162035;946.4841661294577;936.3866667332908;938.652698501552;938.6714649872558;939.0187254319253;943.3443756589105;696.7805141380449;697.3410127429581;697.3653974882832;698.6751160710244;700.7302188657353;15299.235038248155;15535.456259030992;15633.06201627906;15679.372825087097;15773.211339432983;13863.514776982756;14339.78490322646;14403.423863045466;14431.783523247159;14442;12709.491620335175;12750.68123296925;12920.87079129206;13204.405801738849;13679.521216757465;3674.706023518112;3893.3770596704676;4034.515858097018;4678.555537223959;4755.144074066667;87754;118702;125006;126030;126207;10815;11020.393878336768;11167.994880460798;11319.264247823865;11814.113941454425;21741.47809653309;22478.775212247667;22496.662550061763;22498.325050248517;22532.21137260188;6562.278149403562;7523;7580.05249343832;7674.501157424749;7819.17898620648;4421.292593185075;4432.335149727567;4488.169688607618;4582.747948862844;4670.322803193518;3749.1939233064477;3854.248421557825;3996.4205190247253;4175.665946724254;4181.059261666101;735.8197241675716;736.3225832234357;757.3032809814983;762.6949220311809;772.0735117858592;594.7531774313611;596.8868061066081;598.3926314790491;600.4625859855405;602.4487593851665;10085.394876307446;10493.793323400036;10560.2079844012;10895.782084358269;11098.667039988813;598.6258588382261;608.9939100609026;612.6875293600207;624.4161708802285;739.1278291615837;4871.244957031666;5073.974630126826;5119.795208191705;5173.508516690908;5225.346831646044;72579.91130133052;79247;109936;110448;112478.43760781144;79466.60266698629;87310.12689873147;90622;91123.08876911146;93400.0659993405;78556.82164767533;79585.60207199043;79874.6006269965;81949.18050819654;82724;9441.480718560546;10861;11141.442927853737;11237.438128093727;11252.549898003988;51086.74456627693;51369;51869;52353;53303.73348133235;50209.98740075607;70346;70553.64723176352;71121;72548;13117;13278.734425311246;13349.132306400053;13521.797173042609;13617.319134043457;14775.482858099915;14824.851751482778;15163.393464261306;15362.923185384001;15607.531774046796;11183.552657893919;13374.908180551016;13913.58259252224;13950.372233249731;14074.366653500412;13475.32623368808;14000.579982600539;14106.012579119362;14260.358283877044;14292.213928234047;12821.551245706729;12882.677933051375;14083.647908802363;14253.474996005718;14406.927965360106;9474.95262523683;9834.459104749307;9971.950140249543;9982.450965196984;10101.595936162472;8027.558484283187;11123.99884010443;11336.943315283701;11454.599089031844;11472.713182170513 15:38:34 INFO - PROCESS | 1646 | __end_tp_report 15:38:34 INFO - PROCESS | 1646 | __start_cc_report 15:38:34 INFO - PROCESS | 1646 | _x_x_mozilla_cycle_collect,1454 15:38:34 INFO - PROCESS | 1646 | __end_cc_report 15:38:34 INFO - PROCESS | 1646 | __startTimestamp1490827114044__endTimestamp 15:38:34 INFO - PROCESS | 1646 | 15:38:34 INFO - PROCESS | 1646 | ------- Summary: start ------- 15:38:34 INFO - PROCESS | 1646 | Number of tests: 6 15:38:34 INFO - PROCESS | 1646 | 15:38:34 INFO - PROCESS | 1646 | [#0] dojo.html Cycles:165 Average:5764.24 Median:5990.34 stddev:644.63 (10.8%) stddev-sans-first:614.78 15:38:34 INFO - PROCESS | 1646 | Values: 3214.0 3271.7 3280.6 3388.9 3429.0 5686.5 5713.5 5741.6 5743.9 5745.8 5566.1 5585.8 5684.7 5741.3 5755.7 5223.1 5253.5 5260.8 5262.2 5307.6 5171.9 5174.1 5175.0 5316.6 5335.6 5229.7 5231.3 5256.4 5276.4 5350.8 5272.9 5276.5 5280.3 5281.6 5286.8 5111.9 5184.6 5250.8 5277.6 5307.4 5592.0 5613.3 5673.3 5719.9 5724.4 6212.1 6216.9 6251.6 6259.7 6278.8 6237.4 6275.3 6278.5 6291.4 6308.7 5735.2 5911.4 5949.9 5961.8 5972.2 6193.9 6241.3 6256.3 6271.0 6302.0 6188.8 6192.7 6195.1 6199.9 6210.0 6202.6 6260.9 6272.2 6285.6 6291.0 6119.9 6128.9 6129.3 6145.1 6230.1 6218.7 6252.8 6273.8 6290.6 6298.2 4604.8 4738.6 5020.9 5025.4 5034.5 4404.6 4454.1 4463.3 4525.5 4532.7 5582.2 5614.5 5623.6 5637.8 5684.6 6292.6 6300.7 6302.5 6302.8 6303.4 5584.0 5632.0 5676.1 5736.9 5759.4 5287.0 5417.5 5446.9 5481.8 5482.9 6239.0 6270.8 6285.0 6289.5 6302.2 6302.9 6304.4 6310.1 6331.8 6357.4 6196.2 6215.3 6243.1 6270.4 6327.4 6154.0 6244.8 6249.2 6253.3 6258.9 6307.7 6313.0 6320.1 6326.0 6336.3 6027.0 6092.2 6121.3 6169.9 6208.0 6022.1 6056.3 6080.4 6083.2 6145.2 5986.3 5990.3 5996.6 6022.5 6046.2 5916.5 6075.2 6098.9 6128.1 6188.0 5853.4 5909.2 5953.0 5967.9 5981.0 15:38:34 INFO - PROCESS | 1646 | 15:38:34 INFO - PROCESS | 1646 | [#1] ext.html Cycles:180 Average:67118.00 Median:18858.65 stddev:140195.65 (743.4%) stddev-sans-first:140499.70 15:38:34 INFO - PROCESS | 1646 | Values: 493.5 513.3 520.4 531.6 556.2 31707.8 43356.8 45276.3 45322.7 45403.0 44084.1 44364.0 44420.0 44554.6 44601.6 8997.8 9204.1 9500.6 9719.6 9738.6 11591.2 11842.1 11852.8 12012.5 12019.3 11839.4 11859.9 11897.6 11916.3 11972.5 11789.9 11871.0 11874.9 11876.5 11877.2 11583.4 11654.8 11742.3 11753.6 11756.2 34083.5 41006.0 41649.2 42019.0 42033.0 4030.2 4064.3 4090.3 4109.6 4129.6 30921.8 31527.8 31743.0 32785.7 33217.8 3231.3 3309.5 3360.4 3394.1 3489.0 493608.5 494576.0 494823.0 495279.0 495317.0 58807.0 60649.0 61658.4 66902.0 67053.0 67827.3 67921.7 69770.0 69870.0 70068.0 17290.2 17537.2 17569.4 17602.0 17614.8 12430.8 12658.2 12695.4 13155.5 13252.9 18045.0 18235.8 18341.7 18354.0 18440.0 7466.9 7527.4 7532.4 7539.2 7569.8 740.0 858.7 859.5 873.9 901.1 30322.4 30374.8 30481.1 30884.5 31047.7 924.0 1065.6 1072.2 1108.2 1180.9 15935.3 15958.0 16052.5 16153.3 16400.9 625259.0 629128.0 629666.0 629764.0 630016.0 61573.7 61732.4 61819.4 61826.1 61923.8 1336.3 1393.4 1439.9 1479.9 1514.7 30195.6 31809.5 32346.9 32848.7 33199.3 51986.7 52546.7 52782.7 53328.7 53481.5 436362.0 436712.0 436987.0 437315.0 438542.8 32920.0 37220.6 37260.0 38464.6 38620.0 46902.8 47144.6 47869.8 48618.8 49545.0 31193.0 31930.2 32645.5 32956.2 32969.2 26035.3 32758.2 33593.7 34030.7 34228.3 37550.6 38272.8 38836.8 39017.0 39210.6 32951.0 32966.3 32967.8 33173.7 34070.1 25534.7 25573.1 25782.6 26105.5 26174.0 15:38:34 INFO - PROCESS | 1646 | 15:38:34 INFO - PROCESS | 1646 | [#2] jquery.html Cycles:180 Average:40766.09 Median:2819.94 stddev:119900.22 (4251.9%) stddev-sans-first:120198.25 15:38:34 INFO - PROCESS | 1646 | Values: 392.6 397.0 399.7 404.3 425.1 20692.2 21796.1 22084.6 22089.6 22138.7 22215.2 22237.0 22673.3 22962.7 23197.7 5356.5 5915.4 6087.1 6221.5 6238.0 5293.9 5786.4 6109.9 6175.5 6181.8 6127.2 6134.4 6141.8 6144.2 6148.6 5202.7 5840.0 5921.6 6013.3 6154.4 5167.5 5378.7 5383.3 5384.9 5386.5 26819.9 27020.2 27025.9 27217.5 27351.6 2569.4 2786.2 2817.9 2819.8 2820.0 10195.1 10554.2 10693.7 10751.5 10853.6 1824.5 1862.6 1867.7 1875.5 1910.6 129487.4 130899.3 137498.0 145639.0 146259.0 11756.0 11930.9 12012.4 12041.6 12297.8 16299.1 16331.0 16356.6 16376.3 16397.3 8993.6 9150.9 9162.8 9185.4 9313.9 9004.2 9006.4 9010.4 9186.7 9206.3 4829.4 4907.4 4908.4 5008.7 5058.5 1965.7 2000.6 2024.6 2025.9 2035.7 699.8 710.9 790.3 907.9 965.2 21270.0 22549.3 22760.8 23068.7 23141.3 947.5 952.0 965.9 987.5 998.6 9535.3 9812.1 9898.9 11411.1 11830.0 562672.0 597368.0 762528.0 799193.0 807035.0 164402.0 167384.0 173112.0 177273.0 180651.0 1046.9 1050.8 1103.2 1104.8 1108.9 19977.7 19979.9 20597.9 20763.8 20865.9 59545.1 61048.4 61285.0 61603.0 61818.8 89594.0 89942.0 91709.1 93890.0 94628.0 8227.1 8475.2 8549.4 8748.1 8787.6 10414.5 12944.4 12957.4 13044.8 13208.3 11150.4 11210.9 11412.9 11649.7 11687.8 10555.4 10593.2 10702.4 10952.0 11064.6 6269.7 9328.4 9546.4 11071.2 11165.2 8314.0 8600.1 8626.1 8786.0 8792.2 9497.3 9842.2 11225.3 11260.8 11545.2 15:38:34 INFO - PROCESS | 1646 | 15:38:34 INFO - PROCESS | 1646 | [#3] mootools.html Cycles:180 Average:5482.11 Median:5135.86 stddev:2988.06 (58.2%) stddev-sans-first:2981.04 15:38:34 INFO - PROCESS | 1646 | Values: 1445.5 1453.8 1457.1 1481.4 1495.2 8244.0 8633.0 8646.0 8649.4 8680.2 7631.7 7858.0 7870.0 7952.9 8459.7 2131.1 2194.9 2289.6 2346.1 2368.8 2403.8 2404.4 2405.5 2411.4 2412.8 2315.5 2336.2 2347.1 2348.8 2349.2 2001.6 2322.0 2338.1 2340.6 2362.9 2302.8 2303.9 2320.8 2333.1 2336.5 8479.7 8539.4 8570.5 8614.7 8638.9 5125.6 5316.7 5322.4 5325.4 5330.4 3465.4 3480.0 3531.7 3532.5 3559.5 1210.7 1211.7 1233.1 1260.2 1260.7 10830.7 11055.7 11145.6 11148.8 11150.6 4430.6 4685.4 4805.4 4806.8 4808.3 9670.2 9674.3 9694.3 9701.2 9703.0 4570.9 5247.9 5365.9 5382.7 5394.2 4839.2 4892.2 4965.6 4967.8 4984.7 3717.2 3811.9 3812.9 3930.0 3947.8 1265.9 1266.1 1268.2 1279.7 1284.7 907.8 920.9 923.0 930.9 954.3 5609.9 5636.2 5843.4 5881.1 5910.6 965.9 987.6 1004.4 1015.1 1034.5 3312.3 3566.4 3733.6 3828.0 3891.6 9936.0 10102.0 10221.9 10235.2 10252.9 10167.3 10177.7 10192.3 10196.7 10211.1 7558.0 7949.4 8104.4 8122.1 8141.5 5505.8 5558.0 5587.2 5670.2 5722.6 9239.7 9335.6 9387.4 9410.6 9475.7 7896.9 9431.4 9666.8 9673.6 9766.4 6804.0 6838.1 6907.0 6987.9 6995.1 7261.5 7506.1 7521.9 7914.4 7949.3 6416.2 6689.5 6887.0 7003.1 7257.3 5862.4 6849.7 6962.1 6980.7 6991.2 6160.9 6166.7 6234.3 6235.5 6239.8 5010.7 5060.6 5080.0 5080.2 5092.2 4992.6 5019.3 5146.1 5210.4 5210.7 15:38:34 INFO - PROCESS | 1646 | 15:38:34 INFO - PROCESS | 1646 | [#4] prototype.html Cycles:180 Average:4419.22 Median:4812.61 stddev:1287.18 (26.7%) stddev-sans-first:1254.26 15:38:34 INFO - PROCESS | 1646 | Values: 362.5 362.8 372.3 380.2 382.5 5085.9 5333.5 5401.9 5425.7 5434.4 4515.0 4997.5 5229.2 5275.9 5418.8 3308.8 4188.2 4200.5 4241.8 4248.5 4189.7 4199.9 4253.9 4265.8 4310.0 3469.8 3985.6 4178.8 4186.6 4222.7 3914.8 4156.5 4180.4 4188.5 4189.9 3131.9 3708.6 3716.1 3722.5 3734.8 4257.2 5074.2 5241.2 5265.3 5296.9 3572.4 4176.9 4657.2 4827.5 4838.3 4686.7 5505.3 5641.0 5642.7 5658.7 3631.7 4113.5 4125.2 4150.2 4152.4 5576.8 5801.7 5886.0 5888.9 5914.7 4197.9 4204.4 4216.3 4217.8 4231.9 3921.7 4260.9 4282.6 4303.9 4305.3 3771.0 3834.6 4712.6 4778.3 4806.3 4715.6 5619.3 5627.9 5644.4 5678.8 1292.1 1317.7 1369.0 1389.3 1398.7 885.6 889.0 926.3 932.7 935.9 4110.8 4543.8 4544.0 4840.1 4927.4 4897.6 5015.1 5074.2 5111.6 5480.3 4793.4 4900.5 4904.8 5126.6 5187.6 2767.9 2894.7 2906.3 2908.9 2913.9 4818.9 5579.2 5618.3 5664.6 5678.0 4702.9 5023.5 5610.0 5618.4 5677.7 4724.0 4761.6 5454.3 5520.6 5610.9 4390.3 5014.5 5132.3 5490.8 5530.5 4430.7 4798.0 5059.5 5167.3 5241.5 4930.8 5574.9 5589.4 5597.8 5612.7 3219.5 3315.0 3530.2 3671.3 3680.6 4635.5 4729.7 5445.1 5445.7 5485.4 4664.6 5080.9 5245.8 5290.8 5292.4 4161.9 4562.1 4740.3 4796.6 5175.8 4385.8 5167.5 5189.0 5207.3 5278.3 4997.9 5369.2 5421.8 5537.9 5553.6 4345.4 5033.6 5129.9 5422.8 5453.7 15:38:34 INFO - PROCESS | 1646 | 15:38:34 INFO - PROCESS | 1646 | [#5] yui.html Cycles:180 Average:20886.61 Median:4460.25 stddev:30209.88 (677.3%) stddev-sans-first:30256.67 15:38:34 INFO - PROCESS | 1646 | Values: 717.5 761.8 775.1 792.9 853.8 15196.8 15698.8 15719.9 15727.4 15748.8 14340.0 14343.2 14388.8 14553.2 14675.0 851.4 876.0 880.1 880.3 880.3 879.7 882.9 883.3 884.0 884.1 748.4 772.5 913.1 937.4 946.5 936.4 938.7 938.7 939.0 943.3 696.8 697.3 697.4 698.7 700.7 15299.2 15535.5 15633.1 15679.4 15773.2 13863.5 14339.8 14403.4 14431.8 14442.0 12709.5 12750.7 12920.9 13204.4 13679.5 3674.7 3893.4 4034.5 4678.6 4755.1 87754.0 118702.0 125006.0 126030.0 126207.0 10815.0 11020.4 11168.0 11319.3 11814.1 21741.5 22478.8 22496.7 22498.3 22532.2 6562.3 7523.0 7580.1 7674.5 7819.2 4421.3 4432.3 4488.2 4582.7 4670.3 3749.2 3854.2 3996.4 4175.7 4181.1 735.8 736.3 757.3 762.7 772.1 594.8 596.9 598.4 600.5 602.4 10085.4 10493.8 10560.2 10895.8 11098.7 598.6 609.0 612.7 624.4 739.1 4871.2 5074.0 5119.8 5173.5 5225.3 72579.9 79247.0 109936.0 110448.0 112478.4 79466.6 87310.1 90622.0 91123.1 93400.1 78556.8 79585.6 79874.6 81949.2 82724.0 9441.5 10861.0 11141.4 11237.4 11252.5 51086.7 51369.0 51869.0 52353.0 53303.7 50210.0 70346.0 70553.6 71121.0 72548.0 13117.0 13278.7 13349.1 13521.8 13617.3 14775.5 14824.9 15163.4 15362.9 15607.5 11183.6 13374.9 13913.6 13950.4 14074.4 13475.3 14000.6 14106.0 14260.4 14292.2 12821.6 12882.7 14083.6 14253.5 14406.9 9475.0 9834.5 9972.0 9982.5 10101.6 8027.6 11124.0 11336.9 11454.6 11472.7 15:38:34 INFO - PROCESS | 1646 | -------- Summary: end -------- 15:38:34 INFO - PROCESS | 1646 | 15:38:34 INFO - TEST-INFO | 1646: exit 0 15:38:34 INFO - TEST-OK | dromaeo_css | took 1116787ms 15:38:34 INFO - TEST-START | kraken 15:38:34 INFO - operating with platform_type : mac_ 15:38:34 INFO - Initialising browser for kraken test... 15:38:34 INFO - TEST-INFO | started process 1657 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/tmpMkIHOn/profile http://localhost:49251/getInfo.html) 15:38:36 INFO - PROCESS | 1657 | __metrics Screen width/height:1600/1200 15:38:36 INFO - PROCESS | 1657 | colorDepth:24 15:38:36 INFO - PROCESS | 1657 | Browser inner width/height: 1024/689 15:38:36 INFO - PROCESS | 1657 | __metrics 15:38:37 INFO - PROCESS | 1657 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 15:38:37 INFO - PROCESS | 1657 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:38:37 INFO - TEST-INFO | 1657: exit 0 15:38:37 INFO - Browser initialized. 15:38:37 INFO - Running cycle 1/1 for kraken test... 15:38:37 INFO - TEST-INFO | started process 1659 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/tmpMkIHOn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:38:49 INFO - PROCESS | 1659 | RSS: Main: 167669760 15:38:49 INFO - PROCESS | 1659 | 15:38:52 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49251/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49251/tests/kraken/driver.html?testName=audio-beat-detection) 15:38:53 INFO - PROCESS | 1659 | RSS: Main: 215654400 15:38:53 INFO - PROCESS | 1659 | 15:38:55 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49251/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49251/tests/kraken/driver.html?testName=audio-dft) 15:38:56 INFO - PROCESS | 1659 | RSS: Main: 228499456 15:38:56 INFO - PROCESS | 1659 | 15:38:59 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49251/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49251/tests/kraken/driver.html?testName=audio-fft) 15:39:00 INFO - PROCESS | 1659 | RSS: Main: 326680576 15:39:00 INFO - PROCESS | 1659 | 15:39:02 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49251/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49251/tests/kraken/driver.html?testName=audio-oscillator) 15:39:02 INFO - PROCESS | 1659 | RSS: Main: 228483072 15:39:02 INFO - PROCESS | 1659 | 15:39:04 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49251/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49251/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:39:05 INFO - PROCESS | 1659 | RSS: Main: 229187584 15:39:05 INFO - PROCESS | 1659 | 15:39:08 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49251/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49251/tests/kraken/driver.html?testName=imaging-darkroom) 15:39:08 INFO - PROCESS | 1659 | RSS: Main: 269643776 15:39:08 INFO - PROCESS | 1659 | 15:39:11 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49251/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49251/tests/kraken/driver.html?testName=imaging-desaturate) 15:39:12 INFO - PROCESS | 1659 | RSS: Main: 271167488 15:39:12 INFO - PROCESS | 1659 | 15:39:15 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49251/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49251/tests/kraken/driver.html?testName=json-parse-financial) 15:39:15 INFO - PROCESS | 1659 | RSS: Main: 268673024 15:39:15 INFO - PROCESS | 1659 | 15:39:17 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49251/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49251/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:39:17 INFO - PROCESS | 1659 | RSS: Main: 245796864 15:39:17 INFO - PROCESS | 1659 | 15:39:19 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49251/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49251/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:39:20 INFO - PROCESS | 1659 | RSS: Main: 249180160 15:39:20 INFO - PROCESS | 1659 | 15:39:22 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49251/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49251/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:39:23 INFO - PROCESS | 1659 | RSS: Main: 257740800 15:39:23 INFO - PROCESS | 1659 | 15:39:26 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49251/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49251/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:39:26 INFO - PROCESS | 1659 | RSS: Main: 262217728 15:39:26 INFO - PROCESS | 1659 | 15:39:29 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49251/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49251/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:39:30 INFO - PROCESS | 1659 | RSS: Main: 263352320 15:39:30 INFO - PROCESS | 1659 | 15:39:31 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49251/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49251/tests/kraken/driver.html?testName=ai-astar) 15:39:32 INFO - PROCESS | 1659 | RSS: Main: 307875840 15:39:32 INFO - PROCESS | 1659 | 15:39:32 INFO - PROCESS | 1659 | __start_tp_report 15:39:32 INFO - PROCESS | 1659 | _x_x_mozilla_page_load 15:39:32 INFO - PROCESS | 1659 | _x_x_mozilla_page_load_details 15:39:32 INFO - PROCESS | 1659 | |i|pagename|runs| 15:39:32 INFO - PROCESS | 1659 | |0;ai-astar;112;112;114;112;115;114;114;114;114;114 15:39:32 INFO - PROCESS | 1659 | |1;audio-beat-detection;135;107;105;140;108;107;106;105;126;104 15:39:32 INFO - PROCESS | 1659 | |2;audio-dft;184;185;183;185;185;184;183;183;182;185 15:39:32 INFO - PROCESS | 1659 | |3;audio-fft;80;58;58;88;58;59;57;58;75;64 15:39:32 INFO - PROCESS | 1659 | |4;audio-oscillator;87;72;113;100;99;68;81;66;68;82 15:39:32 INFO - PROCESS | 1659 | |5;imaging-gaussian-blur;88;85;88;85;87;84;88;86;87;85 15:39:32 INFO - PROCESS | 1659 | |6;imaging-darkroom;93;94;103;143;93;94;94;95;93;93 15:39:32 INFO - PROCESS | 1659 | |7;imaging-desaturate;83;86;84;88;84;86;86;85;88;84 15:39:32 INFO - PROCESS | 1659 | |8;json-parse-financial;53;52;51;55;54;56;54;55;55;55 15:39:32 INFO - PROCESS | 1659 | |9;json-stringify-tinderbox;63;72;75;76;72;67;68;69;70;69 15:39:32 INFO - PROCESS | 1659 | |10;stanford-crypto-aes;81;84;84;85;82;84;87;87;118;85 15:39:32 INFO - PROCESS | 1659 | |11;stanford-crypto-ccm;140;142;139;132;132;159;145;127;152;131 15:39:32 INFO - PROCESS | 1659 | |12;stanford-crypto-pbkdf2;164;165;164;167;166;165;164;165;163;163 15:39:32 INFO - PROCESS | 1659 | |13;stanford-crypto-sha256-iterative;63;65;64;64;64;63;63;63;64;63 15:39:32 INFO - PROCESS | 1659 | __end_tp_report 15:39:32 INFO - PROCESS | 1659 | __start_cc_report 15:39:32 INFO - PROCESS | 1659 | _x_x_mozilla_cycle_collect,1939 15:39:32 INFO - PROCESS | 1659 | __end_cc_report 15:39:32 INFO - PROCESS | 1659 | __startTimestamp1490827172031__endTimestamp 15:39:32 INFO - PROCESS | 1659 | 15:39:32 INFO - PROCESS | 1659 | ------- Summary: start ------- 15:39:32 INFO - PROCESS | 1659 | Number of tests: 14 15:39:32 INFO - PROCESS | 1659 | 15:39:32 INFO - PROCESS | 1659 | [#0] ai-astar Cycles:10 Average:113.50 Median:114.00 stddev:1.08 (0.9%) stddev-sans-first:1.00 15:39:32 INFO - PROCESS | 1659 | Values: 112.0 112.0 114.0 112.0 115.0 114.0 114.0 114.0 114.0 114.0 15:39:32 INFO - PROCESS | 1659 | 15:39:32 INFO - PROCESS | 1659 | [#1] audio-beat-detection Cycles:10 Average:114.30 Median:107.50 stddev:13.82 (12.9%) stddev-sans-first:12.47 15:39:32 INFO - PROCESS | 1659 | Values: 135.0 107.0 105.0 140.0 108.0 107.0 106.0 105.0 126.0 104.0 15:39:32 INFO - PROCESS | 1659 | 15:39:32 INFO - PROCESS | 1659 | [#2] audio-dft Cycles:10 Average:183.90 Median:184.50 stddev:1.10 (0.6%) stddev-sans-first:1.17 15:39:32 INFO - PROCESS | 1659 | Values: 184.0 185.0 183.0 185.0 185.0 184.0 183.0 183.0 182.0 185.0 15:39:32 INFO - PROCESS | 1659 | 15:39:32 INFO - PROCESS | 1659 | [#3] audio-fft Cycles:10 Average:65.50 Median:61.50 stddev:11.30 (18.4%) stddev-sans-first:10.69 15:39:32 INFO - PROCESS | 1659 | Values: 80.0 58.0 58.0 88.0 58.0 59.0 57.0 58.0 75.0 64.0 15:39:32 INFO - PROCESS | 1659 | 15:39:32 INFO - PROCESS | 1659 | [#4] audio-oscillator Cycles:10 Average:83.60 Median:76.50 stddev:16.06 (21.0%) stddev-sans-first:16.99 15:39:32 INFO - PROCESS | 1659 | Values: 87.0 72.0 113.0 100.0 99.0 68.0 81.0 66.0 68.0 82.0 15:39:32 INFO - PROCESS | 1659 | 15:39:32 INFO - PROCESS | 1659 | [#5] imaging-gaussian-blur Cycles:10 Average:86.30 Median:87.00 stddev:1.49 (1.7%) stddev-sans-first:1.45 15:39:32 INFO - PROCESS | 1659 | Values: 88.0 85.0 88.0 85.0 87.0 84.0 88.0 86.0 87.0 85.0 15:39:32 INFO - PROCESS | 1659 | 15:39:32 INFO - PROCESS | 1659 | [#6] imaging-darkroom Cycles:10 Average:99.50 Median:93.50 stddev:15.58 (16.7%) stddev-sans-first:16.35 15:39:32 INFO - PROCESS | 1659 | Values: 93.0 94.0 103.0 143.0 93.0 94.0 94.0 95.0 93.0 93.0 15:39:32 INFO - PROCESS | 1659 | 15:39:32 INFO - PROCESS | 1659 | [#7] imaging-desaturate Cycles:10 Average:85.40 Median:86.00 stddev:1.71 (2.0%) stddev-sans-first:1.58 15:39:32 INFO - PROCESS | 1659 | Values: 83.0 86.0 84.0 88.0 84.0 86.0 86.0 85.0 88.0 84.0 15:39:32 INFO - PROCESS | 1659 | 15:39:32 INFO - PROCESS | 1659 | [#8] json-parse-financial Cycles:10 Average:54.00 Median:55.00 stddev:1.56 (2.8%) stddev-sans-first:1.62 15:39:32 INFO - PROCESS | 1659 | Values: 53.0 52.0 51.0 55.0 54.0 56.0 54.0 55.0 55.0 55.0 15:39:32 INFO - PROCESS | 1659 | 15:39:32 INFO - PROCESS | 1659 | [#9] json-stringify-tinderbox Cycles:10 Average:70.10 Median:71.00 stddev:3.84 (5.4%) stddev-sans-first:3.10 15:39:32 INFO - PROCESS | 1659 | Values: 63.0 72.0 75.0 76.0 72.0 67.0 68.0 69.0 70.0 69.0 15:39:32 INFO - PROCESS | 1659 | 15:39:32 INFO - PROCESS | 1659 | [#10] stanford-crypto-aes Cycles:10 Average:87.70 Median:84.50 stddev:10.81 (12.8%) stddev-sans-first:11.19 15:39:32 INFO - PROCESS | 1659 | Values: 81.0 84.0 84.0 85.0 82.0 84.0 87.0 87.0 118.0 85.0 15:39:32 INFO - PROCESS | 1659 | 15:39:32 INFO - PROCESS | 1659 | [#11] stanford-crypto-ccm Cycles:10 Average:139.90 Median:141.00 stddev:10.07 (7.1%) stddev-sans-first:10.68 15:39:32 INFO - PROCESS | 1659 | Values: 140.0 142.0 139.0 132.0 132.0 159.0 145.0 127.0 152.0 131.0 15:39:32 INFO - PROCESS | 1659 | 15:39:32 INFO - PROCESS | 1659 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.60 Median:165.00 stddev:1.26 (0.8%) stddev-sans-first:1.32 15:39:32 INFO - PROCESS | 1659 | Values: 164.0 165.0 164.0 167.0 166.0 165.0 164.0 165.0 163.0 163.0 15:39:32 INFO - PROCESS | 1659 | 15:39:32 INFO - PROCESS | 1659 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.60 Median:64.00 stddev:0.70 (1.1%) stddev-sans-first:0.71 15:39:32 INFO - PROCESS | 1659 | Values: 63.0 65.0 64.0 64.0 64.0 63.0 63.0 63.0 64.0 63.0 15:39:32 INFO - PROCESS | 1659 | -------- Summary: end -------- 15:39:32 INFO - PROCESS | 1659 | 15:39:32 INFO - TEST-INFO | 1659: exit 0 15:39:32 INFO - TEST-OK | kraken | took 58191ms 15:39:32 INFO - SUITE-END | took 1174s 15:39:33 INFO - Completed test suite (00:19:35) 15:39:33 INFO - javascript benchmark 15:39:33 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3213.9999999999986, 3271.7055465008148, 3280.5735254416923, 3388.8983330500087, 3429.0, 5686.4597863203035, 5713.542916566675, 5741.62679425837, 5743.856403589913, 5745.770169193227, 5566.053770858954, 5585.776568937237, 5684.744186511606, 5741.339745929219, 5755.68343741094, 5223.112070947929, 5253.474652534745, 5260.789568417278, 5262.184361423985, 5307.628466007381, 5171.922421163686, 5174.09453345663, 5174.974125129388, 5316.574674026068, 5335.599830012765, 5229.686218826882, 5231.319928409321, 5256.395514515842, 5276.419593844674, 5350.759215835296, 5272.947270527284, 5276.472352764731, 5280.313559237313, 5281.551068159211, 5286.788528458857, 5111.897762044739, 5184.611154163415, 5250.842474725764, 5277.6041796865, 5307.416184219733, 5592.0, 5613.326400831886, 5673.347565030033, 5719.885602287973, 5724.398938111522, 6212.1303017577575, 6216.937830621681, 6251.624902505864, 6259.655718935457, 6278.811635650938, 6237.438630523275, 6275.309715931244, 6278.529110316745, 6291.370862913718, 6308.747650093991, 5735.2257445245195, 5911.379305172981, 5949.940500594982, 5961.791337303173, 5972.223610930551, 6193.938060619426, 6241.282252540925, 6256.280527739277, 6271.0, 6302.023186406114, 6188.845278867974, 6192.659403732748, 6195.101710251988, 6199.907001394983, 6210.0, 6202.627842329474, 6260.906086408708, 6272.2159730033745, 6285.622862628257, 6290.968545157245, 6119.877602447926, 6128.872947855148, 6129.328227221949, 6145.139680444741, 6230.065490176419, 6218.720157592919, 6252.843678908063, 6273.811785646438, 6290.591111577733, 6298.244210694655, 4604.792784324646, 4738.573528382462, 5020.899582008413, 5025.422076461181, 5034.521720436553, 4404.647628189801, 4454.109178164315, 4463.263561512379, 4525.547445255514, 4532.7280363178315, 5582.218489411485, 5614.466625670555, 5623.550115990711, 5637.774489020475, 5684.551617199701, 6292.590981586182, 6300.7479700811455, 6302.464290535264, 6302.810915672537, 6303.401176888188, 5584.0, 5632.04255276604, 5676.148577713376, 5736.942630573641, 5759.366469688331, 5286.97356513215, 5417.539509141767, 5446.863828404243, 5481.780728770885, 5482.862928426742, 6238.968805156127, 6270.811875643738, 6284.962981108158, 6289.465395441439, 6302.180716506917, 6302.873942521032, 6304.432601065926, 6310.085037669604, 6331.778387756406, 6357.427831495188, 6196.194494715658, 6215.285242197205, 6243.094751260951, 6270.404311590391, 6327.367263273636, 6153.969230153821, 6244.812655620339, 6249.156363890998, 6253.3121356651645, 6258.874822503433, 6307.653079080695, 6313.021481670348, 6320.08358787964, 6326.0, 6336.334684858208, 6027.035674292268, 6092.238470191226, 6121.326654068138, 6169.907451388322, 6208.037754148114, 6022.066579680157, 6056.273247210363, 6080.422359875804, 6083.239595050619, 6145.217886812774, 5986.341502434816, 5990.34106248321, 5996.580239383201, 6022.45797878193, 6046.153538504701, 5916.526677865846, 6075.179850720273, 6098.908516372169, 6128.111423843428, 6188.0, 5853.385394533512, 5909.23179986599, 5953.0, 5967.880642387215, 5981.0], "value": 5721.493727009359, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [493.51388881951294, 513.2788432252685, 520.4379270387981, 531.6092671886163, 556.1907424697066, 31707.841460792693, 43356.78321608392, 45276.320855187114, 45322.733863306865, 45403.0, 44084.11831763371, 44364.0, 44420.0, 44554.55445445544, 44601.553984460144, 8997.820043599124, 9204.125608067223, 9500.57247423866, 9719.56261968213, 9738.610455581804, 11591.246568973032, 11842.052635789116, 11852.7629447411, 12012.519499220021, 12019.338936358497, 11839.408029598486, 11859.940700296487, 11897.643070707893, 11916.344601046982, 11972.521099156023, 11789.882101179008, 11871.0, 11874.881251187508, 11876.465559049777, 11877.16859819813, 11583.362915039754, 11654.766904661945, 11742.295462272292, 11753.588624398191, 11756.177067605271, 34083.4887476688, 41006.0, 41649.1670166598, 42019.0, 42033.0, 4030.161594170478, 4064.309067458539, 4090.2637525245445, 4109.630133287988, 4129.566395528486, 30921.845390773127, 31527.84236078828, 31743.0, 32785.6721432785, 33217.83391083029, 3231.337575796956, 3309.5366648669205, 3360.41192791263, 3394.0835974286806, 3488.9825550872083, 493608.53195734153, 494576.0, 494823.0, 495279.0, 495317.0, 58807.0, 60649.0, 61658.38341616616, 66902.0, 67052.99420508598, 67827.32172678309, 67921.66039169772, 69770.0, 69870.0, 70068.0, 17290.22194001273, 17537.210825512884, 17569.385071522436, 17602.031888246012, 17614.823851761575, 12430.813537796941, 12658.177218480769, 12695.428705708266, 13155.473781048842, 13252.867471325357, 18045.0, 18235.817641823676, 18341.7248741269, 18354.0, 18439.985800780818, 7466.85066298671, 7527.435442341846, 7532.359749421251, 7539.170691223961, 7569.772906812805, 739.9667014984338, 858.7295002074327, 859.5100792548187, 873.9113518690335, 901.1169054326797, 30322.393552128833, 30374.848125759672, 30481.085567433012, 30884.53673194904, 31047.68952310448, 923.9676611318572, 1065.648336049102, 1072.1958531101673, 1108.2187058124002, 1180.8996235320094, 15935.282912268976, 15958.0, 16052.518424447286, 16153.273102710406, 16400.917995409945, 625259.0, 629128.0, 629666.0, 629764.0, 630016.0, 61573.69213153995, 61732.38267617267, 61819.38180618226, 61826.0726089109, 61923.761524770154, 1336.3318340829585, 1393.4078016843005, 1439.899207055538, 1479.896407251482, 1514.7424937760607, 30195.61180342223, 31809.522857157623, 32346.8678596248, 32848.671513284564, 33199.33601327911, 51986.740066299426, 52546.73726631342, 52782.736086319324, 53328.66678333073, 53481.465185347646, 436362.0, 436712.0, 436987.0, 437315.0, 438542.8072859615, 32920.0, 37220.62779372172, 37260.0, 38464.61535384722, 38620.0, 46902.76548617235, 47144.58566243018, 47869.76065119652, 48618.75690621524, 49545.0, 31193.0, 31930.20174495656, 32645.510317344782, 32956.17609559684, 32969.17577060593, 26035.349116271485, 32758.181045474055, 33593.66406336003, 34030.65969340374, 34228.315433691685, 37550.624493754716, 38272.808635956644, 38836.805815970736, 39017.0, 39210.60789392069, 32951.0, 32966.34067318688, 32967.83516082404, 33173.66826331706, 34070.14824629404, 25534.744652553978, 25573.104941326965, 25782.613260801478, 26105.477890442464, 26174.0], "value": 20707.65677109599, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [392.5936655561493, 396.97419667721596, 399.7301821270645, 404.2723098422839, 425.0797024442083, 20692.172313107458, 21796.128154873804, 22084.558308833835, 22089.558208835813, 22138.667919981173, 22215.22246721365, 22237.0, 22673.319800405974, 22962.65556016661, 23197.652035219486, 5356.464353564651, 5915.438033386832, 6087.11736798164, 6221.471174950112, 6237.968810155943, 5293.8941221175555, 5786.392428794979, 6109.938900611004, 6175.47508461779, 6181.783637572686, 6127.1728316677345, 6134.386561343875, 6141.754329826802, 6144.2319710036245, 6148.6310821350635, 5202.687838729688, 5839.970800145993, 5921.585489015771, 6013.338532761437, 6154.415330543591, 5167.457416971201, 5378.650387724785, 5383.2732581101445, 5384.946150538483, 5386.48828361305, 26819.865900670567, 27020.1893943182, 27025.86487067552, 27217.45565088687, 27351.589726154125, 2569.4347243606376, 2786.150224181624, 2817.9013734519194, 2819.84490853003, 2820.0411859967503, 10195.133413659774, 10554.155667546578, 10693.732656683567, 10751.462426878625, 10853.620123295726, 1824.4617837737899, 1862.6367858267643, 1867.6918308479085, 1875.4842418334931, 1910.5987742573936, 129487.35256323752, 130899.34550327282, 137498.0, 145639.0, 146259.0, 11756.0, 11930.940345298219, 12012.399380030964, 12041.578544750892, 12297.815532767016, 16299.103549304902, 16331.0, 16356.591085222964, 16376.263068161961, 16397.344106235618, 8993.640254389751, 9150.86273705895, 9162.770930726785, 9185.438475459188, 9313.90686093144, 9004.234640055538, 9006.369554131148, 9010.369274150878, 9186.724398268063, 9206.309526785519, 4829.372181616438, 4907.435644900882, 4908.361912951294, 5008.724520151427, 5058.544730974157, 1965.665836807746, 2000.648265888742, 2024.5647185854818, 2025.908834102469, 2035.7149998999855, 699.8215455058927, 710.8711879656148, 790.2690011739119, 907.9137481939205, 965.2278177458146, 21270.0, 22549.323520294416, 22760.772392276198, 23068.653970190462, 23141.305760827203, 947.5025611553989, 952.0, 965.932384733076, 987.4568987057233, 998.610541888664, 9535.284853636005, 9812.067853553901, 9898.851517227247, 11411.087113030937, 11830.0, 562672.0, 597368.0, 762528.0, 799193.0, 807035.0, 164402.0, 167384.0, 173112.0, 177273.0, 180651.0, 1046.8900765419673, 1050.76883085721, 1103.2332528892503, 1104.812181929074, 1108.8558487396588, 19977.700334495286, 19979.900100499406, 20597.89701051485, 20763.79236207679, 20865.89567052155, 59545.10682339682, 61048.38951610427, 61285.0, 61603.0, 61818.763624728155, 89594.0, 89942.0, 91709.08290917006, 93890.0, 94628.0, 8227.095019547965, 8475.237228649452, 8549.358798090043, 8748.08145144776, 8787.604557795043, 10414.479276036016, 12944.41750121228, 12957.416916238602, 13044.804327935279, 13208.339583021003, 11150.386728729673, 11210.887891120985, 11412.942935285271, 11649.708757281136, 11687.824682629598, 10555.419451930218, 10593.205509586658, 10702.357858528514, 10952.0, 11064.612738554111, 6269.717862696099, 9328.39365441244, 9546.427214366882, 11071.1696622752, 11165.218434709492, 8314.0, 8600.13998600135, 8626.094260102598, 8785.956070219609, 8792.208701216921, 9497.335186537153, 9842.212622990286, 11225.270357426742, 11260.831087533857, 11545.249558778652], "value": 10105.409491521661, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1445.5157522230052, 1453.7819327100933, 1457.0893191755154, 1481.3556103095148, 1495.244901324831, 8244.0, 8633.0, 8645.956770216157, 8649.394542382028, 8680.175383338588, 7631.694732210705, 7857.960710196441, 7869.960650196741, 7952.880706789403, 8459.703910363138, 2131.1049359269105, 2194.9451263718374, 2289.645105008726, 2346.061575369857, 2368.763123687626, 2403.7716416940452, 2404.3530181825417, 2405.4707964247837, 2411.4212588978608, 2412.8069754419603, 2315.548468048731, 2336.2290444153386, 2347.1432926981615, 2348.7886090251873, 2349.166046053652, 2001.6196922584663, 2322.036354912709, 2338.1115176233093, 2340.6020976434047, 2362.9409264768433, 2302.781235782598, 2303.9424014399606, 2320.756320586348, 2333.1367394064137, 2336.497653004612, 8479.74560763172, 8539.444936079135, 8570.528620925847, 8614.698485553039, 8638.870416943751, 5125.615578831603, 5316.73416329182, 5322.441143679896, 5325.387580428262, 5330.360356757175, 3465.4455287154187, 3479.9652003479896, 3531.7174626030114, 3532.4701294805727, 3559.537260156189, 1210.6973256685828, 1211.715246916974, 1233.0628722171125, 1260.2438536877892, 1260.7352455984255, 10830.72923176919, 11055.72360690981, 11145.609903653414, 11148.777024459465, 11150.609728659458, 4430.579094985971, 4685.4143232095985, 4805.399325084364, 4806.7836947337455, 4808.3027960946165, 9670.178034867115, 9674.322797404115, 9694.321397502248, 9701.17540009093, 9703.0, 4570.9314360284625, 5247.924175544004, 5365.946340536545, 5382.67703937765, 5394.217838413408, 4839.153148199051, 4892.168331383673, 4965.553100220997, 4967.751612419437, 4984.7258400788305, 3717.1636381814415, 3811.8856434306463, 3812.8856134316015, 3930.0, 3947.763134211899, 1265.9177153485177, 1266.0631132961726, 1268.1756858042347, 1279.7248591552675, 1284.6916739982523, 907.7821322882593, 920.889493260813, 922.9847168115019, 930.9348345615878, 954.3033585482636, 5609.859753506195, 5636.167644443542, 5843.415658434123, 5881.05903055509, 5910.586258961917, 965.888922773876, 987.6493844685033, 1004.4023805835516, 1015.0712098430001, 1034.4982683398546, 3312.3044160726035, 3566.375884220251, 3733.626637336299, 3827.9617203827606, 3891.6497515223764, 9936.0, 10102.0, 10221.897781022244, 10235.181185505142, 10252.897471025344, 10167.28828981979, 10177.694669159937, 10192.286539942133, 10196.694099177037, 10211.132053775513, 7558.0, 7949.443538952218, 8104.392170587112, 8122.147174546588, 8141.470804397695, 5505.779768809363, 5558.0, 5587.217789509553, 5670.177824215548, 5722.599418040863, 9239.676611318571, 9335.626574936927, 9387.397957661828, 9410.623575057194, 9475.668351607661, 7896.881546776688, 9431.434113953184, 9666.806663866824, 9673.564689589126, 9766.36518626287, 6804.0, 6838.076859624086, 6906.965465172642, 6987.9301206987275, 6995.055667484824, 7261.455390845602, 7506.099268087864, 7521.924780752122, 7914.366850652049, 7949.3243074339325, 6416.197975253093, 6689.49828762835, 6887.0, 7003.054587630605, 7257.346838784535, 5862.443067908542, 6849.657517124224, 6962.060121883481, 6980.650967451708, 6991.161060672752, 6160.907586386297, 6166.691665416801, 6234.251889773256, 6235.501159907287, 6239.75040998355, 5010.749462526786, 5060.645754797129, 5080.0, 5080.187170052922, 5092.159793634009, 4992.575631071254, 5019.347484827095, 5146.099432599205, 5210.426853046238, 5210.6613070150315], "value": 4470.761204791618, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [362.4653635887065, 362.83491011589723, 372.29078605256984, 380.2243423416231, 382.54095085896915, 5085.949140508594, 5333.466653334664, 5401.891962160759, 5425.7287135643155, 5434.375046869606, 4515.0, 4997.475265097167, 5229.150113188312, 5275.947240527594, 5418.756155972981, 3308.7518436117266, 4188.24611569918, 4200.537940826506, 4241.766702831343, 4248.532661407243, 4189.716604450582, 4199.9370009449885, 4253.914921701564, 4265.758023901826, 4309.956900430987, 3469.8265086745687, 3985.60143985602, 4178.770167640779, 4186.623203911648, 4222.68329875259, 3914.8042597869994, 4156.545209176794, 4180.435641188431, 4188.497380314382, 4189.937150942738, 3131.937361252762, 3708.592054873962, 3716.0524066363173, 3722.4602432647384, 3734.775913445202, 4257.169851878885, 5074.238864170367, 5241.240020197089, 5265.341832270966, 5296.92054619181, 3572.4105522588743, 4176.893123322322, 4657.161710892038, 4827.468978412372, 4838.346823178861, 4686.718796872165, 5505.284313039279, 5641.012822756002, 5642.6614403135945, 5658.688772117532, 3631.7457777955556, 4113.526944401402, 4125.23683118621, 4150.211459822624, 4152.418661387408, 5576.804811831607, 5801.7099145042575, 5886.0, 5888.911666325009, 5914.704264786787, 4197.895052623709, 4204.3693445982735, 4216.3464662977285, 4217.810198541073, 4231.894202644897, 3921.7254792164276, 4260.8721738347895, 4282.571742825692, 4303.935440968388, 4305.268104422255, 3770.9832134293006, 3834.5973672764517, 4712.575868171881, 4778.296615581074, 4806.303086052503, 4715.599174070242, 5619.269494965628, 5627.861412663244, 5644.379118297066, 5678.829635110953, 1292.1019891175542, 1317.7349744245632, 1368.9520866769615, 1389.298404305819, 1398.6782490546336, 885.5660726244223, 888.9911100889037, 926.2775035472342, 932.7248461703814, 935.8923723771717, 4110.759635998388, 4543.818247270138, 4543.977280113579, 4840.080384726891, 4927.359443272351, 4897.555221209752, 5015.097282489114, 5074.16276314404, 5111.616628752859, 5480.301106656949, 4793.352897358882, 4900.509949005071, 4904.779284932187, 5126.641135120581, 5187.584993200535, 2767.9308017299727, 2894.6526416830116, 2906.302487403008, 2908.941821163607, 2913.8543072846273, 4818.915743957652, 5579.218909352694, 5618.269624948731, 5664.603477756517, 5678.0, 4702.8960885815195, 5023.538466151633, 5610.0, 5618.39875635442, 5677.687727174963, 4724.0, 4761.643096566603, 5454.318210223722, 5520.613557051048, 5610.887782244414, 4390.34144878258, 5014.473480284663, 5132.3327967364, 5490.752916118704, 5530.529904958124, 4430.734155950653, 4797.976010119927, 5059.546120131659, 5167.32062079818, 5241.528262456397, 4930.778114984906, 5574.888502230014, 5589.357223919302, 5597.832065038056, 5612.7193640317, 3219.5331676907185, 3314.9502757458176, 3530.223350862806, 3671.3391589514144, 3680.6319368062977, 4635.51327110662, 4729.69256998294, 5445.128779395278, 5445.700486473123, 5485.424030476743, 4664.603508701798, 5080.942218401553, 5245.816396426107, 5290.761915713879, 5292.41783403833, 4161.91676166481, 4562.064776720698, 4740.265258884879, 4796.56830885222, 5175.81884634036, 4385.824567017411, 5167.509086636764, 5189.0, 5207.270982062439, 5278.310940499157, 4997.8504943863845, 5369.167778994262, 5421.756020978986, 5537.944620553904, 5553.583481238842, 4345.391645169742, 5033.6476446648385, 5129.922716229634, 5422.834090670524, 5453.672779633234], "value": 4034.1667687203485, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [717.4798271253338, 761.7638532055059, 775.0892701076234, 792.9444938854281, 853.7609469348585, 15196.772048419283, 15698.76451853223, 15719.92140039301, 15727.449539266128, 15748.842511574867, 14340.0, 14343.21112338821, 14388.7769539589, 14553.199574023425, 14675.0, 851.4295422067199, 876.027609353617, 880.1242763450343, 880.2693764175751, 880.3089574683875, 879.705298724928, 882.858742601184, 883.3198437203382, 884.0187391994881, 884.054062153496, 748.4461498491105, 772.5403384985924, 913.118840319092, 937.386012162035, 946.4841661294577, 936.3866667332908, 938.652698501552, 938.6714649872558, 939.0187254319253, 943.3443756589105, 696.7805141380449, 697.3410127429581, 697.3653974882832, 698.6751160710244, 700.7302188657353, 15299.235038248155, 15535.456259030992, 15633.06201627906, 15679.372825087097, 15773.211339432983, 13863.514776982756, 14339.78490322646, 14403.423863045466, 14431.783523247159, 14442.0, 12709.491620335175, 12750.68123296925, 12920.87079129206, 13204.405801738849, 13679.521216757465, 3674.706023518112, 3893.3770596704676, 4034.515858097018, 4678.555537223959, 4755.144074066667, 87754.0, 118702.0, 125006.0, 126030.0, 126207.0, 10815.0, 11020.393878336768, 11167.994880460798, 11319.264247823865, 11814.113941454425, 21741.47809653309, 22478.775212247667, 22496.662550061763, 22498.325050248517, 22532.21137260188, 6562.278149403562, 7523.0, 7580.05249343832, 7674.501157424749, 7819.17898620648, 4421.292593185075, 4432.335149727567, 4488.169688607618, 4582.747948862844, 4670.322803193518, 3749.1939233064477, 3854.248421557825, 3996.4205190247253, 4175.665946724254, 4181.059261666101, 735.8197241675716, 736.3225832234357, 757.3032809814983, 762.6949220311809, 772.0735117858592, 594.7531774313611, 596.8868061066081, 598.3926314790491, 600.4625859855405, 602.4487593851665, 10085.394876307446, 10493.793323400036, 10560.2079844012, 10895.782084358269, 11098.667039988813, 598.6258588382261, 608.9939100609026, 612.6875293600207, 624.4161708802285, 739.1278291615837, 4871.244957031666, 5073.974630126826, 5119.795208191705, 5173.508516690908, 5225.346831646044, 72579.91130133052, 79247.0, 109936.0, 110448.0, 112478.43760781144, 79466.60266698629, 87310.12689873147, 90622.0, 91123.08876911146, 93400.0659993405, 78556.82164767533, 79585.60207199043, 79874.6006269965, 81949.18050819654, 82724.0, 9441.480718560546, 10861.0, 11141.442927853737, 11237.438128093727, 11252.549898003988, 51086.74456627693, 51369.0, 51869.0, 52353.0, 53303.73348133235, 50209.98740075607, 70346.0, 70553.64723176352, 71121.0, 72548.0, 13117.0, 13278.734425311246, 13349.132306400053, 13521.797173042609, 13617.319134043457, 14775.482858099915, 14824.851751482778, 15163.393464261306, 15362.923185384001, 15607.531774046796, 11183.552657893919, 13374.908180551016, 13913.58259252224, 13950.372233249731, 14074.366653500412, 13475.32623368808, 14000.579982600539, 14106.012579119362, 14260.358283877044, 14292.213928234047, 12821.551245706729, 12882.677933051375, 14083.647908802363, 14253.474996005718, 14406.927965360106, 9474.95262523683, 9834.459104749307, 9971.950140249543, 9982.450965196984, 10101.595936162472, 8027.558484283187, 11123.99884010443, 11336.943315283701, 11454.599089031844, 11472.713182170513], "value": 7700.0011287233965, "unit": "score"}], "name": "dromaeo_css", "value": 7415.578040661364, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 112.0, 114.0, 112.0, 115.0, 114.0, 114.0, 114.0, 114.0, 114.0], "value": 113.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 107.0, 105.0, 140.0, 108.0, 107.0, 106.0, 105.0, 126.0, 104.0], "value": 114.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 185.0, 183.0, 185.0, 185.0, 184.0, 183.0, 183.0, 182.0, 185.0], "value": 183.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 58.0, 58.0, 88.0, 58.0, 59.0, 57.0, 58.0, 75.0, 64.0], "value": 65.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 72.0, 113.0, 100.0, 99.0, 68.0, 81.0, 66.0, 68.0, 82.0], "value": 83.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 85.0, 88.0, 85.0, 87.0, 84.0, 88.0, 86.0, 87.0, 85.0], "value": 86.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 103.0, 143.0, 93.0, 94.0, 94.0, 95.0, 93.0, 93.0], "value": 99.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 86.0, 84.0, 88.0, 84.0, 86.0, 86.0, 85.0, 88.0, 84.0], "value": 85.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 52.0, 51.0, 55.0, 54.0, 56.0, 54.0, 55.0, 55.0, 55.0], "value": 54.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 72.0, 75.0, 76.0, 72.0, 67.0, 68.0, 69.0, 70.0, 69.0], "value": 70.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 84.0, 84.0, 85.0, 82.0, 84.0, 87.0, 87.0, 118.0, 85.0], "value": 87.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 142.0, 139.0, 132.0, 132.0, 159.0, 145.0, 127.0, 152.0, 131.0], "value": 139.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 165.0, 164.0, 167.0, 166.0, 165.0, 164.0, 165.0, 163.0, 163.0], "value": 164.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 65.0, 64.0, 64.0, 64.0, 63.0, 63.0, 63.0, 64.0, 63.0], "value": 63.6, "unit": "score"}], "name": "kraken", "value": 1411.8999999999999, "alertThreshold": 2.0}]} 15:39:33 INFO - Return code: 0 15:39:33 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:39:33 INFO - # TBPL SUCCESS # 15:39:33 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:39:33 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:39:33 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:39:33 INFO - 2017-03-29 15:39:33.376 screenresolution[1663:9792] starting screenresolution argv=screenresolution get 15:39:33 INFO - 2017-03-29 15:39:33.378 screenresolution[1663:9792] Display 0: 1600x1200x32@60 15:39:33 INFO - 2017-03-29 15:39:33.384 screenresolution[1664:9795] starting screenresolution argv=screenresolution list 15:39:33 INFO - Available Modes on Display 0 15:39:33 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:39:33 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:39:33 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:39:33 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:39:33 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:39:33 INFO - Intel Iris: 15:39:33 INFO - Chipset Model: Intel Iris 15:39:33 INFO - Type: GPU 15:39:33 INFO - Bus: Built-In 15:39:33 INFO - VRAM (Dynamic, Max): 1536 MB 15:39:33 INFO - Vendor: Intel (0x8086) 15:39:33 INFO - Device ID: 0x0a2e 15:39:33 INFO - Revision ID: 0x0009 15:39:33 INFO - Displays: 15:39:33 INFO - Display: 15:39:33 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:39:33 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:39:33 INFO - Display Serial Number: 1600x1200 60 15:39:33 INFO - Main Display: Yes 15:39:33 INFO - Mirror: Off 15:39:33 INFO - Online: Yes 15:39:33 INFO - Rotation: Supported 15:39:33 INFO - Return code: 0 15:39:33 INFO - Running post-action listener: _resource_record_post_action 15:39:33 INFO - [mozharness: 2017-03-29 22:39:33.622121Z] Finished run-tests step (success) 15:39:33 INFO - Running post-run listener: _resource_record_post_run 15:39:33 INFO - Total resource usage - Wall time: 1190s; CPU: 53.0%; Read bytes: 38196224; Write bytes: 419447296; Read time: 242; Write time: 1360 15:39:33 INFO - TinderboxPrint: CPU usage
53.5% 15:39:33 INFO - TinderboxPrint: I/O read bytes / time
38,196,224 / 242 15:39:33 INFO - TinderboxPrint: I/O write bytes / time
419,447,296 / 1,360 15:39:33 INFO - TinderboxPrint: CPU idle
2,214.7 (46.5%) 15:39:33 INFO - TinderboxPrint: CPU system
945.3 (19.9%) 15:39:33 INFO - TinderboxPrint: CPU user
1,601.7 (33.6%) 15:39:33 INFO - TinderboxPrint: Swap in / out
160,317,440 / 0 15:39:33 INFO - install - Wall time: 15s; CPU: 54.0%; Read bytes: 122710528; Write bytes: 122437632; Read time: 11138; Write time: 273 15:39:33 INFO - run-tests - Wall time: 1176s; CPU: 53.0%; Read bytes: 34362368; Write bytes: 295469568; Read time: 219; Write time: 1082 15:39:34 INFO - Running post-run listener: _upload_blobber_files 15:39:34 INFO - Blob upload gear active. 15:39:34 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:39:34 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 15:39:34 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'] 15:39:34 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 15:39:34 INFO - (blobuploader) - INFO - Open directory for files ... 15:39:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 15:39:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:39:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:39:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 15:39:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:39:35 INFO - (blobuploader) - INFO - Done attempting. 15:39:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 15:39:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:39:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:39:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 15:39:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:39:36 INFO - (blobuploader) - INFO - Done attempting. 15:39:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 15:39:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:39:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:39:37 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 15:39:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:39:37 INFO - (blobuploader) - INFO - Done attempting. 15:39:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:39:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:39:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:39:39 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:39:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:39:39 INFO - (blobuploader) - INFO - Done attempting. 15:39:39 INFO - (blobuploader) - INFO - Iteration through files over. 15:39:39 INFO - Return code: 0 15:39:39 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:39:39 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:39:39 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/84912e8fbc0926e54e0f5f023ef69e4106710f2afd6ef345ddca555b784bdb7db5e290b4c657f353ddc27243362ff8aad7d08e316588ae1af9a7da79eeaee171", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a0e5375221a1b0fbfcfa029fb9a837d756b6801134703b9b19a87f51fbbd5fd790cbd3ffdbe9eb74579b50ba18c83deee252d16187c3f53abeedb9d610b50c2f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e72cc02f363a1f0c5dc6273a047dd174bd2860fbbc9ac72db1ae847a9f1dedd3705c924fb7d6cdb257515a42d297d545f77a9f39fb9ad8f41334aa9d69db9f1c", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0c57ff804d2a33159a234b7ce16ea33be69ccfae163cb829826c961427d0404dc03e9a3caf45241a71f62b266742e03329d9f5ad1808476887cd355acf5eada0"} 15:39:39 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:39:39 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:39:39 INFO - Contents: 15:39:39 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/84912e8fbc0926e54e0f5f023ef69e4106710f2afd6ef345ddca555b784bdb7db5e290b4c657f353ddc27243362ff8aad7d08e316588ae1af9a7da79eeaee171", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a0e5375221a1b0fbfcfa029fb9a837d756b6801134703b9b19a87f51fbbd5fd790cbd3ffdbe9eb74579b50ba18c83deee252d16187c3f53abeedb9d610b50c2f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e72cc02f363a1f0c5dc6273a047dd174bd2860fbbc9ac72db1ae847a9f1dedd3705c924fb7d6cdb257515a42d297d545f77a9f39fb9ad8f41334aa9d69db9f1c", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0c57ff804d2a33159a234b7ce16ea33be69ccfae163cb829826c961427d0404dc03e9a3caf45241a71f62b266742e03329d9f5ad1808476887cd355acf5eada0"} 15:39:39 INFO - Running post-run listener: copy_logs_to_upload_dir 15:39:39 INFO - Copying logs to upload dir... 15:39:39 INFO - mkdir: /builds/slave/test/build/upload/logs 15:39:39 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1254.782773 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2017-03-29 15:39:39.312937) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-29 15:39:39.316087) ========= 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.QcFmr5Rrnh/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.C0MpvK7zTr/Listeners TMPDIR=/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/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/84912e8fbc0926e54e0f5f023ef69e4106710f2afd6ef345ddca555b784bdb7db5e290b4c657f353ddc27243362ff8aad7d08e316588ae1af9a7da79eeaee171", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a0e5375221a1b0fbfcfa029fb9a837d756b6801134703b9b19a87f51fbbd5fd790cbd3ffdbe9eb74579b50ba18c83deee252d16187c3f53abeedb9d610b50c2f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e72cc02f363a1f0c5dc6273a047dd174bd2860fbbc9ac72db1ae847a9f1dedd3705c924fb7d6cdb257515a42d297d545f77a9f39fb9ad8f41334aa9d69db9f1c", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0c57ff804d2a33159a234b7ce16ea33be69ccfae163cb829826c961427d0404dc03e9a3caf45241a71f62b266742e03329d9f5ad1808476887cd355acf5eada0"} build_url:https://queue.taskcluster.net/v1/task/D8ypfo99Tp-XInZynU7iFA/artifacts/public/build/firefox-53.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011076 build_url: 'https://queue.taskcluster.net/v1/task/D8ypfo99Tp-XInZynU7iFA/artifacts/public/build/firefox-53.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/84912e8fbc0926e54e0f5f023ef69e4106710f2afd6ef345ddca555b784bdb7db5e290b4c657f353ddc27243362ff8aad7d08e316588ae1af9a7da79eeaee171", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a0e5375221a1b0fbfcfa029fb9a837d756b6801134703b9b19a87f51fbbd5fd790cbd3ffdbe9eb74579b50ba18c83deee252d16187c3f53abeedb9d610b50c2f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e72cc02f363a1f0c5dc6273a047dd174bd2860fbbc9ac72db1ae847a9f1dedd3705c924fb7d6cdb257515a42d297d545f77a9f39fb9ad8f41334aa9d69db9f1c", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0c57ff804d2a33159a234b7ce16ea33be69ccfae163cb829826c961427d0404dc03e9a3caf45241a71f62b266742e03329d9f5ad1808476887cd355acf5eada0"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-29 15:39:39.351027) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-29 15:39:39.351346) ========= 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.QcFmr5Rrnh/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.C0MpvK7zTr/Listeners TMPDIR=/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/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.005407 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-29 15:39:39.399814) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-29 15:39:39.400164) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-29 15:39:39.400531) ========= ========= Total master_lag: 0.18 =========