builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0051 starttime: 1490287137.86 results: success (0) buildid: 20170323080524 builduid: ed0d99478e6d4d8ba52ed029d32401ae revision: 7fec8b804687f87447477a5759039a2be4d16796 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-23 09:38:57.862108) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-23 09:38:57.862777) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-23 09:38:57.863078) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-23 09:38:57.893131) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-23 09:38:57.893638) ========= 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.vC0mavhZdU/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.dMLgMe3eN6/Listeners TMPDIR=/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/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-23 09:38:58-- 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% 7.37M=0.002s 2017-03-23 09:38:58 (7.37 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.099823 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-23 09:38:58.016675) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-23 09:38:58.017012) ========= 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.vC0mavhZdU/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.dMLgMe3eN6/Listeners TMPDIR=/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/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.020727 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-23 09:38:58.065278) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-23 09:38:58.065642) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 7fec8b804687f87447477a5759039a2be4d16796 --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-aurora --rev 7fec8b804687f87447477a5759039a2be4d16796 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.vC0mavhZdU/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.dMLgMe3eN6/Listeners TMPDIR=/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/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-23 09:38:58,250 truncating revision to first 12 chars 2017-03-23 09:38:58,250 Setting DEBUG logging. 2017-03-23 09:38:58,250 attempt 1/10 2017-03-23 09:38:58,250 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/7fec8b804687?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-23 09:38:59,794 unpacking tar archive at: mozilla-aurora-7fec8b804687/testing/mozharness/ program finished with exit code 0 elapsedTime=1.797668 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-23 09:38:59.884697) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-23 09:38:59.885024) ========= script_repo_revision: 7fec8b804687f87447477a5759039a2be4d16796 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-23 09:38:59.885478) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-23 09:38:59.885764) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-23 09:38:59.904626) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 23 secs) (at 2017-03-23 09:38:59.904946) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.vC0mavhZdU/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.dMLgMe3eN6/Listeners TMPDIR=/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 09:39:00 INFO - MultiFileLogger online at 20170323 09:39:00 in /builds/slave/test 09:39:00 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 09:39:00 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:39:00 INFO - {'append_to_log': False, 09:39:00 INFO - 'base_work_dir': '/builds/slave/test', 09:39:00 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 09:39:00 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:39:00 INFO - 'branch': 'Mozilla-Aurora', 09:39:00 INFO - 'buildbot_json_path': 'buildprops.json', 09:39:00 INFO - 'config_files': ('talos/mac_config.py',), 09:39:00 INFO - 'default_actions': ('clobber', 09:39:00 INFO - 'read-buildbot-config', 09:39:00 INFO - 'download-and-extract', 09:39:00 INFO - 'populate-webroot', 09:39:00 INFO - 'create-virtualenv', 09:39:00 INFO - 'install', 09:39:00 INFO - 'run-tests'), 09:39:00 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:39:00 INFO - 'download_minidump_stackwalk': True, 09:39:00 INFO - 'download_symbols': 'ondemand', 09:39:00 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:39:00 INFO - 'tooltool.py': '/tools/tooltool.py', 09:39:00 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:39:00 INFO - '/tools/misc-python/virtualenv.py')}, 09:39:00 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:39:00 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:39:00 INFO - 'gecko_profile': False, 09:39:00 INFO - 'gecko_profile_interval': 0, 09:39:00 INFO - 'installer_path': 'installer.exe', 09:39:00 INFO - 'log_level': 'info', 09:39:00 INFO - 'log_name': 'talos', 09:39:00 INFO - 'log_to_console': True, 09:39:00 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 09:39:00 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 09:39:00 INFO - 'opt_config_files': (), 09:39:00 INFO - 'pip_index': False, 09:39:00 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:39:00 INFO - 'cmd': ('bash', 09:39:00 INFO - '-c', 09:39:00 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:39:00 INFO - 'enabled': True, 09:39:00 INFO - 'halt_on_failure': False, 09:39:00 INFO - 'name': 'check_screen_resolution'},), 09:39:00 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:39:00 INFO - 'cmd': ('bash', 09:39:00 INFO - '-c', 09:39:00 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:39:00 INFO - 'enabled': True, 09:39:00 INFO - 'halt_on_failure': False, 09:39:00 INFO - 'name': 'check_screen_resolution'},), 09:39:00 INFO - 'run_cmd_checks_enabled': True, 09:39:00 INFO - 'suite': 'dromaeojs', 09:39:00 INFO - 'system_bits': '32', 09:39:00 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:39:00 INFO - 'title': 't-yosemite-r7-0051', 09:39:00 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:39:00 INFO - 'use_talos_json': True, 09:39:00 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:39:00 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:39:00 INFO - 'work_dir': 'build'} 09:39:00 INFO - [mozharness: 2017-03-23 16:39:00.201968Z] Running clobber step. 09:39:00 INFO - Running pre-action listener: _resource_record_pre_action 09:39:00 INFO - Running main action method: clobber 09:39:00 INFO - rmtree: /builds/slave/test/build 09:39:00 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:39:02 INFO - Running post-action listener: _resource_record_post_action 09:39:02 INFO - [mozharness: 2017-03-23 16:39:02.230263Z] Finished clobber step (success) 09:39:02 INFO - [mozharness: 2017-03-23 16:39:02.230409Z] Running read-buildbot-config step. 09:39:02 INFO - Running pre-action listener: _resource_record_pre_action 09:39:02 INFO - Running main action method: read_buildbot_config 09:39:02 INFO - Using buildbot properties: 09:39:02 INFO - { 09:39:02 INFO - "project": "", 09:39:02 INFO - "product": "firefox", 09:39:02 INFO - "script_repo_revision": "production", 09:39:02 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 09:39:02 INFO - "repository": "", 09:39:02 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 09:39:02 INFO - "buildid": "20170323080524", 09:39:02 INFO - "pgo_build": "False", 09:39:02 INFO - "basedir": "/builds/slave/test", 09:39:02 INFO - "buildnumber": 24, 09:39:02 INFO - "slavename": "t-yosemite-r7-0051", 09:39:02 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 09:39:02 INFO - "platform": "yosemite_r7", 09:39:02 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 09:39:02 INFO - "branch": "mozilla-aurora", 09:39:02 INFO - "repo_path": "releases/mozilla-aurora", 09:39:02 INFO - "revision": "7fec8b804687f87447477a5759039a2be4d16796", 09:39:02 INFO - "stage_platform": "macosx64", 09:39:02 INFO - "builduid": "ed0d99478e6d4d8ba52ed029d32401ae", 09:39:02 INFO - "slavebuilddir": "test" 09:39:02 INFO - } 09:39:02 INFO - Found installer url https://queue.taskcluster.net/v1/task/To3fmq63TUWxSLscsRR8Ew/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg. 09:39:02 INFO - Running post-action listener: _resource_record_post_action 09:39:02 INFO - [mozharness: 2017-03-23 16:39:02.233790Z] Finished read-buildbot-config step (success) 09:39:02 INFO - [mozharness: 2017-03-23 16:39:02.233906Z] Running download-and-extract step. 09:39:02 INFO - Running pre-action listener: _resource_record_pre_action 09:39:02 INFO - Running main action method: download_and_extract 09:39:02 INFO - mkdir: /builds/slave/test/build/tests 09:39:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:39:02 INFO - trying https://queue.taskcluster.net/v1/task/To3fmq63TUWxSLscsRR8Ew/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json 09:39:02 INFO - Downloading https://queue.taskcluster.net/v1/task/To3fmq63TUWxSLscsRR8Ew/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json 09:39:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/To3fmq63TUWxSLscsRR8Ew/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json'}, attempt #1 09:39:03 INFO - Downloaded 1199 bytes. 09:39:03 INFO - Reading from file /builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json 09:39:03 INFO - Using the following test package requirements: 09:39:03 INFO - {u'common': [u'firefox-54.0a2.en-US.mac.common.tests.zip'], 09:39:03 INFO - u'cppunittest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 09:39:03 INFO - u'firefox-54.0a2.en-US.mac.cppunittest.tests.zip'], 09:39:03 INFO - u'gtest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 09:39:03 INFO - u'firefox-54.0a2.en-US.mac.gtest.tests.zip'], 09:39:03 INFO - u'jittest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 09:39:03 INFO - u'jsshell-mac.zip'], 09:39:03 INFO - u'mochitest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 09:39:03 INFO - u'firefox-54.0a2.en-US.mac.mochitest.tests.zip'], 09:39:03 INFO - u'mozbase': [u'firefox-54.0a2.en-US.mac.common.tests.zip'], 09:39:03 INFO - u'reftest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 09:39:03 INFO - u'firefox-54.0a2.en-US.mac.reftest.tests.zip'], 09:39:03 INFO - u'talos': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 09:39:03 INFO - u'firefox-54.0a2.en-US.mac.talos.tests.zip'], 09:39:03 INFO - u'web-platform': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 09:39:03 INFO - u'firefox-54.0a2.en-US.mac.web-platform.tests.zip'], 09:39:03 INFO - u'xpcshell': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 09:39:03 INFO - u'firefox-54.0a2.en-US.mac.xpcshell.tests.zip']} 09:39:03 INFO - Downloading packages: [u'firefox-54.0a2.en-US.mac.common.tests.zip'] for test suite category: common 09:39:03 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/To3fmq63TUWxSLscsRR8Ew/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip 09:39:03 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/To3fmq63TUWxSLscsRR8Ew/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip'}, attempt #1 09:39:03 INFO - Fetch https://queue.taskcluster.net/v1/task/To3fmq63TUWxSLscsRR8Ew/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip into memory 09:39:04 INFO - Expected file size: 51782000 09:39:04 INFO - Obtained file size: 51782000 09:39:21 INFO - Downloading packages: [u'firefox-54.0a2.en-US.mac.common.tests.zip', u'firefox-54.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 09:39:21 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/To3fmq63TUWxSLscsRR8Ew/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip 09:39:21 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/To3fmq63TUWxSLscsRR8Ew/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip'}, attempt #1 09:39:21 INFO - Fetch https://queue.taskcluster.net/v1/task/To3fmq63TUWxSLscsRR8Ew/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip into memory 09:39:22 INFO - Expected file size: 51782000 09:39:22 INFO - Obtained file size: 51782000 09:39:37 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/To3fmq63TUWxSLscsRR8Ew/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip 09:39:37 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/To3fmq63TUWxSLscsRR8Ew/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip'}, attempt #1 09:39:37 INFO - Fetch https://queue.taskcluster.net/v1/task/To3fmq63TUWxSLscsRR8Ew/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip into memory 09:39:39 INFO - Expected file size: 14404438 09:39:39 INFO - Obtained file size: 14404438 09:39:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:39:39 INFO - trying https://queue.taskcluster.net/v1/task/To3fmq63TUWxSLscsRR8Ew/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 09:39:39 INFO - Downloading https://queue.taskcluster.net/v1/task/To3fmq63TUWxSLscsRR8Ew/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg 09:39:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/To3fmq63TUWxSLscsRR8Ew/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg'}, attempt #1 09:39:41 INFO - Downloaded 74759990 bytes. 09:39:41 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/To3fmq63TUWxSLscsRR8Ew/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 09:39:41 INFO - mkdir: /builds/slave/test/properties 09:39:41 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:39:41 INFO - Writing to file /builds/slave/test/properties/build_url 09:39:41 INFO - Contents: 09:39:41 INFO - build_url:https://queue.taskcluster.net/v1/task/To3fmq63TUWxSLscsRR8Ew/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 09:39:43 INFO - Running post-action listener: _resource_record_post_action 09:39:43 INFO - Running post-action listener: set_extra_try_arguments 09:39:43 INFO - [mozharness: 2017-03-23 16:39:43.041318Z] Finished download-and-extract step (success) 09:39:43 INFO - [mozharness: 2017-03-23 16:39:43.041424Z] Running populate-webroot step. 09:39:43 INFO - Running pre-action listener: _resource_record_pre_action 09:39:43 INFO - Running main action method: populate_webroot 09:39:43 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:39:43 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:39:43 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:39:43 INFO - '--tppagecycles', 09:39:43 INFO - '7'], 09:39:43 INFO - 'tests': ['tsvgm']}}, 09:39:43 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:39:43 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:39:43 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:39:43 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:39:43 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:39:43 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:39:43 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 09:39:43 INFO - 'talos_options': ['--disable-e10s'], 09:39:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:39:43 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 09:39:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:39:43 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 09:39:43 INFO - 'talos_options': ['--disable-e10s'], 09:39:43 INFO - 'tests': ['damp', 'tps']}, 09:39:43 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 09:39:43 INFO - 'tests': ['damp', 'tps']}, 09:39:43 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:39:43 INFO - 'tests': ['dromaeo_dom']}, 09:39:43 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:39:43 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:39:43 INFO - 'tests': ['basic_compositor_video']}, 09:39:43 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:39:43 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:39:43 INFO - 'tests': ['a11yr', 09:39:43 INFO - 'ts_paint', 09:39:43 INFO - 'tpaint', 09:39:43 INFO - 'sessionrestore', 09:39:43 INFO - 'sessionrestore_no_auto_restore', 09:39:43 INFO - 'tabpaint']}, 09:39:43 INFO - 'other-e10s': {'tests': ['a11yr', 09:39:43 INFO - 'ts_paint', 09:39:43 INFO - 'tpaint', 09:39:43 INFO - 'sessionrestore', 09:39:43 INFO - 'sessionrestore_no_auto_restore', 09:39:43 INFO - 'tabpaint']}, 09:39:43 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:39:43 INFO - 'ts_paint', 09:39:43 INFO - 'tpaint', 09:39:43 INFO - 'sessionrestore', 09:39:43 INFO - 'sessionrestore_no_auto_restore', 09:39:43 INFO - 'tabpaint']}, 09:39:43 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:39:43 INFO - 'ts_paint', 09:39:43 INFO - 'tpaint', 09:39:43 INFO - 'sessionrestore', 09:39:43 INFO - 'sessionrestore_no_auto_restore', 09:39:43 INFO - 'tabpaint']}, 09:39:43 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:39:43 INFO - 'tests': ['a11yr', 09:39:43 INFO - 'ts_paint', 09:39:43 INFO - 'tpaint', 09:39:43 INFO - 'sessionrestore', 09:39:43 INFO - 'sessionrestore_no_auto_restore', 09:39:43 INFO - 'tabpaint']}, 09:39:43 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:39:43 INFO - 'tests': ['a11yr', 09:39:43 INFO - 'ts_paint', 09:39:43 INFO - 'tpaint', 09:39:43 INFO - 'sessionrestore', 09:39:43 INFO - 'sessionrestore_no_auto_restore', 09:39:43 INFO - 'tabpaint']}, 09:39:43 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:39:43 INFO - 'tests': ['tsvgx', 09:39:43 INFO - 'tsvgr_opacity', 09:39:43 INFO - 'tart', 09:39:43 INFO - 'tscrollx', 09:39:43 INFO - 'cart', 09:39:43 INFO - 'tsvg_static']}, 09:39:43 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:39:43 INFO - 'tsvgr_opacity', 09:39:43 INFO - 'tart', 09:39:43 INFO - 'tscrollx', 09:39:43 INFO - 'cart', 09:39:43 INFO - 'tsvg_static']}, 09:39:43 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 09:39:43 INFO - 'talos_options': ['--disable-e10s'], 09:39:43 INFO - 'tests': ['tp5o']}, 09:39:43 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 09:39:43 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 09:39:43 INFO - 'talos_options': ['--disable-e10s', 09:39:43 INFO - '--xperf_path', 09:39:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:39:43 INFO - 'tests': ['tp5n']}, 09:39:43 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 09:39:43 INFO - 'talos_options': ['--xperf_path', 09:39:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:39:43 INFO - 'tests': ['tp5n']}}, 09:39:43 INFO - 'talos.zip': {'path': '', 09:39:43 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:39:43 INFO - Running post-action listener: _resource_record_post_action 09:39:43 INFO - [mozharness: 2017-03-23 16:39:43.059499Z] Finished populate-webroot step (success) 09:39:43 INFO - [mozharness: 2017-03-23 16:39:43.059603Z] Running create-virtualenv step. 09:39:43 INFO - Running pre-action listener: _resource_record_pre_action 09:39:43 INFO - Running main action method: create_virtualenv 09:39:43 INFO - Creating virtualenv /builds/slave/test/build/venv 09:39:43 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 09:39:43 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:39:43 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:39:43 INFO - Using real prefix '/tools/python27' 09:39:43 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:39:43 INFO - Installing distribute.............................................................................................................................................................................................done. 09:39:46 INFO - Installing pip.................done. 09:39:46 INFO - Return code: 0 09:39:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:39:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:39:46 INFO - Reading from file tmpfile_stdout 09:39:46 INFO - Output received: 09:39:46 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) 09:39:46 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:39:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:39:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:39:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:39:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:39:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:39:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:39:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b6a2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b6a5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd220d98710>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b480d30>, '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 0x10b3a7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b475be8>, '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.vC0mavhZdU/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.dMLgMe3eN6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:39:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 09:39:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:39:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vC0mavhZdU/Render', 09:39:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:39:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:39:47 INFO - 'HOME': '/Users/cltbld', 09:39:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:39:47 INFO - 'LOGNAME': 'cltbld', 09:39:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:39:47 INFO - 'MOZ_NO_REMOTE': '1', 09:39:47 INFO - 'NO_EM_RESTART': '1', 09:39:47 INFO - 'PAGER': '/bin/cat', 09:39:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:39:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:39:47 INFO - 'PWD': '/builds/slave/test', 09:39:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:39:47 INFO - 'SHELL': '/bin/bash', 09:39:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dMLgMe3eN6/Listeners', 09:39:47 INFO - 'TMPDIR': '/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/', 09:39:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:39:47 INFO - 'USER': 'cltbld', 09:39:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:39:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:39:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:39:47 INFO - 'XPC_FLAGS': '0x0', 09:39:47 INFO - 'XPC_SERVICE_NAME': '0', 09:39:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:39:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:39:47 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 09:39:47 INFO - Cleaning up... 09:39:47 INFO - Return code: 0 09:39:47 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:39:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:39:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:39:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:39:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:39:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:39:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:39:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10b6a2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b6a5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd220d98710>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b480d30>, '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 0x10b3a7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b475be8>, '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.vC0mavhZdU/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.dMLgMe3eN6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:39:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 09:39:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 09:39:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vC0mavhZdU/Render', 09:39:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:39:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:39:47 INFO - 'HOME': '/Users/cltbld', 09:39:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:39:47 INFO - 'LOGNAME': 'cltbld', 09:39:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:39:47 INFO - 'MOZ_NO_REMOTE': '1', 09:39:47 INFO - 'NO_EM_RESTART': '1', 09:39:47 INFO - 'PAGER': '/bin/cat', 09:39:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:39:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:39:47 INFO - 'PWD': '/builds/slave/test', 09:39:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:39:47 INFO - 'SHELL': '/bin/bash', 09:39:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dMLgMe3eN6/Listeners', 09:39:47 INFO - 'TMPDIR': '/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/', 09:39:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:39:47 INFO - 'USER': 'cltbld', 09:39:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:39:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:39:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:39:47 INFO - 'XPC_FLAGS': '0x0', 09:39:47 INFO - 'XPC_SERVICE_NAME': '0', 09:39:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:39:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:39:47 INFO - Downloading/unpacking psutil>=3.1.1 09:39:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:39:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:39:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:39:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:39:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:39:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:39:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:39:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:39:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:39:51 INFO - Installing collected packages: psutil 09:39:51 INFO - Running setup.py install for psutil 09:39:51 INFO - building 'psutil._psutil_osx' extension 09:39:51 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 09:39:52 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 09:39:52 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 09:39:52 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 09:39:52 INFO - building 'psutil._psutil_posix' extension 09:39:52 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 09:39:52 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 09:39:52 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 09:39:52 INFO - ^ 09:39:52 INFO - 1 warning generated. 09:39:52 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 09:39:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:39:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:39:52 INFO - Successfully installed psutil 09:39:52 INFO - Cleaning up... 09:39:52 INFO - Return code: 0 09:39:52 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:39:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:39:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:39:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:39:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:39:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:39:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:39:52 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 0x10b6a2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b6a5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd220d98710>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b480d30>, '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 0x10b3a7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b475be8>, '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.vC0mavhZdU/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.dMLgMe3eN6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:39:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 09:39:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 09:39:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vC0mavhZdU/Render', 09:39:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:39:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:39:52 INFO - 'HOME': '/Users/cltbld', 09:39:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:39:52 INFO - 'LOGNAME': 'cltbld', 09:39:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:39:52 INFO - 'MOZ_NO_REMOTE': '1', 09:39:52 INFO - 'NO_EM_RESTART': '1', 09:39:52 INFO - 'PAGER': '/bin/cat', 09:39:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:39:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:39:52 INFO - 'PWD': '/builds/slave/test', 09:39:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:39:52 INFO - 'SHELL': '/bin/bash', 09:39:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dMLgMe3eN6/Listeners', 09:39:52 INFO - 'TMPDIR': '/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/', 09:39:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:39:52 INFO - 'USER': 'cltbld', 09:39:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:39:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:39:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:39:52 INFO - 'XPC_FLAGS': '0x0', 09:39:52 INFO - 'XPC_SERVICE_NAME': '0', 09:39:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:39:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:39:52 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:39:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:39:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:39:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:39:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:39:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:39:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:39:55 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:39:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:39:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:39:55 INFO - Installing collected packages: mozsystemmonitor 09:39:55 INFO - Running setup.py install for mozsystemmonitor 09:39:55 INFO - Successfully installed mozsystemmonitor 09:39:55 INFO - Cleaning up... 09:39:55 INFO - Return code: 0 09:39:55 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:39:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:39:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:39:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:39:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:39:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:39:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:39:56 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 0x10b6a2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b6a5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd220d98710>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b480d30>, '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 0x10b3a7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b475be8>, '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.vC0mavhZdU/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.dMLgMe3eN6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:39:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 09:39:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 09:39:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vC0mavhZdU/Render', 09:39:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:39:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:39:56 INFO - 'HOME': '/Users/cltbld', 09:39:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:39:56 INFO - 'LOGNAME': 'cltbld', 09:39:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:39:56 INFO - 'MOZ_NO_REMOTE': '1', 09:39:56 INFO - 'NO_EM_RESTART': '1', 09:39:56 INFO - 'PAGER': '/bin/cat', 09:39:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:39:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:39:56 INFO - 'PWD': '/builds/slave/test', 09:39:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:39:56 INFO - 'SHELL': '/bin/bash', 09:39:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dMLgMe3eN6/Listeners', 09:39:56 INFO - 'TMPDIR': '/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/', 09:39:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:39:56 INFO - 'USER': 'cltbld', 09:39:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:39:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:39:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:39:56 INFO - 'XPC_FLAGS': '0x0', 09:39:56 INFO - 'XPC_SERVICE_NAME': '0', 09:39:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:39:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:39:56 INFO - Downloading/unpacking jsonschema==2.5.1 09:39:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:39:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:39:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:39:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:39:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:39:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:39:59 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:39:59 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:39:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:39:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:39:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:39:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:39:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:39:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:40:00 INFO - Downloading functools32-3.2.3-2.tar.gz 09:40:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:40:00 INFO - warning: no files found matching '*.txt' 09:40:00 INFO - no previously-included directories found matching 'build' 09:40:00 INFO - no previously-included directories found matching 'dist' 09:40:00 INFO - no previously-included directories found matching '.git*' 09:40:00 INFO - Installing collected packages: jsonschema, functools32 09:40:00 INFO - Running setup.py install for functools32 09:40:00 INFO - warning: no files found matching '*.txt' 09:40:00 INFO - no previously-included directories found matching 'build' 09:40:00 INFO - no previously-included directories found matching 'dist' 09:40:00 INFO - no previously-included directories found matching '.git*' 09:40:00 INFO - Successfully installed jsonschema functools32 09:40:00 INFO - Cleaning up... 09:40:00 INFO - Return code: 0 09:40:00 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:40:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:40:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:40:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:40:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:40:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:40:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:40:00 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 0x10b6a2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b6a5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd220d98710>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b480d30>, '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 0x10b3a7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b475be8>, '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.vC0mavhZdU/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.dMLgMe3eN6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:40:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 09:40:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 09:40:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vC0mavhZdU/Render', 09:40:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:40:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:40:00 INFO - 'HOME': '/Users/cltbld', 09:40:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:40:00 INFO - 'LOGNAME': 'cltbld', 09:40:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:40:00 INFO - 'MOZ_NO_REMOTE': '1', 09:40:00 INFO - 'NO_EM_RESTART': '1', 09:40:00 INFO - 'PAGER': '/bin/cat', 09:40:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:40:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:40:00 INFO - 'PWD': '/builds/slave/test', 09:40:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:40:00 INFO - 'SHELL': '/bin/bash', 09:40:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dMLgMe3eN6/Listeners', 09:40:00 INFO - 'TMPDIR': '/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/', 09:40:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:40:00 INFO - 'USER': 'cltbld', 09:40:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:40:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:40:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:40:00 INFO - 'XPC_FLAGS': '0x0', 09:40:00 INFO - 'XPC_SERVICE_NAME': '0', 09:40:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:40:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:40:00 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:40:00 INFO - Cleaning up... 09:40:00 INFO - Return code: 0 09:40:00 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:40:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:40:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:40:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:40:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:40:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:40:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:40:00 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 0x10b6a2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b6a5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd220d98710>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b480d30>, '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 0x10b3a7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b475be8>, '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.vC0mavhZdU/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.dMLgMe3eN6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:40:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:40:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:40:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vC0mavhZdU/Render', 09:40:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:40:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:40:00 INFO - 'HOME': '/Users/cltbld', 09:40:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:40:00 INFO - 'LOGNAME': 'cltbld', 09:40:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:40:00 INFO - 'MOZ_NO_REMOTE': '1', 09:40:00 INFO - 'NO_EM_RESTART': '1', 09:40:00 INFO - 'PAGER': '/bin/cat', 09:40:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:40:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:40:00 INFO - 'PWD': '/builds/slave/test', 09:40:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:40:00 INFO - 'SHELL': '/bin/bash', 09:40:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dMLgMe3eN6/Listeners', 09:40:00 INFO - 'TMPDIR': '/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/', 09:40:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:40:00 INFO - 'USER': 'cltbld', 09:40:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:40:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:40:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:40:00 INFO - 'XPC_FLAGS': '0x0', 09:40:00 INFO - 'XPC_SERVICE_NAME': '0', 09:40:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:40:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:40:01 INFO - Downloading/unpacking blobuploader==1.2.4 09:40:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:40:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:40:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:40:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:40:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:40:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:40:03 INFO - Downloading blobuploader-1.2.4.tar.gz 09:40:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:40:03 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:40:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:40:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:40:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:40:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:40:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:40:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:40:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:40:04 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:40:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:40:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:40:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:40:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:40:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:40:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:40:05 INFO - Downloading docopt-0.6.1.tar.gz 09:40:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:40:05 INFO - Installing collected packages: blobuploader, requests, docopt 09:40:05 INFO - Running setup.py install for blobuploader 09:40:05 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:40:05 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:40:05 INFO - Running setup.py install for requests 09:40:05 INFO - Running setup.py install for docopt 09:40:05 INFO - Successfully installed blobuploader requests docopt 09:40:05 INFO - Cleaning up... 09:40:05 INFO - Return code: 0 09:40:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:40:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:40:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:40:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:40:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:40:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:40:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:40:05 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 0x10b6a2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b6a5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd220d98710>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b480d30>, '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 0x10b3a7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b475be8>, '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.vC0mavhZdU/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.dMLgMe3eN6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:40:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:40:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:40:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vC0mavhZdU/Render', 09:40:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:40:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:40:05 INFO - 'HOME': '/Users/cltbld', 09:40:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:40:05 INFO - 'LOGNAME': 'cltbld', 09:40:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:40:05 INFO - 'MOZ_NO_REMOTE': '1', 09:40:05 INFO - 'NO_EM_RESTART': '1', 09:40:06 INFO - 'PAGER': '/bin/cat', 09:40:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:40:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:40:06 INFO - 'PWD': '/builds/slave/test', 09:40:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:40:06 INFO - 'SHELL': '/bin/bash', 09:40:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dMLgMe3eN6/Listeners', 09:40:06 INFO - 'TMPDIR': '/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/', 09:40:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:40:06 INFO - 'USER': 'cltbld', 09:40:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:40:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:40:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:40:06 INFO - 'XPC_FLAGS': '0x0', 09:40:06 INFO - 'XPC_SERVICE_NAME': '0', 09:40:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:40:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:40:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:40:06 INFO - Running setup.py (path:/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/pip-UJcrPw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:40:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:40:06 INFO - Running setup.py (path:/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/pip-78jvwB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:40:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:40:06 INFO - Running setup.py (path:/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/pip-o3IVcS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:40:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:40:06 INFO - Running setup.py (path:/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/pip-hvG2vs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:40:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:40:06 INFO - Running setup.py (path:/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/pip-tLkGpR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:40:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:40:06 INFO - Running setup.py (path:/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/pip-26f6cJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:40:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:40:06 INFO - Running setup.py (path:/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/pip-q13eCJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:40:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:40:07 INFO - Running setup.py (path:/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/pip-Wt5NZ7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:40:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:40:07 INFO - Running setup.py (path:/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/pip-mk0z6j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:40:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:40:07 INFO - Running setup.py (path:/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/pip-geIqDG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:40:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:40:07 INFO - Running setup.py (path:/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/pip-pVyF1a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:40:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:40:07 INFO - Running setup.py (path:/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/pip-OOCMxH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:40:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:40:07 INFO - Running setup.py (path:/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/pip-E2LZdr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:40:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:40:07 INFO - Running setup.py (path:/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/pip-hD9HnG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:40:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:40:07 INFO - Running setup.py (path:/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/pip-rZFLlU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:40:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:40:07 INFO - Running setup.py (path:/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/pip-nX_p2h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:40:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:40:08 INFO - Running setup.py (path:/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/pip-WJD8Nh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:40:08 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:40:08 INFO - Running setup.py install for manifestparser 09:40:08 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:40:08 INFO - Running setup.py install for mozcrash 09:40:08 INFO - Running setup.py install for mozdebug 09:40:08 INFO - Running setup.py install for mozdevice 09:40:08 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:40:08 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:40:08 INFO - Running setup.py install for mozfile 09:40:08 INFO - Running setup.py install for mozhttpd 09:40:09 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:40:09 INFO - Running setup.py install for mozinfo 09:40:09 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:40:09 INFO - Running setup.py install for mozInstall 09:40:09 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:40:09 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:40:09 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:40:09 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:40:09 INFO - Running setup.py install for mozleak 09:40:09 INFO - Running setup.py install for mozlog 09:40:09 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:40:09 INFO - Running setup.py install for moznetwork 09:40:09 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:40:09 INFO - Running setup.py install for mozprocess 09:40:09 INFO - Running setup.py install for mozprofile 09:40:10 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:40:10 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:40:10 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:40:10 INFO - Running setup.py install for mozrunner 09:40:10 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:40:10 INFO - Running setup.py install for mozscreenshot 09:40:10 INFO - Running setup.py install for moztest 09:40:10 INFO - Running setup.py install for mozversion 09:40:10 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:40:10 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:40:10 INFO - Cleaning up... 09:40:10 INFO - Return code: 0 09:40:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:40:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:40:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:40:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:40:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:40:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:40:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:40:10 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 0x10b6a2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b6a5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd220d98710>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b480d30>, '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 0x10b3a7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b475be8>, '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.vC0mavhZdU/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.dMLgMe3eN6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:40:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:40:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:40:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vC0mavhZdU/Render', 09:40:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:40:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:40:10 INFO - 'HOME': '/Users/cltbld', 09:40:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:40:10 INFO - 'LOGNAME': 'cltbld', 09:40:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:40:10 INFO - 'MOZ_NO_REMOTE': '1', 09:40:10 INFO - 'NO_EM_RESTART': '1', 09:40:10 INFO - 'PAGER': '/bin/cat', 09:40:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:40:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:40:10 INFO - 'PWD': '/builds/slave/test', 09:40:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:40:10 INFO - 'SHELL': '/bin/bash', 09:40:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dMLgMe3eN6/Listeners', 09:40:10 INFO - 'TMPDIR': '/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/', 09:40:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:40:10 INFO - 'USER': 'cltbld', 09:40:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:40:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:40:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:40:10 INFO - 'XPC_FLAGS': '0x0', 09:40:10 INFO - 'XPC_SERVICE_NAME': '0', 09:40:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:40:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:40:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:40:11 INFO - Running setup.py (path:/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/pip-6pE8zR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:40:11 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 09:40:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:40:11 INFO - Running setup.py (path:/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/pip-33slaL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:40:11 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)) 09:40:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:40:11 INFO - Running setup.py (path:/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/pip-ucB9gz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:40:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:40:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:40:11 INFO - Running setup.py (path:/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/pip-QyWb9h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:40:11 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)) 09:40:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:40:11 INFO - Running setup.py (path:/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/pip-mwiAfv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:40:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 09:40:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:40:11 INFO - Running setup.py (path:/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/pip-b8VBEc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:40:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 09:40:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:40:11 INFO - Running setup.py (path:/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/pip-cSfEEa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:40:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 09:40:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:40:11 INFO - Running setup.py (path:/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/pip-nq0mSX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:40:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 09:40:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:40:11 INFO - Running setup.py (path:/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/pip-9VMLhY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:40:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 09:40:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:40:11 INFO - Running setup.py (path:/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/pip-xGfleY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:40:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:40:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:40:12 INFO - Running setup.py (path:/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/pip-4PbdnQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:40:12 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 09:40:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:40:12 INFO - Running setup.py (path:/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/pip-5y6e66-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:40:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 09:40:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:40:12 INFO - Running setup.py (path:/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/pip-MAtDwE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:40:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 09:40:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:40:12 INFO - Running setup.py (path:/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/pip-baItXm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:40:12 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)) 09:40:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:40:12 INFO - Running setup.py (path:/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/pip-AY43iU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:40:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 09:40:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:40:12 INFO - Running setup.py (path:/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/pip-HYKMfg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:40:12 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)) 09:40:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:40:12 INFO - Running setup.py (path:/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/pip-HUJHqC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:40:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 09:40:12 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)) 09:40:12 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)) 09:40:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:40:12 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)) 09:40:12 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)) 09:40:12 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:40:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:40:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:40:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:40:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:40:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:40:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:40:15 INFO - Downloading blessings-1.6.tar.gz 09:40:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:40:15 INFO - Installing collected packages: blessings 09:40:15 INFO - Running setup.py install for blessings 09:40:15 INFO - Successfully installed blessings 09:40:15 INFO - Cleaning up... 09:40:15 INFO - Return code: 0 09:40:15 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:40:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:40:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:40:15 INFO - Reading from file tmpfile_stdout 09:40:15 INFO - Current package versions: 09:40:15 INFO - blessings == 1.6 09:40:15 INFO - blobuploader == 1.2.4 09:40:15 INFO - docopt == 0.6.1 09:40:15 INFO - functools32 == 3.2.3-2 09:40:15 INFO - jsonschema == 2.5.1 09:40:15 INFO - manifestparser == 1.1 09:40:15 INFO - mozInstall == 1.12 09:40:15 INFO - mozcrash == 1.0 09:40:15 INFO - mozdebug == 0.1 09:40:15 INFO - mozdevice == 0.49 09:40:15 INFO - mozfile == 1.2 09:40:15 INFO - mozhttpd == 0.7 09:40:15 INFO - mozinfo == 0.9 09:40:15 INFO - mozleak == 0.1 09:40:15 INFO - mozlog == 3.4 09:40:15 INFO - moznetwork == 0.27 09:40:15 INFO - mozprocess == 0.25 09:40:15 INFO - mozprofile == 0.28 09:40:15 INFO - mozrunner == 6.13 09:40:15 INFO - mozscreenshot == 0.1 09:40:15 INFO - mozsystemmonitor == 0.3 09:40:15 INFO - moztest == 0.8 09:40:15 INFO - mozversion == 1.4 09:40:15 INFO - psutil == 3.1.1 09:40:15 INFO - requests == 1.2.3 09:40:15 INFO - wsgiref == 0.1.2 09:40:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:40:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:40:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:40:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:40:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:40:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:40:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:40:16 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 0x10b6a2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b6a5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd220d98710>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b480d30>, '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 0x10b3a7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b475be8>, '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.vC0mavhZdU/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.dMLgMe3eN6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:40:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 09:40:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:40:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vC0mavhZdU/Render', 09:40:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:40:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:40:16 INFO - 'HOME': '/Users/cltbld', 09:40:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:40:16 INFO - 'LOGNAME': 'cltbld', 09:40:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:40:16 INFO - 'MOZ_NO_REMOTE': '1', 09:40:16 INFO - 'NO_EM_RESTART': '1', 09:40:16 INFO - 'PAGER': '/bin/cat', 09:40:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:40:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:40:16 INFO - 'PWD': '/builds/slave/test', 09:40:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:40:16 INFO - 'SHELL': '/bin/bash', 09:40:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dMLgMe3eN6/Listeners', 09:40:16 INFO - 'TMPDIR': '/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/', 09:40:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:40:16 INFO - 'USER': 'cltbld', 09:40:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:40:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:40:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:40:16 INFO - 'XPC_FLAGS': '0x0', 09:40:16 INFO - 'XPC_SERVICE_NAME': '0', 09:40:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:40:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:40:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:40:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 09:40:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 09:40:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:40:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 09:40:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 09:40:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 09:40:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 09:40:16 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 09:40:16 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:40:16 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:40:16 INFO - Cleaning up... 09:40:16 INFO - Return code: 0 09:40:16 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:40:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:40:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:40:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:40:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:40:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:40:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:40:16 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 0x10b6a2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b6a5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd220d98710>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b480d30>, '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 0x10b3a7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b475be8>, '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.vC0mavhZdU/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.dMLgMe3eN6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:40:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 09:40:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:40:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vC0mavhZdU/Render', 09:40:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:40:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:40:16 INFO - 'HOME': '/Users/cltbld', 09:40:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:40:16 INFO - 'LOGNAME': 'cltbld', 09:40:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:40:16 INFO - 'MOZ_NO_REMOTE': '1', 09:40:16 INFO - 'NO_EM_RESTART': '1', 09:40:16 INFO - 'PAGER': '/bin/cat', 09:40:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:40:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:40:16 INFO - 'PWD': '/builds/slave/test', 09:40:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:40:16 INFO - 'SHELL': '/bin/bash', 09:40:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dMLgMe3eN6/Listeners', 09:40:16 INFO - 'TMPDIR': '/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/', 09:40:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:40:16 INFO - 'USER': 'cltbld', 09:40:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:40:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:40:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:40:16 INFO - 'XPC_FLAGS': '0x0', 09:40:16 INFO - 'XPC_SERVICE_NAME': '0', 09:40:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:40:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:40:16 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:40:16 INFO - Cleaning up... 09:40:16 INFO - Return code: 0 09:40:16 INFO - Running post-action listener: _resource_record_post_action 09:40:16 INFO - Running post-action listener: _start_resource_monitoring 09:40:16 INFO - Starting resource monitoring. 09:40:16 INFO - [mozharness: 2017-03-23 16:40:16.556199Z] Finished create-virtualenv step (success) 09:40:16 INFO - [mozharness: 2017-03-23 16:40:16.557175Z] Running install step. 09:40:16 INFO - Running pre-action listener: _resource_record_pre_action 09:40:16 INFO - Running main action method: install 09:40:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:40:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:40:16 INFO - Reading from file tmpfile_stdout 09:40:16 INFO - Detecting whether we're running mozinstall >=1.0... 09:40:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:40:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:40:16 INFO - Reading from file tmpfile_stdout 09:40:16 INFO - Output received: 09:40:16 INFO - Usage: mozinstall [options] installer 09:40:16 INFO - Options: 09:40:16 INFO - -h, --help show this help message and exit 09:40:16 INFO - -d DEST, --destination=DEST 09:40:16 INFO - Directory to install application into. [default: 09:40:16 INFO - "/builds/slave/test"] 09:40:16 INFO - --app=APP Application being installed. [default: firefox] 09:40:16 INFO - mkdir: /builds/slave/test/build/application 09:40:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 09:40:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 09:40:36 INFO - Reading from file tmpfile_stdout 09:40:36 INFO - Output received: 09:40:36 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 09:40:36 INFO - Running post-action listener: _resource_record_post_action 09:40:36 INFO - [mozharness: 2017-03-23 16:40:36.990181Z] Finished install step (success) 09:40:36 INFO - [mozharness: 2017-03-23 16:40:36.990356Z] Running run-tests step. 09:40:36 INFO - Running pre-action listener: _resource_record_pre_action 09:40:36 INFO - Running main action method: run_tests 09:40:36 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:40:36 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:40:36 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:40:37 INFO - 2017-03-23 09:40:37.004 screenresolution[1970:16330] starting screenresolution argv=screenresolution get 09:40:37 INFO - 2017-03-23 09:40:37.007 screenresolution[1970:16330] Display 0: 1600x1200x32@60 09:40:37 INFO - 2017-03-23 09:40:37.013 screenresolution[1971:16332] starting screenresolution argv=screenresolution list 09:40:37 INFO - Available Modes on Display 0 09:40:37 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:40:37 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:40:37 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:40:37 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:40:37 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:40:37 INFO - Intel Iris: 09:40:37 INFO - Chipset Model: Intel Iris 09:40:37 INFO - Type: GPU 09:40:37 INFO - Bus: Built-In 09:40:37 INFO - VRAM (Dynamic, Max): 1536 MB 09:40:37 INFO - Vendor: Intel (0x8086) 09:40:37 INFO - Device ID: 0x0a2e 09:40:37 INFO - Revision ID: 0x0009 09:40:37 INFO - Displays: 09:40:37 INFO - Display: 09:40:37 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:40:37 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:40:37 INFO - Display Serial Number: 1600x1200 60 09:40:37 INFO - Main Display: Yes 09:40:37 INFO - Mirror: Off 09:40:37 INFO - Online: Yes 09:40:37 INFO - Rotation: Supported 09:40:37 INFO - Return code: 0 09:40:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:40:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:40:37 INFO - Python 2.7.3 09:40:37 INFO - Return code: 0 09:40:37 INFO - grabbing minidump binary from tooltool 09:40:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:40:37 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 0x10b480d30>, '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 0x10b3a7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b475be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:40:37 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 09:40:37 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 09:40:37 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 09:40:37 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:40:37 INFO - Return code: 0 09:40:37 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 09:40:37 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:40:37 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:40:37 INFO - ENV: RUST_BACKTRACE is now 1 09:40:37 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 09:40:37 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:40:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/To3fmq63TUWxSLscsRR8Ew/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0051', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 09:40:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/To3fmq63TUWxSLscsRR8Ew/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0051 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 09:40:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vC0mavhZdU/Render', 09:40:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:40:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:40:37 INFO - 'HOME': '/Users/cltbld', 09:40:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:40:37 INFO - 'LOGNAME': 'cltbld', 09:40:37 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:40:37 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 09:40:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:40:37 INFO - 'MOZ_NO_REMOTE': '1', 09:40:37 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:40:37 INFO - 'NO_EM_RESTART': '1', 09:40:37 INFO - 'PAGER': '/bin/cat', 09:40:37 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:40:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:40:37 INFO - 'PWD': '/builds/slave/test', 09:40:37 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:40:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:40:37 INFO - 'RUST_BACKTRACE': '1', 09:40:37 INFO - 'SHELL': '/bin/bash', 09:40:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dMLgMe3eN6/Listeners', 09:40:37 INFO - 'TMPDIR': '/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/', 09:40:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:40:37 INFO - 'USER': 'cltbld', 09:40:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:40:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:40:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:40:37 INFO - 'XPC_FLAGS': '0x0', 09:40:37 INFO - 'XPC_SERVICE_NAME': '0', 09:40:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:40:37 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/To3fmq63TUWxSLscsRR8Ew/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0051', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 09:40:37 INFO - mozversion application_buildid: 20170323080524 09:40:37 INFO - mozversion application_changeset: 7fec8b804687f87447477a5759039a2be4d16796 09:40:37 INFO - mozversion application_display_name: FirefoxDeveloperEdition 09:40:37 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:40:37 INFO - mozversion application_name: Firefox 09:40:37 INFO - mozversion application_remotingname: firefox-dev 09:40:37 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:40:37 INFO - mozversion application_vendor: Mozilla 09:40:37 INFO - mozversion application_version: 54.0a2 09:40:37 INFO - mozversion platform_buildid: 20170323080524 09:40:37 INFO - mozversion platform_changeset: 7fec8b804687f87447477a5759039a2be4d16796 09:40:37 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:40:37 INFO - mozversion platform_version: 54.0a2 09:40:37 INFO - using testdate: 1490287237 09:40:37 INFO - actual date: 1490287237 09:40:37 INFO - starting webserver on 'localhost:53009' 09:40:37 INFO - SUITE-START | Running 2 tests 09:40:37 INFO - TEST-START | dromaeo_css 09:40:37 INFO - operating with platform_type : mac_ 09:40:37 INFO - Initialising browser for dromaeo_css test... 09:40:37 INFO - TEST-INFO | started process 1981 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/tmpdqnKiy/profile http://localhost:53009/getInfo.html) 09:40:39 INFO - PROCESS | 1981 | __metrics Screen width/height:1600/1200 09:40:39 INFO - PROCESS | 1981 | colorDepth:24 09:40:39 INFO - PROCESS | 1981 | Browser inner width/height: 1024/689 09:40:39 INFO - PROCESS | 1981 | __metrics 09:40:40 INFO - PROCESS | 1981 | 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" 09:40:40 INFO - PROCESS | 1981 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:40:40 INFO - TEST-INFO | 1981: exit 0 09:40:40 INFO - Browser initialized. 09:40:40 INFO - Running cycle 1/1 for dromaeo_css test... 09:40:40 INFO - TEST-INFO | started process 1983 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/tmpdqnKiy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:40:53 INFO - PROCESS | 1983 | RSS: Main: 215273472 09:40:53 INFO - PROCESS | 1983 | 09:43:57 INFO - PROCESS | 1983 | Cycle 1(1): loaded http://localhost:53009/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53009/tests/dromaeo/cssquery-ext.html) 09:43:59 INFO - PROCESS | 1983 | RSS: Main: 348413952 09:43:59 INFO - PROCESS | 1983 | 09:45:43 INFO - PROCESS | 1983 | ************************* 09:45:43 INFO - PROCESS | 1983 | A coding exception was thrown and uncaught in a Task. 09:45:43 INFO - PROCESS | 1983 | 09:45:43 ERROR - PROCESS | 1983 | Full message: TypeError: NetworkError when attempting to fetch resource. 09:45:43 INFO - PROCESS | 1983 | Full stack: 09:45:43 INFO - PROCESS | 1983 | ************************* 09:47:02 INFO - PROCESS | 1983 | Cycle 1(1): loaded http://localhost:53009/tests/dromaeo/cssquery-ext.html (next: http://localhost:53009/tests/dromaeo/cssquery-jquery.html) 09:47:02 INFO - PROCESS | 1983 | RSS: Main: 366170112 09:47:02 INFO - PROCESS | 1983 | 09:50:05 INFO - PROCESS | 1983 | Cycle 1(1): loaded http://localhost:53009/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53009/tests/dromaeo/cssquery-mootools.html) 09:50:05 INFO - PROCESS | 1983 | RSS: Main: 333479936 09:50:05 INFO - PROCESS | 1983 | 09:53:08 INFO - PROCESS | 1983 | Cycle 1(1): loaded http://localhost:53009/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53009/tests/dromaeo/cssquery-prototype.html) 09:53:08 INFO - PROCESS | 1983 | RSS: Main: 322981888 09:53:08 INFO - PROCESS | 1983 | 09:56:12 INFO - PROCESS | 1983 | Cycle 1(1): loaded http://localhost:53009/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53009/tests/dromaeo/cssquery-yui.html) 09:56:13 INFO - PROCESS | 1983 | RSS: Main: 320974848 09:56:13 INFO - PROCESS | 1983 | 09:59:16 INFO - PROCESS | 1983 | Cycle 1(1): loaded http://localhost:53009/tests/dromaeo/cssquery-yui.html (next: http://localhost:53009/tests/dromaeo/cssquery-dojo.html) 09:59:16 INFO - PROCESS | 1983 | RSS: Main: 453087232 09:59:16 INFO - PROCESS | 1983 | 09:59:16 INFO - PROCESS | 1983 | __start_tp_report 09:59:16 INFO - PROCESS | 1983 | _x_x_mozilla_page_load 09:59:16 INFO - PROCESS | 1983 | _x_x_mozilla_page_load_details 09:59:16 INFO - PROCESS | 1983 | |i|pagename|runs| 09:59:16 INFO - PROCESS | 1983 | |0;dojo.html;3419.692227699507;3426.537417448645;3428.314337132574;3428.6057103433113;3489.354469423157;6041.275046994361;6111.743676692132;6122.540809439293;6127.908081378783;6134.429849761934;6077.058056001327;6086.056661217518;6125.9387406125925;6126.479249263818;6146.81559553213;5428;5462.426445223234;5498.340199176085;5506.063969125258;5588.552915766729;5373.435789242132;5382.300300960869;5587.580931430139;5592.3009623797025;5602.915956260659;5444.183372494138;5469.398366179717;5505.229267902497;5554.472325129106;5566.192902029204;5532;5565.165225216209;5572.3034620672415;5575.107982722745;5575.944240557583;5308.73456327186;5433.4566543345745;5483.533899618537;5494.890102197934;5511.118221084607;6037.30570984338;6078.544109191828;6084.756609735606;6107;6131.743695906989;6510.934890651128;6517.348265173492;6521.250056243545;6529.5429319947625;6538.150040494753;6536.411722944958;6567.507436942201;6576.04647326135;6597.109390232353;6613.86772264552;6032.879342413171;6106.847328816815;6117.327094019654;6137.4169453902705;6163.3528479509905;6480.740770369227;6556.770513032021;6563.606183628997;6571.704273307712;6616;6374.139491168726;6383.96808015957;6393.073004414334;6396.968015159988;6397.680115994275;6499.545031847725;6515.055316979012;6515.6742162892615;6527.510436717265;6538.986457099158;6168.19813424261;6224.37756224374;6418.8716225675225;6436.16329877113;6447.258565265054;6380.7128679209545;6445.838854028687;6481.513886458534;6524.314946930599;6530.249021362509;5163.302954101224;5208.192730126836;5213.921791173136;5220.295260139908;5241.790328386898;4536.954630453653;4652.767361631973;4657.930131048037;4663.556962088596;4702.130105930414;6104.664243466563;6107.358727333655;6120.418560236771;6124.112003759519;6126.908096378558;6398.040293955851;6403.359664033559;6405.807825765234;6430.7106180222;6470.9029364559565;6105.938940610626;6131.223750760734;6151.446369826737;6163.291221509494;6163.476104531165;5778.162166485836;5788.479036886701;5794.681292528951;5805.071188609802;5815.418458154235;6492.220933488012;6554.868902622016;6641.070250165078;6785.9660701696175;6802.387785099365;6436.581622194542;6481.513886458629;6481.740730370732;6483.4164925156965;6496.220453545605;6612.437942774725;6690.966545167243;6692.564983276072;6695.0626912231355;6728;5427.213054107211;6091.842549915502;6377.96811015942;6383.234011918599;6386.074019267273;5429.886873190907;5933.199018132669;6355.30091689923;6396;6485.027245913151;6352.523560732871;6358.523110766619;6369.80890573265;6371.39471750183;6386.16979792624;6269.811905642838;6283.5287353449585;6347.333529979285;6354.110424540476;6362.554621176473;6138.0179171332375;6155.569110162425;6167.753289868535;6194.5354098443695;6251;6294.874102517832;6325.05124231369;6325.462335701517;6346.111544383883;6348.77779277723;6177.876442471035;6212.254529456313;6237.968810156101;6255;6265.718042687999 09:59:16 INFO - PROCESS | 1983 | |1;ext.html;759.8404335089631;779.1974266505499;809.0574480729948;877.7191298784392;889.8531742262527;27658.446831063367;38983.61016389839;39464.210715785666;39536.406953895676;39575.802120989356;39769.80115099421;40001.79999100001;40074.19851602966;40100.59899401005;40176.794696159086;7451.850962980737;9248.999999999984;9408.81182376352;9416.340856140074;9428.952855235748;7427.888581671279;11280.548778048867;11445.141614378956;11463.31220126795;11479.368634725086;9547.379420337691;11307.491162897648;11329.773404531905;11330.490127944222;11331.603393881216;11251.43742812856;11299.774004519946;11299.943500282447;11303.943480282545;11322.26405283654;7295.562266263988;7477.551346919202;7521.135069467026;7531.585762783045;7539.2460753924715;37623;38256.80871595652;38368.80815595932;38419.61580384188;39737.40393894065;3820.6561409473;3857.3228864171815;3864.574896761354;3869.090763670535;3969.960300397017;25529.74470255292;27317.45365092707;28803.85598072017;29236.269093272625;29382.11853644394;3059.5869557609662;3142.1673256587023;3154.2114471382156;3164.2089477630593;3196.6483686794436;350063;354108;354240;354619;354728;51049.48950510447;51164.48835511597;51275;51284;51492.48507514952;53085.46914530882;53115.734421327645;53136.07751573623;53175;53230.20154697605;14415.990880638465;14689.632759181106;14690.55928322152;14697.04469209498;14710.852891470948;10895.618653347254;12735.808962865565;12758.979281657445;12774.872251277555;12786.360681965865;10273.640422585324;10351.327163734484;11517.48171332292;11657.533698652129;11737.178397512092;4842.4189097308545;5687.658740475585;5758.798442054508;5761.798337058183;5772.624779389326;883.4831623500324;900.0864122915247;920.2224120618067;946.5693109635099;974.5078735238659;26871.865640671673;27981.160565183076;28659;28725.71274287272;28733.56899646507;1040.2562168049728;1040.5369610523396;1041.286718597763;1078.412265315405;1084.7613525024483;14422.42310307597;14556.563303100924;14628.780568291484;14630.634234144232;14690.779638305434;460185;460334;460428;461152;461710;55536.722316388965;55676;55699;55749.60625984383;55764.72117639386;1197.1500234833018;1433.4624515806572;1463.590194745473;1469.1478942213705;1469.4709904434394;26098.739012609632;27127.59308610333;27150;27403.725962740118;27405.177844664693;44012.779936100116;44023;44033.77983110064;44107.779461103775;44156.779216103714;437929;438031;438129;439007;440041;33208.833955830065;33846.492302614985;33899.4915076279;33929;33972.83013584916;29271.7072829269;29745.25636859096;29985.700142998292;42824.57175428331;43833.34249986317;28340.85829570839;32281.35437291288;32545.837270813496;35774.46338304875;37578.43632345572;28674.856625716737;33620.83189584036;35897.64102358943;36171.63828361683;37242.696505622174;35837;36776.26447471089;36807.81596092002;36926.44610330901;37041;29973.400531988802;32495.512567311984;32556;32599;33062.83468582642;19273.132709027846;23044.654330184727;23259.53480930338;24326.297159199396;24945 09:59:16 INFO - PROCESS | 1983 | |2;jquery.html;381.15954320722807;408.18358305540335;417.5615603616202;427.69419864796663;433.03001277139197;19870.60258794825;20571;21420.25029123981;22281;22669.54660906781;20065.598688026268;21572.029258683357;21934.45163870904;22076;22094.226702065433;5702.914456283159;6559.475241980654;6567.802965911031;6569.244536878273;6584.572002819826;4205.1169254456445;4728.550762821835;6705;6741.629210393427;6754.223264324592;4431.468223813131;4466.776661166945;6866.34769696878;7335.559866408006;7632.580208088553;7405.444591655593;7571;7578.8484230315635;7670.194629563871;7752.26353496417;7278.526895751759;7354.117505899327;7438.442116841258;7443.441741869381;7444.548313078952;20460.79539204604;26157.869210654015;26453;26483.470330593475;26801.597976030374;2640.036386718853;2756.5865120231924;2893.6816950135467;3251.2522119912314;3395.558577384949;14282.785758213635;15811.288492017888;15894.205289735466;15986.920065399714;16854.831451685448;1732.7747392838976;1957.8237958583654;2010.8089731475486;2029.9797002029939;2057.2593866208153;151335;153006.46993530146;159463.20268398584;160485;162642.3735762639;19989.80061196333;20120.798792012185;20259.696104558443;20385.49036274105;20427.795722042887;31725;31920.680793191772;32202.19494512656;32204.19489512734;32336.353272934408;10134.138598219086;10211.489425528694;10385.740356490996;10408.115310198718;10527.526261318259;8666.480011199348;8678.002029766658;8690.826183476422;8849.955750221336;8862.42394244372;7492.887606685904;7594.696212151563;9178.403403778733;9308.348415610977;9445.574949127305;2997.3555685527717;3686.9631303687156;3747.868824591126;3952.347862602696;4030.2141082488633;850.3834719828075;857.4812238595559;896.3904544909394;913.0732306708696;928.9489078100634;17020.744688829676;20731.170753170005;21392.037358318914;21441.89279053595;21949.792761398276;888.5113187746714;897.8742975983367;898.1108702384593;900.8558630619069;926.4672813132476;9664.565094570762;10918.890811091946;11485.540578376771;11504.309741415542;11507.654770356903;747321;759375;767588;774662;807603;126753;135642.93071207684;145301.28192308496;151704;154738;1258.9118761686593;1265.7405231927617;1291.6447976806453;1298.571471414431;1299.1944994103528;18010.379065883608;19019;19061.046947652285;19080.618387632447;19095.809041909957;58729.4127058724;61709;62156.37843621506;62956.68521657363;65340.346596533425;79526;80937.19062809297;82626;82752.3449531018;84784.72822907538;11348.375839328915;11564.768704626029;11576.479058442223;11843.940780296043;11945.522179112739;12601.18092323996;12612.621621351374;12774.936125319315;12903.41934612926;12906.096573239784;10223.846642300223;10771.784564308826;10937.617183398543;11122.110231181648;11138.10895128404;10089.949550252202;10856.620018299638;10946.616868409568;11001.449927503432;11034.503447345049;8452.957735211285;10919.727006824893;11024.834627480755;11123.944380278046;11216.158788090763;10214.642487512901;11453.255538389978;11593.826092608786;11758.82361764557;11884.46519906589;10340.914204008472;10385.013423724735;10505.68482945513;10790.73023174427;10791.514381852678 09:59:16 INFO - PROCESS | 1983 | |3;mootools.html;1466.1935935235617;1525.366972706327;1535.7542793153098;1570.442492915016;1581.7627355896618;10752;11366.204365694395;11380.715482112952;11383.487743051563;11390.202685811986;10680.519376628052;10988.505517251722;11035.117190624751;11112.944435277832;11144.832827507595;2349.8942547585357;2386.343755467252;2386.7374588795305;2388.940276493084;2390.2948630154146;2331.40549159964;2364.6334818103223;2369.1944738788807;2372.217168334454;2373.4066483379156;2302.6200676888293;2320.9883950580224;2322.5587138443725;2330.7785760352826;2332.3352844439337;2138.262299506683;2164.7835216478384;2166.5991791518463;2171.1423987524995;2174.13034786086;2282.167009041704;2339.181286549711;2339.3800642829665;2339.63735620979;2350.4123969007746;11391;11447.969682728595;11471;11484.310941343547;11490.138239631977;4833.782479788383;5410;5467.617266791326;5547.223388725542;5726.828195154152;3254.5769050023346;3422.025381974788;3483.494893240466;3487.8779242726637;3512.4380099184264;1106.4523061084733;1134.2211432750125;1178.6405146430336;1208.746163305707;1212.854457465101;15301.770473442908;15372.154531500762;15424.845751542452;15451.227438628024;15459.768103478456;4240.448741663626;4483.574060464251;4553.021100463417;4569.817207311737;4574.611158051536;11478.713032174095;11491.655250342503;11493.827592586118;11495.712607184887;11499.482523286471;5533.806316778974;5540.9168862467095;5541.750621222055;5553.722313884289;5573.554115670818;4973.801047958041;5024.221245706921;5071.137906555894;5118.897622047538;5152.948470515322;3294.7364210863075;3566.054995426214;3748.5689145748042;3773.3208022556205;3812.8856134316015;955.5652178258875;957.4590356448584;966.5264020629982;968.9660861869801;975.1516180922501;800.9631457454481;841.5203334099627;901.5807649443041;912.3112050401904;925.4724806860025;5661.830145095653;6527.445167160845;6590.209174898947;6619.635920024349;6639.170103737033;839.5508403004363;888.0985799413601;975.9365641233297;1017.1710056304089;1024.538957469142;4164.75011499311;4202.201581699528;4210.59999300066;4314.654827613784;4433.135538570013;13934.651633709238;14300.785488217685;14383.28083595816;14386.424543018371;14425.278736063365;10822.404767737693;11822.88177118235;14344.282785860665;14346.49787257441;14355.497557585435;8838.558072096497;10289.845652315222;10444.373337599769;10470.319429236923;10479.47602619866;6635.402813746786;6656.134702488645;6721;6778;6823.112995310578;12255.938720306342;12286.81569776472;12512.874871251171;12677.936610316889;12687.429065691882;12224.694382640506;12677.746445071232;12915.935420322838;13016.15394999322;13077.41151648159;8442.53566053873;8458.873116903129;8633.827323453621;8648.394612377073;8651.264642505457;10202.948985255027;10217.642382516577;10311.123554497952;10320;10351.482425878827;8979.191872731486;9143.63425462974;9230.630774768933;9252.907470925205;9272.768180795534;8633.35249856276;8952.820943581222;9007.594658240527;9054.683086091954;9064.002959674299;7643.656035478306;7710.344620707303;7787.143414224544;7793.025871766029;7803.102643196105;5669.206311116364;5697.715114244188;5833.270841144857;5841;5856.853578660568;5823.854403639943;5834.562407819515;5951.910721339097;6000.489958353589;6170.81487555374 09:59:16 INFO - PROCESS | 1983 | |4;prototype.html;373.11013233438246;376.0729801040435;377.9508663873696;384.13761106316315;387.71309231168925;4415.028693687392;4637.820224494486;4817.445993710724;5201.5838732901375;5221.895562088756;4472.575105364993;5015;5076.771545280462;5090.32019433587;5248.422673505911;4137.034908418492;4203.831846726127;4230.280852255117;4267.466566679165;4277.443932288814;4010.659093977001;4251.298535741615;4260.552641972595;4293.914121717564;4334.371516130159;3735.2902948439846;4275.845521709137;4297.742135471882;4307.889134324174;4319.524852266248;3509.2455122148863;4168.541460439349;4172.040430700926;4281.850135245251;4333.783310834461;3506.36885360635;3777.9055523611855;3891.8832435026993;3949.7037722170953;3954.5056867891512;4409.96365854024;4685.4143232095985;4736.218523943545;4939.950600493985;4947.431045429786;4633.586756039406;4902.779374928136;4957.413627639157;4975.62682798788;4982.87542811429;4949.133901567247;5101.4133374662015;5325.535477743612;5440.836774896759;5504.339479262514;3673.669369756708;4446.977765111186;4470.642348612103;4481.887952801206;4536.682432229745;4809.663323567387;5467.781288748445;5643.463870932255;5851.531877449836;5916.526677865761;3820.808959552067;3822.222222222222;3966.960330396659;4307.987622908614;4431.490378606437;4540.931886021713;4563.589276965089;4588.334691469719;4592.265237561974;4605.792739326738;3945.3292940200236;4422.823087076481;4789.137955168034;4825.758712064383;4871.3667223260745;4380.737155770664;5268.710220937885;5337.2794672719465;5382.703951282639;5458.9454105458435;1280.3406245783428;1457.8323492798463;1536.9923150384177;1558.3688606114542;1583.279607778458;978.554757585297;1015.441507171053;1173.3487914207697;1176.8584473061117;1190.1609365397546;4408.25059739845;4623.352730617717;4865.927011094836;5005.998800239967;5095.579599690118;4896.485868983706;5410.648307859977;5632.831015069554;5638.2670252866865;5647.661140331593;4433.889152771142;4460.687751857339;5041.092603331435;5116.334876466036;5125.974370128126;2238.0488292475634;2440.9389765255655;2552.693676758801;2809.438112377533;2885.7114288571397;5231.738413079331;5451.955516681244;5790.88418231633;5866.221771555015;5911.556633252523;4816.254734801129;5397.514223719805;5470.134980599322;5533;5708.743106560215;5536.446355364431;5634.070378387521;5642.0252911481475;5752.913706294409;5786.3056433228285;5367.409584945731;5571.994082130349;5690.573207009408;5715.399883012224;5736.942630573641;4677.555632214934;4805.299919062372;5289.6297259193025;5379.327584051994;5541.944580554304;4672.9532704673875;5498.092814685532;5803.970980145073;5852.326982397079;5933.436323549256;4058.289799285172;4167.70801051675;4388;4423.225935461346;4476;5265.52610265078;5353.8506919692545;5369.919451208313;5587.273654424899;5626;4941.901161976813;5189.974050129726;5258.0009798138235;5460.6996615186545;5539.806106786243;4558.82573279337;4721.598664113589;4785.401824771903;5289;5291.618771552739;3795.867144649924;4157.590775564008;4513.864584062483;4985.426675932169;5376.596755243294;4683.461401938821;4710.458297295718;4958.404991401055;5098.031374038921;5123.462036486116;4878.268259761065;4925.236588328815;5129.512696293846;5336.7598458068705;5415.675059496442 09:59:16 INFO - PROCESS | 1983 | |5;yui.html;725.836686745482;750.1111183247851;756.2210922749563;818.8894499242602;828.7720876758891;14827.851721482783;15101.320440580173;15844.920775396107;15877.603059923507;15895.205239738025;14279.357428915699;14372.137671739676;14454.205018723993;14523.636909077279;14588.635284117876;918.2883265469281;931.2038207332735;932.0074121061082;936.5598168860624;944.8677185194044;897.1745993685824;922.1009515722151;928.3779867488798;930.5998420679106;941.6327632223438;969.7866469376726;971.7862070344513;972.2173650211577;972.397113789448;973.9561719722594;964.9372790768648;965.1844191658038;967.066780556766;967.2552134856156;969;720.5028530314119;721.5490318550906;722.9746958856415;723.1611330856182;723.3995783499682;15499.992500487546;15621.609459763484;15641.843581564153;15839.287232074585;15959;13967.860321396758;14100.08349457282;14309.78535321971;14394.712105757826;14395.496157634432;11693.473793679219;11787.882121178764;11886.881131188664;12012.87987120135;12330.691732706664;3688.6495782900583;3691.3909204981146;3742.7941463219513;3795.8671446499516;3888.844446222148;94965.52517237439;118788.40605797002;119007.99999999913;119450;119521.40239298748;10841.83737243942;10893.673189804318;10933.507992140372;10951.397673128055;11294.209405341711;22412.88793556022;22814.771852281596;23054.538909221723;23095.538089238456;23168;7706.845863082707;7716.922830771733;7724.343430808444;7788.185337829399;7926.801829954182;4327.17783621111;4360.324149756792;4384.342348647665;4466.709663871903;4529.162105010583;3350.447176215897;3396.5075064115563;3434.7252219822353;3445.758796884194;3471.6701913318193;606.3663471672113;609.3662590905409;612.7518355066117;622.6108682073703;624.0327492386782;567.2965522751758;665.082186582513;674.9898751518731;683.5147045597582;693.2789898505498;9815.803683926282;10238.53926573306;10328.741781455523;10775.407352595526;10797.46012699362;644.432899048834;679.867425851964;703.9014537964689;705.9974835733168;745.4260219630962;4980.128477516492;5062.848114556569;5063.8480845574695;5085.440601533828;5096.184610462308;69026;86816.53544477567;98506;98587.50706246567;100355;80733.19266807257;90599;95491.56762648566;96047;98114;70376;82425.58787206025;82691.5865420669;85032.14967850366;86668.56665716632;9171.31215158879;9649.276304277348;9758;9783.902160978583;9797.951010244904;51284.487155129464;53159.08694894674;53451.73274133605;54489.72755136199;55417.44582554284;65557;66721;67478.66260668666;67733.66133169303;68215;10467;11093.445327733742;11188.328700278009;11193.66419007431;11587.536498539965;11900.28598284071;12671.683207919876;13260.403281852532;14470.782938256145;14962.775558366415;13819.654508637364;14312.640179828046;14323.355449005028;14344.56966291013;14482.927585362006;13157.342132893125;13584.592462226148;14061.367238474499;14233.572992810232;14773.039752416058;13171.47314107425;13451.932740336235;13742.03805733589;13750.86249137536;14061.086029408056;11133.165012624248;11159.665210043711;11315.603953861575;11353.48909299067;11743.823842642538;7996.440249182501;9619.374740641835;11258;11534.653960381202;11536.423178841193 09:59:16 INFO - PROCESS | 1983 | __end_tp_report 09:59:16 INFO - PROCESS | 1983 | __start_cc_report 09:59:16 INFO - PROCESS | 1983 | _x_x_mozilla_cycle_collect,1391 09:59:16 INFO - PROCESS | 1983 | __end_cc_report 09:59:16 INFO - PROCESS | 1983 | __startTimestamp1490288356659__endTimestamp 09:59:16 INFO - PROCESS | 1983 | 09:59:16 INFO - PROCESS | 1983 | ------- Summary: start ------- 09:59:16 INFO - PROCESS | 1983 | Number of tests: 6 09:59:16 INFO - PROCESS | 1983 | 09:59:16 INFO - PROCESS | 1983 | [#0] dojo.html Cycles:165 Average:6017.84 Median:6168.20 stddev:657.61 (10.7%) stddev-sans-first:627.25 09:59:16 INFO - PROCESS | 1983 | Values: 3419.7 3426.5 3428.3 3428.6 3489.4 6041.3 6111.7 6122.5 6127.9 6134.4 6077.1 6086.1 6125.9 6126.5 6146.8 5428.0 5462.4 5498.3 5506.1 5588.6 5373.4 5382.3 5587.6 5592.3 5602.9 5444.2 5469.4 5505.2 5554.5 5566.2 5532.0 5565.2 5572.3 5575.1 5575.9 5308.7 5433.5 5483.5 5494.9 5511.1 6037.3 6078.5 6084.8 6107.0 6131.7 6510.9 6517.3 6521.3 6529.5 6538.2 6536.4 6567.5 6576.0 6597.1 6613.9 6032.9 6106.8 6117.3 6137.4 6163.4 6480.7 6556.8 6563.6 6571.7 6616.0 6374.1 6384.0 6393.1 6397.0 6397.7 6499.5 6515.1 6515.7 6527.5 6539.0 6168.2 6224.4 6418.9 6436.2 6447.3 6380.7 6445.8 6481.5 6524.3 6530.2 5163.3 5208.2 5213.9 5220.3 5241.8 4537.0 4652.8 4657.9 4663.6 4702.1 6104.7 6107.4 6120.4 6124.1 6126.9 6398.0 6403.4 6405.8 6430.7 6470.9 6105.9 6131.2 6151.4 6163.3 6163.5 5778.2 5788.5 5794.7 5805.1 5815.4 6492.2 6554.9 6641.1 6786.0 6802.4 6436.6 6481.5 6481.7 6483.4 6496.2 6612.4 6691.0 6692.6 6695.1 6728.0 5427.2 6091.8 6378.0 6383.2 6386.1 5429.9 5933.2 6355.3 6396.0 6485.0 6352.5 6358.5 6369.8 6371.4 6386.2 6269.8 6283.5 6347.3 6354.1 6362.6 6138.0 6155.6 6167.8 6194.5 6251.0 6294.9 6325.1 6325.5 6346.1 6348.8 6177.9 6212.3 6238.0 6255.0 6265.7 09:59:16 INFO - PROCESS | 1983 | 09:59:16 INFO - PROCESS | 1983 | [#1] ext.html Cycles:180 Average:55641.99 Median:354673.50 stddev:111419.61 (31.4%) stddev-sans-first:111655.97 09:59:16 INFO - PROCESS | 1983 | Values: 759.8 779.2 809.1 877.7 889.9 27658.4 38983.6 39464.2 39536.4 39575.8 39769.8 40001.8 40074.2 40100.6 40176.8 7451.9 9249.0 9408.8 9416.3 9429.0 7427.9 11280.5 11445.1 11463.3 11479.4 9547.4 11307.5 11329.8 11330.5 11331.6 11251.4 11299.8 11299.9 11303.9 11322.3 7295.6 7477.6 7521.1 7531.6 7539.2 37623.0 38256.8 38368.8 38419.6 39737.4 3820.7 3857.3 3864.6 3869.1 3970.0 25529.7 27317.5 28803.9 29236.3 29382.1 3059.6 3142.2 3154.2 3164.2 3196.6 350063.0 354108.0 354240.0 354619.0 354728.0 51049.5 51164.5 51275.0 51284.0 51492.5 53085.5 53115.7 53136.1 53175.0 53230.2 14416.0 14689.6 14690.6 14697.0 14710.9 10895.6 12735.8 12759.0 12774.9 12786.4 10273.6 10351.3 11517.5 11657.5 11737.2 4842.4 5687.7 5758.8 5761.8 5772.6 883.5 900.1 920.2 946.6 974.5 26871.9 27981.2 28659.0 28725.7 28733.6 1040.3 1040.5 1041.3 1078.4 1084.8 14422.4 14556.6 14628.8 14630.6 14690.8 460185.0 460334.0 460428.0 461152.0 461710.0 55536.7 55676.0 55699.0 55749.6 55764.7 1197.2 1433.5 1463.6 1469.1 1469.5 26098.7 27127.6 27150.0 27403.7 27405.2 44012.8 44023.0 44033.8 44107.8 44156.8 437929.0 438031.0 438129.0 439007.0 440041.0 33208.8 33846.5 33899.5 33929.0 33972.8 29271.7 29745.3 29985.7 42824.6 43833.3 28340.9 32281.4 32545.8 35774.5 37578.4 28674.9 33620.8 35897.6 36171.6 37242.7 35837.0 36776.3 36807.8 36926.4 37041.0 29973.4 32495.5 32556.0 32599.0 33062.8 19273.1 23044.7 23259.5 24326.3 24945.0 09:59:16 INFO - PROCESS | 1983 | 09:59:16 INFO - PROCESS | 1983 | [#2] jquery.html Cycles:180 Average:43171.08 Median:22085.11 stddev:128344.71 (581.1%) stddev-sans-first:128664.53 09:59:16 INFO - PROCESS | 1983 | Values: 381.2 408.2 417.6 427.7 433.0 19870.6 20571.0 21420.3 22281.0 22669.5 20065.6 21572.0 21934.5 22076.0 22094.2 5702.9 6559.5 6567.8 6569.2 6584.6 4205.1 4728.6 6705.0 6741.6 6754.2 4431.5 4466.8 6866.3 7335.6 7632.6 7405.4 7571.0 7578.8 7670.2 7752.3 7278.5 7354.1 7438.4 7443.4 7444.5 20460.8 26157.9 26453.0 26483.5 26801.6 2640.0 2756.6 2893.7 3251.3 3395.6 14282.8 15811.3 15894.2 15986.9 16854.8 1732.8 1957.8 2010.8 2030.0 2057.3 151335.0 153006.5 159463.2 160485.0 162642.4 19989.8 20120.8 20259.7 20385.5 20427.8 31725.0 31920.7 32202.2 32204.2 32336.4 10134.1 10211.5 10385.7 10408.1 10527.5 8666.5 8678.0 8690.8 8850.0 8862.4 7492.9 7594.7 9178.4 9308.3 9445.6 2997.4 3687.0 3747.9 3952.3 4030.2 850.4 857.5 896.4 913.1 928.9 17020.7 20731.2 21392.0 21441.9 21949.8 888.5 897.9 898.1 900.9 926.5 9664.6 10918.9 11485.5 11504.3 11507.7 747321.0 759375.0 767588.0 774662.0 807603.0 126753.0 135642.9 145301.3 151704.0 154738.0 1258.9 1265.7 1291.6 1298.6 1299.2 18010.4 19019.0 19061.0 19080.6 19095.8 58729.4 61709.0 62156.4 62956.7 65340.3 79526.0 80937.2 82626.0 82752.3 84784.7 11348.4 11564.8 11576.5 11843.9 11945.5 12601.2 12612.6 12774.9 12903.4 12906.1 10223.8 10771.8 10937.6 11122.1 11138.1 10089.9 10856.6 10946.6 11001.4 11034.5 8453.0 10919.7 11024.8 11123.9 11216.2 10214.6 11453.3 11593.8 11758.8 11884.5 10340.9 10385.0 10505.7 10790.7 10791.5 09:59:16 INFO - PROCESS | 1983 | 09:59:16 INFO - PROCESS | 1983 | [#3] mootools.html Cycles:180 Average:6718.31 Median:2822.44 stddev:4309.82 (152.7%) stddev-sans-first:4303.85 09:59:16 INFO - PROCESS | 1983 | Values: 1466.2 1525.4 1535.8 1570.4 1581.8 10752.0 11366.2 11380.7 11383.5 11390.2 10680.5 10988.5 11035.1 11112.9 11144.8 2349.9 2386.3 2386.7 2388.9 2390.3 2331.4 2364.6 2369.2 2372.2 2373.4 2302.6 2321.0 2322.6 2330.8 2332.3 2138.3 2164.8 2166.6 2171.1 2174.1 2282.2 2339.2 2339.4 2339.6 2350.4 11391.0 11448.0 11471.0 11484.3 11490.1 4833.8 5410.0 5467.6 5547.2 5726.8 3254.6 3422.0 3483.5 3487.9 3512.4 1106.5 1134.2 1178.6 1208.7 1212.9 15301.8 15372.2 15424.8 15451.2 15459.8 4240.4 4483.6 4553.0 4569.8 4574.6 11478.7 11491.7 11493.8 11495.7 11499.5 5533.8 5540.9 5541.8 5553.7 5573.6 4973.8 5024.2 5071.1 5118.9 5152.9 3294.7 3566.1 3748.6 3773.3 3812.9 955.6 957.5 966.5 969.0 975.2 801.0 841.5 901.6 912.3 925.5 5661.8 6527.4 6590.2 6619.6 6639.2 839.6 888.1 975.9 1017.2 1024.5 4164.8 4202.2 4210.6 4314.7 4433.1 13934.7 14300.8 14383.3 14386.4 14425.3 10822.4 11822.9 14344.3 14346.5 14355.5 8838.6 10289.8 10444.4 10470.3 10479.5 6635.4 6656.1 6721.0 6778.0 6823.1 12255.9 12286.8 12512.9 12677.9 12687.4 12224.7 12677.7 12915.9 13016.2 13077.4 8442.5 8458.9 8633.8 8648.4 8651.3 10202.9 10217.6 10311.1 10320.0 10351.5 8979.2 9143.6 9230.6 9252.9 9272.8 8633.4 8952.8 9007.6 9054.7 9064.0 7643.7 7710.3 7787.1 7793.0 7803.1 5669.2 5697.7 5833.3 5841.0 5856.9 5823.9 5834.6 5951.9 6000.5 6170.8 09:59:16 INFO - PROCESS | 1983 | 09:59:16 INFO - PROCESS | 1983 | [#4] prototype.html Cycles:180 Average:4493.05 Median:4812.96 stddev:1263.53 (26.3%) stddev-sans-first:1228.65 09:59:16 INFO - PROCESS | 1983 | Values: 373.1 376.1 378.0 384.1 387.7 4415.0 4637.8 4817.4 5201.6 5221.9 4472.6 5015.0 5076.8 5090.3 5248.4 4137.0 4203.8 4230.3 4267.5 4277.4 4010.7 4251.3 4260.6 4293.9 4334.4 3735.3 4275.8 4297.7 4307.9 4319.5 3509.2 4168.5 4172.0 4281.9 4333.8 3506.4 3777.9 3891.9 3949.7 3954.5 4410.0 4685.4 4736.2 4940.0 4947.4 4633.6 4902.8 4957.4 4975.6 4982.9 4949.1 5101.4 5325.5 5440.8 5504.3 3673.7 4447.0 4470.6 4481.9 4536.7 4809.7 5467.8 5643.5 5851.5 5916.5 3820.8 3822.2 3967.0 4308.0 4431.5 4540.9 4563.6 4588.3 4592.3 4605.8 3945.3 4422.8 4789.1 4825.8 4871.4 4380.7 5268.7 5337.3 5382.7 5458.9 1280.3 1457.8 1537.0 1558.4 1583.3 978.6 1015.4 1173.3 1176.9 1190.2 4408.3 4623.4 4865.9 5006.0 5095.6 4896.5 5410.6 5632.8 5638.3 5647.7 4433.9 4460.7 5041.1 5116.3 5126.0 2238.0 2440.9 2552.7 2809.4 2885.7 5231.7 5452.0 5790.9 5866.2 5911.6 4816.3 5397.5 5470.1 5533.0 5708.7 5536.4 5634.1 5642.0 5752.9 5786.3 5367.4 5572.0 5690.6 5715.4 5736.9 4677.6 4805.3 5289.6 5379.3 5541.9 4673.0 5498.1 5804.0 5852.3 5933.4 4058.3 4167.7 4388.0 4423.2 4476.0 5265.5 5353.9 5369.9 5587.3 5626.0 4941.9 5190.0 5258.0 5460.7 5539.8 4558.8 4721.6 4785.4 5289.0 5291.6 3795.9 4157.6 4513.9 4985.4 5376.6 4683.5 4710.5 4958.4 5098.0 5123.5 4878.3 4925.2 5129.5 5336.8 5415.7 09:59:16 INFO - PROCESS | 1983 | 09:59:16 INFO - PROCESS | 1983 | [#5] yui.html Cycles:180 Average:20692.46 Median:4497.94 stddev:29828.24 (663.2%) stddev-sans-first:29874.24 09:59:16 INFO - PROCESS | 1983 | Values: 725.8 750.1 756.2 818.9 828.8 14827.9 15101.3 15844.9 15877.6 15895.2 14279.4 14372.1 14454.2 14523.6 14588.6 918.3 931.2 932.0 936.6 944.9 897.2 922.1 928.4 930.6 941.6 969.8 971.8 972.2 972.4 974.0 964.9 965.2 967.1 967.3 969.0 720.5 721.5 723.0 723.2 723.4 15500.0 15621.6 15641.8 15839.3 15959.0 13967.9 14100.1 14309.8 14394.7 14395.5 11693.5 11787.9 11886.9 12012.9 12330.7 3688.6 3691.4 3742.8 3795.9 3888.8 94965.5 118788.4 119008.0 119450.0 119521.4 10841.8 10893.7 10933.5 10951.4 11294.2 22412.9 22814.8 23054.5 23095.5 23168.0 7706.8 7716.9 7724.3 7788.2 7926.8 4327.2 4360.3 4384.3 4466.7 4529.2 3350.4 3396.5 3434.7 3445.8 3471.7 606.4 609.4 612.8 622.6 624.0 567.3 665.1 675.0 683.5 693.3 9815.8 10238.5 10328.7 10775.4 10797.5 644.4 679.9 703.9 706.0 745.4 4980.1 5062.8 5063.8 5085.4 5096.2 69026.0 86816.5 98506.0 98587.5 100355.0 80733.2 90599.0 95491.6 96047.0 98114.0 70376.0 82425.6 82691.6 85032.1 86668.6 9171.3 9649.3 9758.0 9783.9 9798.0 51284.5 53159.1 53451.7 54489.7 55417.4 65557.0 66721.0 67478.7 67733.7 68215.0 10467.0 11093.4 11188.3 11193.7 11587.5 11900.3 12671.7 13260.4 14470.8 14962.8 13819.7 14312.6 14323.4 14344.6 14482.9 13157.3 13584.6 14061.4 14233.6 14773.0 13171.5 13451.9 13742.0 13750.9 14061.1 11133.2 11159.7 11315.6 11353.5 11743.8 7996.4 9619.4 11258.0 11534.7 11536.4 09:59:16 INFO - PROCESS | 1983 | -------- Summary: end -------- 09:59:16 INFO - PROCESS | 1983 | 09:59:17 INFO - TEST-INFO | 1983: exit 0 09:59:17 INFO - TEST-OK | dromaeo_css | took 1119791ms 09:59:17 INFO - TEST-START | kraken 09:59:17 INFO - operating with platform_type : mac_ 09:59:17 INFO - Initialising browser for kraken test... 09:59:17 INFO - TEST-INFO | started process 1987 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/tmpovFDg7/profile http://localhost:53009/getInfo.html) 09:59:19 INFO - PROCESS | 1987 | __metrics Screen width/height:1600/1200 09:59:19 INFO - PROCESS | 1987 | colorDepth:24 09:59:19 INFO - PROCESS | 1987 | Browser inner width/height: 1024/689 09:59:19 INFO - PROCESS | 1987 | __metrics 09:59:19 INFO - PROCESS | 1987 | 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" 09:59:19 INFO - PROCESS | 1987 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:59:20 INFO - TEST-INFO | 1987: exit 0 09:59:20 INFO - Browser initialized. 09:59:20 INFO - Running cycle 1/1 for kraken test... 09:59:20 INFO - TEST-INFO | started process 1988 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/tmpovFDg7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:59:32 INFO - PROCESS | 1988 | RSS: Main: 215097344 09:59:32 INFO - PROCESS | 1988 | 09:59:35 INFO - PROCESS | 1988 | Cycle 1(1): loaded http://localhost:53009/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53009/tests/kraken/driver.html?testName=audio-beat-detection) 09:59:36 INFO - PROCESS | 1988 | RSS: Main: 267735040 09:59:36 INFO - PROCESS | 1988 | 09:59:39 INFO - PROCESS | 1988 | Cycle 1(1): loaded http://localhost:53009/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53009/tests/kraken/driver.html?testName=audio-dft) 09:59:39 INFO - PROCESS | 1988 | RSS: Main: 279236608 09:59:39 INFO - PROCESS | 1988 | 09:59:42 INFO - PROCESS | 1988 | Cycle 1(1): loaded http://localhost:53009/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53009/tests/kraken/driver.html?testName=audio-fft) 09:59:43 INFO - PROCESS | 1988 | RSS: Main: 377274368 09:59:43 INFO - PROCESS | 1988 | 09:59:45 INFO - PROCESS | 1988 | Cycle 1(1): loaded http://localhost:53009/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53009/tests/kraken/driver.html?testName=audio-oscillator) 09:59:46 INFO - PROCESS | 1988 | RSS: Main: 279330816 09:59:46 INFO - PROCESS | 1988 | 09:59:48 INFO - PROCESS | 1988 | Cycle 1(1): loaded http://localhost:53009/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53009/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:59:48 INFO - PROCESS | 1988 | RSS: Main: 280363008 09:59:48 INFO - PROCESS | 1988 | 09:59:51 INFO - PROCESS | 1988 | Cycle 1(1): loaded http://localhost:53009/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53009/tests/kraken/driver.html?testName=imaging-darkroom) 09:59:52 INFO - PROCESS | 1988 | RSS: Main: 319934464 09:59:52 INFO - PROCESS | 1988 | 09:59:55 INFO - PROCESS | 1988 | Cycle 1(1): loaded http://localhost:53009/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53009/tests/kraken/driver.html?testName=imaging-desaturate) 09:59:56 INFO - PROCESS | 1988 | RSS: Main: 320704512 09:59:56 INFO - PROCESS | 1988 | 09:59:58 INFO - PROCESS | 1988 | Cycle 1(1): loaded http://localhost:53009/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53009/tests/kraken/driver.html?testName=json-parse-financial) 09:59:59 INFO - PROCESS | 1988 | RSS: Main: 317374464 09:59:59 INFO - PROCESS | 1988 | 10:00:01 INFO - PROCESS | 1988 | Cycle 1(1): loaded http://localhost:53009/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53009/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:00:01 INFO - PROCESS | 1988 | RSS: Main: 295247872 10:00:01 INFO - PROCESS | 1988 | 10:00:03 INFO - PROCESS | 1988 | Cycle 1(1): loaded http://localhost:53009/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53009/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:00:04 INFO - PROCESS | 1988 | RSS: Main: 297488384 10:00:04 INFO - PROCESS | 1988 | 10:00:06 INFO - PROCESS | 1988 | Cycle 1(1): loaded http://localhost:53009/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53009/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:00:07 INFO - PROCESS | 1988 | RSS: Main: 303861760 10:00:07 INFO - PROCESS | 1988 | 10:00:09 INFO - PROCESS | 1988 | Cycle 1(1): loaded http://localhost:53009/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53009/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:00:10 INFO - PROCESS | 1988 | RSS: Main: 321343488 10:00:10 INFO - PROCESS | 1988 | 10:00:13 INFO - PROCESS | 1988 | Cycle 1(1): loaded http://localhost:53009/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53009/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:00:14 INFO - PROCESS | 1988 | RSS: Main: 314187776 10:00:14 INFO - PROCESS | 1988 | 10:00:16 INFO - PROCESS | 1988 | Cycle 1(1): loaded http://localhost:53009/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53009/tests/kraken/driver.html?testName=ai-astar) 10:00:16 INFO - PROCESS | 1988 | RSS: Main: 358821888 10:00:16 INFO - PROCESS | 1988 | 10:00:16 INFO - PROCESS | 1988 | __start_tp_report 10:00:16 INFO - PROCESS | 1988 | _x_x_mozilla_page_load 10:00:16 INFO - PROCESS | 1988 | _x_x_mozilla_page_load_details 10:00:16 INFO - PROCESS | 1988 | |i|pagename|runs| 10:00:16 INFO - PROCESS | 1988 | |0;ai-astar;115;115;115;116;115;116;116;114;113;115 10:00:16 INFO - PROCESS | 1988 | |1;audio-beat-detection;141;112;111;145;112;110;109;108;131;112 10:00:16 INFO - PROCESS | 1988 | |2;audio-dft;184;188;185;186;184;185;187;185;185;184 10:00:16 INFO - PROCESS | 1988 | |3;audio-fft;85;60;62;96;82;84;83;83;76;60 10:00:16 INFO - PROCESS | 1988 | |4;audio-oscillator;88;71;87;70;69;68;83;68;67;85 10:00:16 INFO - PROCESS | 1988 | |5;imaging-gaussian-blur;88;88;87;88;88;87;87;87;88;87 10:00:16 INFO - PROCESS | 1988 | |6;imaging-darkroom;94;95;94;94;94;94;95;94;93;93 10:00:16 INFO - PROCESS | 1988 | |7;imaging-desaturate;85;85;86;86;85;85;83;83;84;85 10:00:16 INFO - PROCESS | 1988 | |8;json-parse-financial;65;59;61;60;63;63;63;64;58;69 10:00:16 INFO - PROCESS | 1988 | |9;json-stringify-tinderbox;54;59;72;64;61;59;58;60;60;60 10:00:16 INFO - PROCESS | 1988 | |10;stanford-crypto-aes;83;83;87;86;85;84;83;87;84;90 10:00:16 INFO - PROCESS | 1988 | |11;stanford-crypto-ccm;136;138;139;137;125;133;146;148;168;157 10:00:16 INFO - PROCESS | 1988 | |12;stanford-crypto-pbkdf2;162;176;165;165;219;163;166;168;164;168 10:00:16 INFO - PROCESS | 1988 | |13;stanford-crypto-sha256-iterative;66;66;65;62;63;64;69;80;86;80 10:00:16 INFO - PROCESS | 1988 | __end_tp_report 10:00:16 INFO - PROCESS | 1988 | __start_cc_report 10:00:16 INFO - PROCESS | 1988 | _x_x_mozilla_cycle_collect,2224 10:00:16 INFO - PROCESS | 1988 | __end_cc_report 10:00:16 INFO - PROCESS | 1988 | __startTimestamp1490288416376__endTimestamp 10:00:16 INFO - PROCESS | 1988 | 10:00:16 INFO - PROCESS | 1988 | ------- Summary: start ------- 10:00:16 INFO - PROCESS | 1988 | Number of tests: 14 10:00:16 INFO - PROCESS | 1988 | 10:00:16 INFO - PROCESS | 1988 | [#0] ai-astar Cycles:10 Average:115.00 Median:115.00 stddev:0.94 (0.8%) stddev-sans-first:1.00 10:00:16 INFO - PROCESS | 1988 | Values: 115.0 115.0 115.0 116.0 115.0 116.0 116.0 114.0 113.0 115.0 10:00:16 INFO - PROCESS | 1988 | 10:00:16 INFO - PROCESS | 1988 | [#1] audio-beat-detection Cycles:10 Average:119.10 Median:112.00 stddev:14.21 (12.7%) stddev-sans-first:12.67 10:00:16 INFO - PROCESS | 1988 | Values: 141.0 112.0 111.0 145.0 112.0 110.0 109.0 108.0 131.0 112.0 10:00:16 INFO - PROCESS | 1988 | 10:00:16 INFO - PROCESS | 1988 | [#2] audio-dft Cycles:10 Average:185.30 Median:185.00 stddev:1.34 (0.7%) stddev-sans-first:1.33 10:00:16 INFO - PROCESS | 1988 | Values: 184.0 188.0 185.0 186.0 184.0 185.0 187.0 185.0 185.0 184.0 10:00:16 INFO - PROCESS | 1988 | 10:00:16 INFO - PROCESS | 1988 | [#3] audio-fft Cycles:10 Average:77.10 Median:83.00 stddev:12.36 (14.9%) stddev-sans-first:12.77 10:00:16 INFO - PROCESS | 1988 | Values: 85.0 60.0 62.0 96.0 82.0 84.0 83.0 83.0 76.0 60.0 10:00:16 INFO - PROCESS | 1988 | 10:00:16 INFO - PROCESS | 1988 | [#4] audio-oscillator Cycles:10 Average:75.60 Median:77.00 stddev:8.90 (11.6%) stddev-sans-first:8.23 10:00:16 INFO - PROCESS | 1988 | Values: 88.0 71.0 87.0 70.0 69.0 68.0 83.0 68.0 67.0 85.0 10:00:16 INFO - PROCESS | 1988 | 10:00:16 INFO - PROCESS | 1988 | [#5] imaging-gaussian-blur Cycles:10 Average:87.50 Median:88.00 stddev:0.53 (0.6%) stddev-sans-first:0.53 10:00:16 INFO - PROCESS | 1988 | Values: 88.0 88.0 87.0 88.0 88.0 87.0 87.0 87.0 88.0 87.0 10:00:16 INFO - PROCESS | 1988 | 10:00:16 INFO - PROCESS | 1988 | [#6] imaging-darkroom Cycles:10 Average:94.00 Median:94.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 10:00:16 INFO - PROCESS | 1988 | Values: 94.0 95.0 94.0 94.0 94.0 94.0 95.0 94.0 93.0 93.0 10:00:16 INFO - PROCESS | 1988 | 10:00:16 INFO - PROCESS | 1988 | [#7] imaging-desaturate Cycles:10 Average:84.70 Median:85.00 stddev:1.06 (1.2%) stddev-sans-first:1.12 10:00:16 INFO - PROCESS | 1988 | Values: 85.0 85.0 86.0 86.0 85.0 85.0 83.0 83.0 84.0 85.0 10:00:16 INFO - PROCESS | 1988 | 10:00:16 INFO - PROCESS | 1988 | [#8] json-parse-financial Cycles:10 Average:62.50 Median:63.00 stddev:3.21 (5.1%) stddev-sans-first:3.27 10:00:16 INFO - PROCESS | 1988 | Values: 65.0 59.0 61.0 60.0 63.0 63.0 63.0 64.0 58.0 69.0 10:00:16 INFO - PROCESS | 1988 | 10:00:16 INFO - PROCESS | 1988 | [#9] json-stringify-tinderbox Cycles:10 Average:60.70 Median:60.00 stddev:4.69 (7.8%) stddev-sans-first:4.30 10:00:16 INFO - PROCESS | 1988 | Values: 54.0 59.0 72.0 64.0 61.0 59.0 58.0 60.0 60.0 60.0 10:00:16 INFO - PROCESS | 1988 | 10:00:16 INFO - PROCESS | 1988 | [#10] stanford-crypto-aes Cycles:10 Average:85.20 Median:85.50 stddev:2.30 (2.7%) stddev-sans-first:2.30 10:00:16 INFO - PROCESS | 1988 | Values: 83.0 83.0 87.0 86.0 85.0 84.0 83.0 87.0 84.0 90.0 10:00:16 INFO - PROCESS | 1988 | 10:00:16 INFO - PROCESS | 1988 | [#11] stanford-crypto-ccm Cycles:10 Average:142.70 Median:142.50 stddev:12.49 (8.8%) stddev-sans-first:13.01 10:00:16 INFO - PROCESS | 1988 | Values: 136.0 138.0 139.0 137.0 125.0 133.0 146.0 148.0 168.0 157.0 10:00:16 INFO - PROCESS | 1988 | 10:00:16 INFO - PROCESS | 1988 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.60 Median:167.00 stddev:17.11 (10.2%) stddev-sans-first:17.79 10:00:16 INFO - PROCESS | 1988 | Values: 162.0 176.0 165.0 165.0 219.0 163.0 166.0 168.0 164.0 168.0 10:00:16 INFO - PROCESS | 1988 | 10:00:16 INFO - PROCESS | 1988 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.10 Median:67.50 stddev:8.58 (12.7%) stddev-sans-first:8.97 10:00:16 INFO - PROCESS | 1988 | Values: 66.0 66.0 65.0 62.0 63.0 64.0 69.0 80.0 86.0 80.0 10:00:16 INFO - PROCESS | 1988 | -------- Summary: end -------- 10:00:16 INFO - PROCESS | 1988 | 10:00:17 INFO - TEST-INFO | 1988: exit 0 10:00:17 INFO - TEST-OK | kraken | took 59935ms 10:00:17 INFO - SUITE-END | took 1179s 10:00:17 INFO - Completed test suite (00:19:39) 10:00:17 INFO - javascript benchmark 10:00:17 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7644.33387051025, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3419.692227699507, 3426.537417448645, 3428.314337132574, 3428.6057103433113, 3489.354469423157, 6041.275046994361, 6111.743676692132, 6122.540809439293, 6127.908081378783, 6134.429849761934, 6077.058056001327, 6086.056661217518, 6125.9387406125925, 6126.479249263818, 6146.81559553213, 5428.0, 5462.426445223234, 5498.340199176085, 5506.063969125258, 5588.552915766729, 5373.435789242132, 5382.300300960869, 5587.580931430139, 5592.3009623797025, 5602.915956260659, 5444.183372494138, 5469.398366179717, 5505.229267902497, 5554.472325129106, 5566.192902029204, 5532.0, 5565.165225216209, 5572.3034620672415, 5575.107982722745, 5575.944240557583, 5308.73456327186, 5433.4566543345745, 5483.533899618537, 5494.890102197934, 5511.118221084607, 6037.30570984338, 6078.544109191828, 6084.756609735606, 6107.0, 6131.743695906989, 6510.934890651128, 6517.348265173492, 6521.250056243545, 6529.5429319947625, 6538.150040494753, 6536.411722944958, 6567.507436942201, 6576.04647326135, 6597.109390232353, 6613.86772264552, 6032.879342413171, 6106.847328816815, 6117.327094019654, 6137.4169453902705, 6163.3528479509905, 6480.740770369227, 6556.770513032021, 6563.606183628997, 6571.704273307712, 6616.0, 6374.139491168726, 6383.96808015957, 6393.073004414334, 6396.968015159988, 6397.680115994275, 6499.545031847725, 6515.055316979012, 6515.6742162892615, 6527.510436717265, 6538.986457099158, 6168.19813424261, 6224.37756224374, 6418.8716225675225, 6436.16329877113, 6447.258565265054, 6380.7128679209545, 6445.838854028687, 6481.513886458534, 6524.314946930599, 6530.249021362509, 5163.302954101224, 5208.192730126836, 5213.921791173136, 5220.295260139908, 5241.790328386898, 4536.954630453653, 4652.767361631973, 4657.930131048037, 4663.556962088596, 4702.130105930414, 6104.664243466563, 6107.358727333655, 6120.418560236771, 6124.112003759519, 6126.908096378558, 6398.040293955851, 6403.359664033559, 6405.807825765234, 6430.7106180222, 6470.9029364559565, 6105.938940610626, 6131.223750760734, 6151.446369826737, 6163.291221509494, 6163.476104531165, 5778.162166485836, 5788.479036886701, 5794.681292528951, 5805.071188609802, 5815.418458154235, 6492.220933488012, 6554.868902622016, 6641.070250165078, 6785.9660701696175, 6802.387785099365, 6436.581622194542, 6481.513886458629, 6481.740730370732, 6483.4164925156965, 6496.220453545605, 6612.437942774725, 6690.966545167243, 6692.564983276072, 6695.0626912231355, 6728.0, 5427.213054107211, 6091.842549915502, 6377.96811015942, 6383.234011918599, 6386.074019267273, 5429.886873190907, 5933.199018132669, 6355.30091689923, 6396.0, 6485.027245913151, 6352.523560732871, 6358.523110766619, 6369.80890573265, 6371.39471750183, 6386.16979792624, 6269.811905642838, 6283.5287353449585, 6347.333529979285, 6354.110424540476, 6362.554621176473, 6138.0179171332375, 6155.569110162425, 6167.753289868535, 6194.5354098443695, 6251.0, 6294.874102517832, 6325.05124231369, 6325.462335701517, 6346.111544383883, 6348.77779277723, 6177.876442471035, 6212.254529456313, 6237.968810156101, 6255.0, 6265.718042687999], "value": 5975.228215111174, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [759.8404335089631, 779.1974266505499, 809.0574480729948, 877.7191298784392, 889.8531742262527, 27658.446831063367, 38983.61016389839, 39464.210715785666, 39536.406953895676, 39575.802120989356, 39769.80115099421, 40001.79999100001, 40074.19851602966, 40100.59899401005, 40176.794696159086, 7451.850962980737, 9248.999999999984, 9408.81182376352, 9416.340856140074, 9428.952855235748, 7427.888581671279, 11280.548778048867, 11445.141614378956, 11463.31220126795, 11479.368634725086, 9547.379420337691, 11307.491162897648, 11329.773404531905, 11330.490127944222, 11331.603393881216, 11251.43742812856, 11299.774004519946, 11299.943500282447, 11303.943480282545, 11322.26405283654, 7295.562266263988, 7477.551346919202, 7521.135069467026, 7531.585762783045, 7539.2460753924715, 37623.0, 38256.80871595652, 38368.80815595932, 38419.61580384188, 39737.40393894065, 3820.6561409473, 3857.3228864171815, 3864.574896761354, 3869.090763670535, 3969.960300397017, 25529.74470255292, 27317.45365092707, 28803.85598072017, 29236.269093272625, 29382.11853644394, 3059.5869557609662, 3142.1673256587023, 3154.2114471382156, 3164.2089477630593, 3196.6483686794436, 350063.0, 354108.0, 354240.0, 354619.0, 354728.0, 51049.48950510447, 51164.48835511597, 51275.0, 51284.0, 51492.48507514952, 53085.46914530882, 53115.734421327645, 53136.07751573623, 53175.0, 53230.20154697605, 14415.990880638465, 14689.632759181106, 14690.55928322152, 14697.04469209498, 14710.852891470948, 10895.618653347254, 12735.808962865565, 12758.979281657445, 12774.872251277555, 12786.360681965865, 10273.640422585324, 10351.327163734484, 11517.48171332292, 11657.533698652129, 11737.178397512092, 4842.4189097308545, 5687.658740475585, 5758.798442054508, 5761.798337058183, 5772.624779389326, 883.4831623500324, 900.0864122915247, 920.2224120618067, 946.5693109635099, 974.5078735238659, 26871.865640671673, 27981.160565183076, 28659.0, 28725.71274287272, 28733.56899646507, 1040.2562168049728, 1040.5369610523396, 1041.286718597763, 1078.412265315405, 1084.7613525024483, 14422.42310307597, 14556.563303100924, 14628.780568291484, 14630.634234144232, 14690.779638305434, 460185.0, 460334.0, 460428.0, 461152.0, 461710.0, 55536.722316388965, 55676.0, 55699.0, 55749.60625984383, 55764.72117639386, 1197.1500234833018, 1433.4624515806572, 1463.590194745473, 1469.1478942213705, 1469.4709904434394, 26098.739012609632, 27127.59308610333, 27150.0, 27403.725962740118, 27405.177844664693, 44012.779936100116, 44023.0, 44033.77983110064, 44107.779461103775, 44156.779216103714, 437929.0, 438031.0, 438129.0, 439007.0, 440041.0, 33208.833955830065, 33846.492302614985, 33899.4915076279, 33929.0, 33972.83013584916, 29271.7072829269, 29745.25636859096, 29985.700142998292, 42824.57175428331, 43833.34249986317, 28340.85829570839, 32281.35437291288, 32545.837270813496, 35774.46338304875, 37578.43632345572, 28674.856625716737, 33620.83189584036, 35897.64102358943, 36171.63828361683, 37242.696505622174, 35837.0, 36776.26447471089, 36807.81596092002, 36926.44610330901, 37041.0, 29973.400531988802, 32495.512567311984, 32556.0, 32599.0, 33062.83468582642, 19273.132709027846, 23044.654330184727, 23259.53480930338, 24326.297159199396, 24945.0], "value": 18516.277284072563, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [381.15954320722807, 408.18358305540335, 417.5615603616202, 427.69419864796663, 433.03001277139197, 19870.60258794825, 20571.0, 21420.25029123981, 22281.0, 22669.54660906781, 20065.598688026268, 21572.029258683357, 21934.45163870904, 22076.0, 22094.226702065433, 5702.914456283159, 6559.475241980654, 6567.802965911031, 6569.244536878273, 6584.572002819826, 4205.1169254456445, 4728.550762821835, 6705.0, 6741.629210393427, 6754.223264324592, 4431.468223813131, 4466.776661166945, 6866.34769696878, 7335.559866408006, 7632.580208088553, 7405.444591655593, 7571.0, 7578.8484230315635, 7670.194629563871, 7752.26353496417, 7278.526895751759, 7354.117505899327, 7438.442116841258, 7443.441741869381, 7444.548313078952, 20460.79539204604, 26157.869210654015, 26453.0, 26483.470330593475, 26801.597976030374, 2640.036386718853, 2756.5865120231924, 2893.6816950135467, 3251.2522119912314, 3395.558577384949, 14282.785758213635, 15811.288492017888, 15894.205289735466, 15986.920065399714, 16854.831451685448, 1732.7747392838976, 1957.8237958583654, 2010.8089731475486, 2029.9797002029939, 2057.2593866208153, 151335.0, 153006.46993530146, 159463.20268398584, 160485.0, 162642.3735762639, 19989.80061196333, 20120.798792012185, 20259.696104558443, 20385.49036274105, 20427.795722042887, 31725.0, 31920.680793191772, 32202.19494512656, 32204.19489512734, 32336.353272934408, 10134.138598219086, 10211.489425528694, 10385.740356490996, 10408.115310198718, 10527.526261318259, 8666.480011199348, 8678.002029766658, 8690.826183476422, 8849.955750221336, 8862.42394244372, 7492.887606685904, 7594.696212151563, 9178.403403778733, 9308.348415610977, 9445.574949127305, 2997.3555685527717, 3686.9631303687156, 3747.868824591126, 3952.347862602696, 4030.2141082488633, 850.3834719828075, 857.4812238595559, 896.3904544909394, 913.0732306708696, 928.9489078100634, 17020.744688829676, 20731.170753170005, 21392.037358318914, 21441.89279053595, 21949.792761398276, 888.5113187746714, 897.8742975983367, 898.1108702384593, 900.8558630619069, 926.4672813132476, 9664.565094570762, 10918.890811091946, 11485.540578376771, 11504.309741415542, 11507.654770356903, 747321.0, 759375.0, 767588.0, 774662.0, 807603.0, 126753.0, 135642.93071207684, 145301.28192308496, 151704.0, 154738.0, 1258.9118761686593, 1265.7405231927617, 1291.6447976806453, 1298.571471414431, 1299.1944994103528, 18010.379065883608, 19019.0, 19061.046947652285, 19080.618387632447, 19095.809041909957, 58729.4127058724, 61709.0, 62156.37843621506, 62956.68521657363, 65340.346596533425, 79526.0, 80937.19062809297, 82626.0, 82752.3449531018, 84784.72822907538, 11348.375839328915, 11564.768704626029, 11576.479058442223, 11843.940780296043, 11945.522179112739, 12601.18092323996, 12612.621621351374, 12774.936125319315, 12903.41934612926, 12906.096573239784, 10223.846642300223, 10771.784564308826, 10937.617183398543, 11122.110231181648, 11138.10895128404, 10089.949550252202, 10856.620018299638, 10946.616868409568, 11001.449927503432, 11034.503447345049, 8452.957735211285, 10919.727006824893, 11024.834627480755, 11123.944380278046, 11216.158788090763, 10214.642487512901, 11453.255538389978, 11593.826092608786, 11758.82361764557, 11884.46519906589, 10340.914204008472, 10385.013423724735, 10505.68482945513, 10790.73023174427, 10791.514381852678], "value": 11335.996864636545, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1466.1935935235617, 1525.366972706327, 1535.7542793153098, 1570.442492915016, 1581.7627355896618, 10752.0, 11366.204365694395, 11380.715482112952, 11383.487743051563, 11390.202685811986, 10680.519376628052, 10988.505517251722, 11035.117190624751, 11112.944435277832, 11144.832827507595, 2349.8942547585357, 2386.343755467252, 2386.7374588795305, 2388.940276493084, 2390.2948630154146, 2331.40549159964, 2364.6334818103223, 2369.1944738788807, 2372.217168334454, 2373.4066483379156, 2302.6200676888293, 2320.9883950580224, 2322.5587138443725, 2330.7785760352826, 2332.3352844439337, 2138.262299506683, 2164.7835216478384, 2166.5991791518463, 2171.1423987524995, 2174.13034786086, 2282.167009041704, 2339.181286549711, 2339.3800642829665, 2339.63735620979, 2350.4123969007746, 11391.0, 11447.969682728595, 11471.0, 11484.310941343547, 11490.138239631977, 4833.782479788383, 5410.0, 5467.617266791326, 5547.223388725542, 5726.828195154152, 3254.5769050023346, 3422.025381974788, 3483.494893240466, 3487.8779242726637, 3512.4380099184264, 1106.4523061084733, 1134.2211432750125, 1178.6405146430336, 1208.746163305707, 1212.854457465101, 15301.770473442908, 15372.154531500762, 15424.845751542452, 15451.227438628024, 15459.768103478456, 4240.448741663626, 4483.574060464251, 4553.021100463417, 4569.817207311737, 4574.611158051536, 11478.713032174095, 11491.655250342503, 11493.827592586118, 11495.712607184887, 11499.482523286471, 5533.806316778974, 5540.9168862467095, 5541.750621222055, 5553.722313884289, 5573.554115670818, 4973.801047958041, 5024.221245706921, 5071.137906555894, 5118.897622047538, 5152.948470515322, 3294.7364210863075, 3566.054995426214, 3748.5689145748042, 3773.3208022556205, 3812.8856134316015, 955.5652178258875, 957.4590356448584, 966.5264020629982, 968.9660861869801, 975.1516180922501, 800.9631457454481, 841.5203334099627, 901.5807649443041, 912.3112050401904, 925.4724806860025, 5661.830145095653, 6527.445167160845, 6590.209174898947, 6619.635920024349, 6639.170103737033, 839.5508403004363, 888.0985799413601, 975.9365641233297, 1017.1710056304089, 1024.538957469142, 4164.75011499311, 4202.201581699528, 4210.59999300066, 4314.654827613784, 4433.135538570013, 13934.651633709238, 14300.785488217685, 14383.28083595816, 14386.424543018371, 14425.278736063365, 10822.404767737693, 11822.88177118235, 14344.282785860665, 14346.49787257441, 14355.497557585435, 8838.558072096497, 10289.845652315222, 10444.373337599769, 10470.319429236923, 10479.47602619866, 6635.402813746786, 6656.134702488645, 6721.0, 6778.0, 6823.112995310578, 12255.938720306342, 12286.81569776472, 12512.874871251171, 12677.936610316889, 12687.429065691882, 12224.694382640506, 12677.746445071232, 12915.935420322838, 13016.15394999322, 13077.41151648159, 8442.53566053873, 8458.873116903129, 8633.827323453621, 8648.394612377073, 8651.264642505457, 10202.948985255027, 10217.642382516577, 10311.123554497952, 10320.0, 10351.482425878827, 8979.191872731486, 9143.63425462974, 9230.630774768933, 9252.907470925205, 9272.768180795534, 8633.35249856276, 8952.820943581222, 9007.594658240527, 9054.683086091954, 9064.002959674299, 7643.656035478306, 7710.344620707303, 7787.143414224544, 7793.025871766029, 7803.102643196105, 5669.206311116364, 5697.715114244188, 5833.270841144857, 5841.0, 5856.853578660568, 5823.854403639943, 5834.562407819515, 5951.910721339097, 6000.489958353589, 6170.81487555374], "value": 5055.979156239944, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [373.11013233438246, 376.0729801040435, 377.9508663873696, 384.13761106316315, 387.71309231168925, 4415.028693687392, 4637.820224494486, 4817.445993710724, 5201.5838732901375, 5221.895562088756, 4472.575105364993, 5015.0, 5076.771545280462, 5090.32019433587, 5248.422673505911, 4137.034908418492, 4203.831846726127, 4230.280852255117, 4267.466566679165, 4277.443932288814, 4010.659093977001, 4251.298535741615, 4260.552641972595, 4293.914121717564, 4334.371516130159, 3735.2902948439846, 4275.845521709137, 4297.742135471882, 4307.889134324174, 4319.524852266248, 3509.2455122148863, 4168.541460439349, 4172.040430700926, 4281.850135245251, 4333.783310834461, 3506.36885360635, 3777.9055523611855, 3891.8832435026993, 3949.7037722170953, 3954.5056867891512, 4409.96365854024, 4685.4143232095985, 4736.218523943545, 4939.950600493985, 4947.431045429786, 4633.586756039406, 4902.779374928136, 4957.413627639157, 4975.62682798788, 4982.87542811429, 4949.133901567247, 5101.4133374662015, 5325.535477743612, 5440.836774896759, 5504.339479262514, 3673.669369756708, 4446.977765111186, 4470.642348612103, 4481.887952801206, 4536.682432229745, 4809.663323567387, 5467.781288748445, 5643.463870932255, 5851.531877449836, 5916.526677865761, 3820.808959552067, 3822.222222222222, 3966.960330396659, 4307.987622908614, 4431.490378606437, 4540.931886021713, 4563.589276965089, 4588.334691469719, 4592.265237561974, 4605.792739326738, 3945.3292940200236, 4422.823087076481, 4789.137955168034, 4825.758712064383, 4871.3667223260745, 4380.737155770664, 5268.710220937885, 5337.2794672719465, 5382.703951282639, 5458.9454105458435, 1280.3406245783428, 1457.8323492798463, 1536.9923150384177, 1558.3688606114542, 1583.279607778458, 978.554757585297, 1015.441507171053, 1173.3487914207697, 1176.8584473061117, 1190.1609365397546, 4408.25059739845, 4623.352730617717, 4865.927011094836, 5005.998800239967, 5095.579599690118, 4896.485868983706, 5410.648307859977, 5632.831015069554, 5638.2670252866865, 5647.661140331593, 4433.889152771142, 4460.687751857339, 5041.092603331435, 5116.334876466036, 5125.974370128126, 2238.0488292475634, 2440.9389765255655, 2552.693676758801, 2809.438112377533, 2885.7114288571397, 5231.738413079331, 5451.955516681244, 5790.88418231633, 5866.221771555015, 5911.556633252523, 4816.254734801129, 5397.514223719805, 5470.134980599322, 5533.0, 5708.743106560215, 5536.446355364431, 5634.070378387521, 5642.0252911481475, 5752.913706294409, 5786.3056433228285, 5367.409584945731, 5571.994082130349, 5690.573207009408, 5715.399883012224, 5736.942630573641, 4677.555632214934, 4805.299919062372, 5289.6297259193025, 5379.327584051994, 5541.944580554304, 4672.9532704673875, 5498.092814685532, 5803.970980145073, 5852.326982397079, 5933.436323549256, 4058.289799285172, 4167.70801051675, 4388.0, 4423.225935461346, 4476.0, 5265.52610265078, 5353.8506919692545, 5369.919451208313, 5587.273654424899, 5626.0, 4941.901161976813, 5189.974050129726, 5258.0009798138235, 5460.6996615186545, 5539.806106786243, 4558.82573279337, 4721.598664113589, 4785.401824771903, 5289.0, 5291.618771552739, 3795.867144649924, 4157.590775564008, 4513.864584062483, 4985.426675932169, 5376.596755243294, 4683.461401938821, 4710.458297295718, 4958.404991401055, 5098.031374038921, 5123.462036486116, 4878.268259761065, 4925.236588328815, 5129.512696293846, 5336.7598458068705, 5415.675059496442], "value": 4125.955845783397, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [725.836686745482, 750.1111183247851, 756.2210922749563, 818.8894499242602, 828.7720876758891, 14827.851721482783, 15101.320440580173, 15844.920775396107, 15877.603059923507, 15895.205239738025, 14279.357428915699, 14372.137671739676, 14454.205018723993, 14523.636909077279, 14588.635284117876, 918.2883265469281, 931.2038207332735, 932.0074121061082, 936.5598168860624, 944.8677185194044, 897.1745993685824, 922.1009515722151, 928.3779867488798, 930.5998420679106, 941.6327632223438, 969.7866469376726, 971.7862070344513, 972.2173650211577, 972.397113789448, 973.9561719722594, 964.9372790768648, 965.1844191658038, 967.066780556766, 967.2552134856156, 969.0, 720.5028530314119, 721.5490318550906, 722.9746958856415, 723.1611330856182, 723.3995783499682, 15499.992500487546, 15621.609459763484, 15641.843581564153, 15839.287232074585, 15959.0, 13967.860321396758, 14100.08349457282, 14309.78535321971, 14394.712105757826, 14395.496157634432, 11693.473793679219, 11787.882121178764, 11886.881131188664, 12012.87987120135, 12330.691732706664, 3688.6495782900583, 3691.3909204981146, 3742.7941463219513, 3795.8671446499516, 3888.844446222148, 94965.52517237439, 118788.40605797002, 119007.99999999913, 119450.0, 119521.40239298748, 10841.83737243942, 10893.673189804318, 10933.507992140372, 10951.397673128055, 11294.209405341711, 22412.88793556022, 22814.771852281596, 23054.538909221723, 23095.538089238456, 23168.0, 7706.845863082707, 7716.922830771733, 7724.343430808444, 7788.185337829399, 7926.801829954182, 4327.17783621111, 4360.324149756792, 4384.342348647665, 4466.709663871903, 4529.162105010583, 3350.447176215897, 3396.5075064115563, 3434.7252219822353, 3445.758796884194, 3471.6701913318193, 606.3663471672113, 609.3662590905409, 612.7518355066117, 622.6108682073703, 624.0327492386782, 567.2965522751758, 665.082186582513, 674.9898751518731, 683.5147045597582, 693.2789898505498, 9815.803683926282, 10238.53926573306, 10328.741781455523, 10775.407352595526, 10797.46012699362, 644.432899048834, 679.867425851964, 703.9014537964689, 705.9974835733168, 745.4260219630962, 4980.128477516492, 5062.848114556569, 5063.8480845574695, 5085.440601533828, 5096.184610462308, 69026.0, 86816.53544477567, 98506.0, 98587.50706246567, 100355.0, 80733.19266807257, 90599.0, 95491.56762648566, 96047.0, 98114.0, 70376.0, 82425.58787206025, 82691.5865420669, 85032.14967850366, 86668.56665716632, 9171.31215158879, 9649.276304277348, 9758.0, 9783.902160978583, 9797.951010244904, 51284.487155129464, 53159.08694894674, 53451.73274133605, 54489.72755136199, 55417.44582554284, 65557.0, 66721.0, 67478.66260668666, 67733.66133169303, 68215.0, 10467.0, 11093.445327733742, 11188.328700278009, 11193.66419007431, 11587.536498539965, 11900.28598284071, 12671.683207919876, 13260.403281852532, 14470.782938256145, 14962.775558366415, 13819.654508637364, 14312.640179828046, 14323.355449005028, 14344.56966291013, 14482.927585362006, 13157.342132893125, 13584.592462226148, 14061.367238474499, 14233.572992810232, 14773.039752416058, 13171.47314107425, 13451.932740336235, 13742.03805733589, 13750.86249137536, 14061.086029408056, 11133.165012624248, 11159.665210043711, 11315.603953861575, 11353.48909299067, 11743.823842642538, 7996.440249182501, 9619.374740641835, 11258.0, 11534.653960381202, 11536.423178841193], "value": 7626.029364009184, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1431.1, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 115.0, 115.0, 116.0, 115.0, 116.0, 116.0, 114.0, 113.0, 115.0], "value": 115.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 112.0, 111.0, 145.0, 112.0, 110.0, 109.0, 108.0, 131.0, 112.0], "value": 119.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 188.0, 185.0, 186.0, 184.0, 185.0, 187.0, 185.0, 185.0, 184.0], "value": 185.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 60.0, 62.0, 96.0, 82.0, 84.0, 83.0, 83.0, 76.0, 60.0], "value": 77.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 71.0, 87.0, 70.0, 69.0, 68.0, 83.0, 68.0, 67.0, 85.0], "value": 75.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 88.0, 87.0, 88.0, 88.0, 87.0, 87.0, 87.0, 88.0, 87.0], "value": 87.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 94.0, 94.0, 94.0, 94.0, 95.0, 94.0, 93.0, 93.0], "value": 94.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 86.0, 86.0, 85.0, 85.0, 83.0, 83.0, 84.0, 85.0], "value": 84.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 59.0, 61.0, 60.0, 63.0, 63.0, 63.0, 64.0, 58.0, 69.0], "value": 62.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 59.0, 72.0, 64.0, 61.0, 59.0, 58.0, 60.0, 60.0, 60.0], "value": 60.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 87.0, 86.0, 85.0, 84.0, 83.0, 87.0, 84.0, 90.0], "value": 85.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 138.0, 139.0, 137.0, 125.0, 133.0, 146.0, 148.0, 168.0, 157.0], "value": 142.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 176.0, 165.0, 165.0, 219.0, 163.0, 166.0, 168.0, 164.0, 168.0], "value": 171.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 65.0, 62.0, 63.0, 64.0, 69.0, 80.0, 86.0, 80.0], "value": 70.1, "unit": "score"}]}]} 10:00:17 INFO - Return code: 0 10:00:17 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:00:17 ERROR - # TBPL SUCCESS # 10:00:17 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:00:17 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:00:17 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:00:17 INFO - 2017-03-23 10:00:17.690 screenresolution[1992:18481] starting screenresolution argv=screenresolution get 10:00:17 INFO - 2017-03-23 10:00:17.693 screenresolution[1992:18481] Display 0: 1600x1200x32@60 10:00:17 INFO - 2017-03-23 10:00:17.699 screenresolution[1993:18484] starting screenresolution argv=screenresolution list 10:00:17 INFO - Available Modes on Display 0 10:00:17 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:00:17 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:00:17 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:00:17 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:00:17 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:00:17 INFO - Intel Iris: 10:00:17 INFO - Chipset Model: Intel Iris 10:00:17 INFO - Type: GPU 10:00:17 INFO - Bus: Built-In 10:00:17 INFO - VRAM (Dynamic, Max): 1536 MB 10:00:17 INFO - Vendor: Intel (0x8086) 10:00:17 INFO - Device ID: 0x0a2e 10:00:17 INFO - Revision ID: 0x0009 10:00:17 INFO - Displays: 10:00:17 INFO - Display: 10:00:17 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:00:17 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:00:17 INFO - Display Serial Number: 1600x1200 60 10:00:17 INFO - Main Display: Yes 10:00:17 INFO - Mirror: Off 10:00:17 INFO - Online: Yes 10:00:17 INFO - Rotation: Supported 10:00:17 INFO - Return code: 0 10:00:17 INFO - Running post-action listener: _resource_record_post_action 10:00:17 INFO - [mozharness: 2017-03-23 17:00:17.936883Z] Finished run-tests step (success) 10:00:17 INFO - Running post-run listener: _resource_record_post_run 10:00:18 INFO - Total resource usage - Wall time: 1200s; CPU: 54.0%; Read bytes: 864256; Write bytes: 506902528; Read time: 11; Write time: 1875 10:00:18 INFO - TinderboxPrint: CPU usage
53.8% 10:00:18 INFO - TinderboxPrint: I/O read bytes / time
864,256 / 11 10:00:18 INFO - TinderboxPrint: I/O write bytes / time
506,902,528 / 1,875 10:00:18 INFO - TinderboxPrint: CPU idle
2,219.9 (46.2%) 10:00:18 INFO - TinderboxPrint: CPU system
955.1 (19.9%) 10:00:18 INFO - TinderboxPrint: CPU user
1,626.7 (33.9%) 10:00:18 INFO - TinderboxPrint: Swap in / out
209,666,048 / 0 10:00:18 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 204233216; Write bytes: 199938048; Read time: 15661; Write time: 366 10:00:18 INFO - run-tests - Wall time: 1181s; CPU: 54.0%; Read bytes: 827392; Write bytes: 295917568; Read time: 11; Write time: 1472 10:00:18 INFO - Running post-run listener: _upload_blobber_files 10:00:18 INFO - Blob upload gear active. 10:00:18 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:00:18 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 10:00:18 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-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:00:18 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-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:00:18 INFO - (blobuploader) - INFO - Open directory for files ... 10:00:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:00:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:00:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:00:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:00:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:00:19 INFO - (blobuploader) - INFO - Done attempting. 10:00:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:00:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:00:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:00:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:00:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:00:20 INFO - (blobuploader) - INFO - Done attempting. 10:00:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 10:00:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:00:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:00:21 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 10:00:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:00:21 INFO - (blobuploader) - INFO - Done attempting. 10:00:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:00:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:00:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:00:23 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:00:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:00:23 INFO - (blobuploader) - INFO - Done attempting. 10:00:23 INFO - (blobuploader) - INFO - Iteration through files over. 10:00:23 INFO - Return code: 0 10:00:23 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:00:23 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:00:23 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d2347d2fdb48e6c23848f6846a8331b7d2b945f3313dadceef1da3b06bba87915330fcf6e0817a08b2d73ff90fb60e4aab6c22360c2809869d9c70b8e8d588fc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/07e82be8d7ca57c320b027ad1c5fdb4c3f7e1d64214f6bd3e63ff479027ff32038ea7617e08542ff9961de9398faa6a8fe797697e9e875230b478c72cc06f0b1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/541ef2a4af6e1ed6b2c03f42ef4e042cb177583b26a856ede618117b93d193c8120d69accbb23cd2443eb1c862a61c8083b4e0af5871fd4ffc3c73fb3c1f5ff5", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9eba1e2f77705ca8555e46cd3e239cc989916a1a54765475088f6d6c5f2d8e3551b255ddaccabb6bf8a43738f7f704b85e08126153952310f6936c513d065fe7"} 10:00:23 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:00:23 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:00:23 INFO - Contents: 10:00:23 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d2347d2fdb48e6c23848f6846a8331b7d2b945f3313dadceef1da3b06bba87915330fcf6e0817a08b2d73ff90fb60e4aab6c22360c2809869d9c70b8e8d588fc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/07e82be8d7ca57c320b027ad1c5fdb4c3f7e1d64214f6bd3e63ff479027ff32038ea7617e08542ff9961de9398faa6a8fe797697e9e875230b478c72cc06f0b1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/541ef2a4af6e1ed6b2c03f42ef4e042cb177583b26a856ede618117b93d193c8120d69accbb23cd2443eb1c862a61c8083b4e0af5871fd4ffc3c73fb3c1f5ff5", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9eba1e2f77705ca8555e46cd3e239cc989916a1a54765475088f6d6c5f2d8e3551b255ddaccabb6bf8a43738f7f704b85e08126153952310f6936c513d065fe7"} 10:00:23 INFO - Running post-run listener: copy_logs_to_upload_dir 10:00:23 INFO - Copying logs to upload dir... 10:00:23 INFO - mkdir: /builds/slave/test/build/upload/logs 10:00:23 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1283.567022 ========= master_lag: -0.13 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 23 secs) (at 2017-03-23 10:00:23.346582) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-23 10:00:23.349865) ========= 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.vC0mavhZdU/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.dMLgMe3eN6/Listeners TMPDIR=/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/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-Aurora/sha512/d2347d2fdb48e6c23848f6846a8331b7d2b945f3313dadceef1da3b06bba87915330fcf6e0817a08b2d73ff90fb60e4aab6c22360c2809869d9c70b8e8d588fc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/07e82be8d7ca57c320b027ad1c5fdb4c3f7e1d64214f6bd3e63ff479027ff32038ea7617e08542ff9961de9398faa6a8fe797697e9e875230b478c72cc06f0b1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/541ef2a4af6e1ed6b2c03f42ef4e042cb177583b26a856ede618117b93d193c8120d69accbb23cd2443eb1c862a61c8083b4e0af5871fd4ffc3c73fb3c1f5ff5", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9eba1e2f77705ca8555e46cd3e239cc989916a1a54765475088f6d6c5f2d8e3551b255ddaccabb6bf8a43738f7f704b85e08126153952310f6936c513d065fe7"} build_url:https://queue.taskcluster.net/v1/task/To3fmq63TUWxSLscsRR8Ew/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011286 build_url: 'https://queue.taskcluster.net/v1/task/To3fmq63TUWxSLscsRR8Ew/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d2347d2fdb48e6c23848f6846a8331b7d2b945f3313dadceef1da3b06bba87915330fcf6e0817a08b2d73ff90fb60e4aab6c22360c2809869d9c70b8e8d588fc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/07e82be8d7ca57c320b027ad1c5fdb4c3f7e1d64214f6bd3e63ff479027ff32038ea7617e08542ff9961de9398faa6a8fe797697e9e875230b478c72cc06f0b1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/541ef2a4af6e1ed6b2c03f42ef4e042cb177583b26a856ede618117b93d193c8120d69accbb23cd2443eb1c862a61c8083b4e0af5871fd4ffc3c73fb3c1f5ff5", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9eba1e2f77705ca8555e46cd3e239cc989916a1a54765475088f6d6c5f2d8e3551b255ddaccabb6bf8a43738f7f704b85e08126153952310f6936c513d065fe7"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-23 10:00:23.384302) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-23 10:00:23.384636) ========= 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.vC0mavhZdU/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.dMLgMe3eN6/Listeners TMPDIR=/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/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.005312 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-23 10:00:23.433117) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-23 10:00:23.433418) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-23 10:00:23.433740) ========= ========= Total master_lag: 0.01 =========