builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0365 starttime: 1489078732.59 results: success (0) buildid: 20170309072024 builduid: d2f85c978ad44ff4ad9c25a00c43c038 revision: 3d8f875e7af5260119652056404f47e16760ea42 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-09 08:58:52.594574) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-09 08:58:52.595086) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-09 08:58:52.595377) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-09 08:58:52.620505) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-09 08:58:52.620889) ========= 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.52n0KLSWPF/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.3nP71L5h4l/Listeners TMPDIR=/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/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-09 08:58:52-- 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% 48.8M=0s 2017-03-09 08:58:52 (48.8 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.145839 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-09 08:58:52.789848) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-09 08:58:52.790154) ========= 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.52n0KLSWPF/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.3nP71L5h4l/Listeners TMPDIR=/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/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.020498 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-09 08:58:52.838938) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2017-03-09 08:58:52.839300) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 3d8f875e7af5260119652056404f47e16760ea42 --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 3d8f875e7af5260119652056404f47e16760ea42 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.52n0KLSWPF/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.3nP71L5h4l/Listeners TMPDIR=/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/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-09 08:58:52,946 truncating revision to first 12 chars 2017-03-09 08:58:52,947 Setting DEBUG logging. 2017-03-09 08:58:52,947 attempt 1/10 2017-03-09 08:58:52,947 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/3d8f875e7af5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-09 08:58:55,982 unpacking tar archive at: mozilla-aurora-3d8f875e7af5/testing/mozharness/ program finished with exit code 0 elapsedTime=3.294278 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2017-03-09 08:58:56.156721) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-09 08:58:56.157049) ========= script_repo_revision: 3d8f875e7af5260119652056404f47e16760ea42 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-09 08:58:56.157447) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-09 08:58:56.157721) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-09 08:58:56.177577) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 24 secs) (at 2017-03-09 08:58:56.177975) ========= /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.52n0KLSWPF/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.3nP71L5h4l/Listeners TMPDIR=/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 08:58:56 INFO - MultiFileLogger online at 20170309 08:58:56 in /builds/slave/test 08:58:56 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 08:58:56 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:58:56 INFO - {'append_to_log': False, 08:58:56 INFO - 'base_work_dir': '/builds/slave/test', 08:58:56 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 08:58:56 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:58:56 INFO - 'branch': 'Mozilla-Aurora', 08:58:56 INFO - 'buildbot_json_path': 'buildprops.json', 08:58:56 INFO - 'config_files': ('talos/mac_config.py',), 08:58:56 INFO - 'default_actions': ('clobber', 08:58:56 INFO - 'read-buildbot-config', 08:58:56 INFO - 'download-and-extract', 08:58:56 INFO - 'populate-webroot', 08:58:56 INFO - 'create-virtualenv', 08:58:56 INFO - 'install', 08:58:56 INFO - 'run-tests'), 08:58:56 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:58:56 INFO - 'download_minidump_stackwalk': True, 08:58:56 INFO - 'download_symbols': 'ondemand', 08:58:56 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:58:56 INFO - 'tooltool.py': '/tools/tooltool.py', 08:58:56 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:58:56 INFO - '/tools/misc-python/virtualenv.py')}, 08:58:56 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:58:56 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:58:56 INFO - 'gecko_profile': False, 08:58:56 INFO - 'gecko_profile_interval': 0, 08:58:56 INFO - 'installer_path': 'installer.exe', 08:58:56 INFO - 'log_level': 'info', 08:58:56 INFO - 'log_name': 'talos', 08:58:56 INFO - 'log_to_console': True, 08:58:56 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:58:56 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:58:56 INFO - 'opt_config_files': (), 08:58:56 INFO - 'pip_index': False, 08:58:56 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:58:56 INFO - 'cmd': ('bash', 08:58:56 INFO - '-c', 08:58:56 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:58:56 INFO - 'enabled': True, 08:58:56 INFO - 'halt_on_failure': False, 08:58:56 INFO - 'name': 'check_screen_resolution'},), 08:58:56 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:58:56 INFO - 'cmd': ('bash', 08:58:56 INFO - '-c', 08:58:56 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:58:56 INFO - 'enabled': True, 08:58:56 INFO - 'halt_on_failure': False, 08:58:56 INFO - 'name': 'check_screen_resolution'},), 08:58:56 INFO - 'run_cmd_checks_enabled': True, 08:58:56 INFO - 'suite': 'dromaeojs', 08:58:56 INFO - 'system_bits': '32', 08:58:56 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:58:56 INFO - 'title': 't-yosemite-r7-0365', 08:58:56 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:58:56 INFO - 'use_talos_json': True, 08:58:56 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:58:56 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:58:56 INFO - 'work_dir': 'build'} 08:58:56 INFO - [mozharness: 2017-03-09 16:58:56.413025Z] Running clobber step. 08:58:56 INFO - Running pre-action listener: _resource_record_pre_action 08:58:56 INFO - Running main action method: clobber 08:58:56 INFO - rmtree: /builds/slave/test/build 08:58:56 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:58:57 INFO - Running post-action listener: _resource_record_post_action 08:58:57 INFO - [mozharness: 2017-03-09 16:58:57.152568Z] Finished clobber step (success) 08:58:57 INFO - [mozharness: 2017-03-09 16:58:57.152768Z] Running read-buildbot-config step. 08:58:57 INFO - Running pre-action listener: _resource_record_pre_action 08:58:57 INFO - Running main action method: read_buildbot_config 08:58:57 INFO - Using buildbot properties: 08:58:57 INFO - { 08:58:57 INFO - "project": "", 08:58:57 INFO - "product": "firefox", 08:58:57 INFO - "script_repo_revision": "production", 08:58:57 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 08:58:57 INFO - "repository": "", 08:58:57 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 08:58:57 INFO - "buildid": "20170309072024", 08:58:57 INFO - "pgo_build": "False", 08:58:57 INFO - "basedir": "/builds/slave/test", 08:58:57 INFO - "buildnumber": 51, 08:58:57 INFO - "slavename": "t-yosemite-r7-0365", 08:58:57 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 08:58:57 INFO - "platform": "yosemite_r7", 08:58:57 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 08:58:57 INFO - "branch": "mozilla-aurora", 08:58:57 INFO - "repo_path": "releases/mozilla-aurora", 08:58:57 INFO - "revision": "3d8f875e7af5260119652056404f47e16760ea42", 08:58:57 INFO - "stage_platform": "macosx64", 08:58:57 INFO - "builduid": "d2f85c978ad44ff4ad9c25a00c43c038", 08:58:57 INFO - "slavebuilddir": "test" 08:58:57 INFO - } 08:58:57 INFO - Found installer url https://queue.taskcluster.net/v1/task/DJ2IoMlAT-aayifG8cndxQ/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg. 08:58:57 INFO - Running post-action listener: _resource_record_post_action 08:58:57 INFO - [mozharness: 2017-03-09 16:58:57.159441Z] Finished read-buildbot-config step (success) 08:58:57 INFO - [mozharness: 2017-03-09 16:58:57.159558Z] Running download-and-extract step. 08:58:57 INFO - Running pre-action listener: _resource_record_pre_action 08:58:57 INFO - Running main action method: download_and_extract 08:58:57 INFO - mkdir: /builds/slave/test/build/tests 08:58:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:58:57 INFO - trying https://queue.taskcluster.net/v1/task/DJ2IoMlAT-aayifG8cndxQ/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json 08:58:57 INFO - Downloading https://queue.taskcluster.net/v1/task/DJ2IoMlAT-aayifG8cndxQ/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 08:58:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DJ2IoMlAT-aayifG8cndxQ/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 08:58:58 INFO - Downloaded 1199 bytes. 08:58:58 INFO - Reading from file /builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json 08:58:58 INFO - Using the following test package requirements: 08:58:58 INFO - {u'common': [u'firefox-54.0a2.en-US.mac.common.tests.zip'], 08:58:58 INFO - u'cppunittest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 08:58:58 INFO - u'firefox-54.0a2.en-US.mac.cppunittest.tests.zip'], 08:58:58 INFO - u'gtest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 08:58:58 INFO - u'firefox-54.0a2.en-US.mac.gtest.tests.zip'], 08:58:58 INFO - u'jittest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 08:58:58 INFO - u'jsshell-mac.zip'], 08:58:58 INFO - u'mochitest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 08:58:58 INFO - u'firefox-54.0a2.en-US.mac.mochitest.tests.zip'], 08:58:58 INFO - u'mozbase': [u'firefox-54.0a2.en-US.mac.common.tests.zip'], 08:58:58 INFO - u'reftest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 08:58:58 INFO - u'firefox-54.0a2.en-US.mac.reftest.tests.zip'], 08:58:58 INFO - u'talos': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 08:58:58 INFO - u'firefox-54.0a2.en-US.mac.talos.tests.zip'], 08:58:58 INFO - u'web-platform': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 08:58:58 INFO - u'firefox-54.0a2.en-US.mac.web-platform.tests.zip'], 08:58:58 INFO - u'xpcshell': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 08:58:58 INFO - u'firefox-54.0a2.en-US.mac.xpcshell.tests.zip']} 08:58:58 INFO - Downloading packages: [u'firefox-54.0a2.en-US.mac.common.tests.zip'] for test suite category: common 08:58:58 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DJ2IoMlAT-aayifG8cndxQ/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip 08:58:58 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DJ2IoMlAT-aayifG8cndxQ/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip'}, attempt #1 08:58:58 INFO - Fetch https://queue.taskcluster.net/v1/task/DJ2IoMlAT-aayifG8cndxQ/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip into memory 08:59:00 INFO - Expected file size: 51777399 08:59:00 INFO - Obtained file size: 51777399 08:59:15 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 08:59:15 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DJ2IoMlAT-aayifG8cndxQ/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip 08:59:15 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DJ2IoMlAT-aayifG8cndxQ/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip'}, attempt #1 08:59:15 INFO - Fetch https://queue.taskcluster.net/v1/task/DJ2IoMlAT-aayifG8cndxQ/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip into memory 08:59:17 INFO - Expected file size: 51777399 08:59:17 INFO - Obtained file size: 51777399 08:59:33 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DJ2IoMlAT-aayifG8cndxQ/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip 08:59:33 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DJ2IoMlAT-aayifG8cndxQ/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip'}, attempt #1 08:59:33 INFO - Fetch https://queue.taskcluster.net/v1/task/DJ2IoMlAT-aayifG8cndxQ/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip into memory 08:59:34 INFO - Expected file size: 14404424 08:59:34 INFO - Obtained file size: 14404424 08:59:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:59:34 INFO - trying https://queue.taskcluster.net/v1/task/DJ2IoMlAT-aayifG8cndxQ/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 08:59:34 INFO - Downloading https://queue.taskcluster.net/v1/task/DJ2IoMlAT-aayifG8cndxQ/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg 08:59:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DJ2IoMlAT-aayifG8cndxQ/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 08:59:36 INFO - Downloaded 74616561 bytes. 08:59:36 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DJ2IoMlAT-aayifG8cndxQ/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 08:59:36 INFO - mkdir: /builds/slave/test/properties 08:59:36 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:59:36 INFO - Writing to file /builds/slave/test/properties/build_url 08:59:36 INFO - Contents: 08:59:36 INFO - build_url:https://queue.taskcluster.net/v1/task/DJ2IoMlAT-aayifG8cndxQ/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 08:59:37 INFO - Running post-action listener: _resource_record_post_action 08:59:37 INFO - Running post-action listener: set_extra_try_arguments 08:59:37 INFO - [mozharness: 2017-03-09 16:59:37.438913Z] Finished download-and-extract step (success) 08:59:37 INFO - [mozharness: 2017-03-09 16:59:37.439033Z] Running populate-webroot step. 08:59:37 INFO - Running pre-action listener: _resource_record_pre_action 08:59:37 INFO - Running main action method: populate_webroot 08:59:37 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:59:37 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:59:37 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:59:37 INFO - '--tppagecycles', 08:59:37 INFO - '7'], 08:59:37 INFO - 'tests': ['tsvgm']}}, 08:59:37 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:59:37 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:59:37 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:59:37 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:59:37 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:59:37 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:59:37 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 08:59:37 INFO - 'talos_options': ['--disable-e10s'], 08:59:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:59:37 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 08:59:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:59:37 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 08:59:37 INFO - 'talos_options': ['--disable-e10s'], 08:59:37 INFO - 'tests': ['damp', 'tps']}, 08:59:37 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 08:59:37 INFO - 'tests': ['damp', 'tps']}, 08:59:37 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:59:37 INFO - 'tests': ['dromaeo_dom']}, 08:59:37 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:59:37 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:59:37 INFO - 'tests': ['basic_compositor_video']}, 08:59:37 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:59:37 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:59:37 INFO - 'tests': ['a11yr', 08:59:37 INFO - 'ts_paint', 08:59:37 INFO - 'tpaint', 08:59:37 INFO - 'sessionrestore', 08:59:37 INFO - 'sessionrestore_no_auto_restore', 08:59:37 INFO - 'tabpaint']}, 08:59:37 INFO - 'other-e10s': {'tests': ['a11yr', 08:59:37 INFO - 'ts_paint', 08:59:37 INFO - 'tpaint', 08:59:37 INFO - 'sessionrestore', 08:59:37 INFO - 'sessionrestore_no_auto_restore', 08:59:37 INFO - 'tabpaint']}, 08:59:37 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:59:37 INFO - 'ts_paint', 08:59:37 INFO - 'tpaint', 08:59:37 INFO - 'sessionrestore', 08:59:37 INFO - 'sessionrestore_no_auto_restore', 08:59:37 INFO - 'tabpaint']}, 08:59:37 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:59:37 INFO - 'ts_paint', 08:59:37 INFO - 'tpaint', 08:59:37 INFO - 'sessionrestore', 08:59:37 INFO - 'sessionrestore_no_auto_restore', 08:59:37 INFO - 'tabpaint']}, 08:59:37 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:59:37 INFO - 'tests': ['a11yr', 08:59:37 INFO - 'ts_paint', 08:59:37 INFO - 'tpaint', 08:59:37 INFO - 'sessionrestore', 08:59:37 INFO - 'sessionrestore_no_auto_restore', 08:59:37 INFO - 'tabpaint']}, 08:59:37 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:59:37 INFO - 'tests': ['a11yr', 08:59:37 INFO - 'ts_paint', 08:59:37 INFO - 'tpaint', 08:59:37 INFO - 'sessionrestore', 08:59:37 INFO - 'sessionrestore_no_auto_restore', 08:59:37 INFO - 'tabpaint']}, 08:59:37 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:59:37 INFO - 'tests': ['tsvgx', 08:59:37 INFO - 'tsvgr_opacity', 08:59:37 INFO - 'tart', 08:59:37 INFO - 'tscrollx', 08:59:37 INFO - 'cart', 08:59:37 INFO - 'tsvg_static']}, 08:59:37 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:59:37 INFO - 'tsvgr_opacity', 08:59:37 INFO - 'tart', 08:59:37 INFO - 'tscrollx', 08:59:37 INFO - 'cart', 08:59:37 INFO - 'tsvg_static']}, 08:59:37 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 08:59:37 INFO - 'talos_options': ['--disable-e10s'], 08:59:37 INFO - 'tests': ['tp5o']}, 08:59:37 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 08:59:37 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 08:59:37 INFO - 'talos_options': ['--disable-e10s', 08:59:37 INFO - '--xperf_path', 08:59:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:59:37 INFO - 'tests': ['tp5n']}, 08:59:37 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 08:59:37 INFO - 'talos_options': ['--xperf_path', 08:59:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:59:37 INFO - 'tests': ['tp5n']}}, 08:59:37 INFO - 'talos.zip': {'path': '', 08:59:37 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:59:37 INFO - Running post-action listener: _resource_record_post_action 08:59:37 INFO - [mozharness: 2017-03-09 16:59:37.457074Z] Finished populate-webroot step (success) 08:59:37 INFO - [mozharness: 2017-03-09 16:59:37.457167Z] Running create-virtualenv step. 08:59:37 INFO - Running pre-action listener: _resource_record_pre_action 08:59:37 INFO - Running main action method: create_virtualenv 08:59:37 INFO - Creating virtualenv /builds/slave/test/build/venv 08:59:37 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 08:59:37 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:59:37 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:59:37 INFO - Using real prefix '/tools/python27' 08:59:37 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:59:38 INFO - Installing distribute.............................................................................................................................................................................................done. 08:59:41 INFO - Installing pip.................done. 08:59:41 INFO - Return code: 0 08:59:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:59:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:59:41 INFO - Reading from file tmpfile_stdout 08:59:41 INFO - Output received: 08:59:41 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) 08:59:41 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:59:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:59:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:59:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:59:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:59:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:59:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:59:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1090b1b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1090b4768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca124a2090>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108e8fd30>, '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 0x108db6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108e84be8>, '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.52n0KLSWPF/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.3nP71L5h4l/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:59:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:59:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:59:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.52n0KLSWPF/Render', 08:59:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:59:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:59:41 INFO - 'HOME': '/Users/cltbld', 08:59:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:59:41 INFO - 'LOGNAME': 'cltbld', 08:59:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:59:41 INFO - 'MOZ_NO_REMOTE': '1', 08:59:41 INFO - 'NO_EM_RESTART': '1', 08:59:41 INFO - 'PAGER': '/bin/cat', 08:59:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:59:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:59:41 INFO - 'PWD': '/builds/slave/test', 08:59:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:59:41 INFO - 'SHELL': '/bin/bash', 08:59:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3nP71L5h4l/Listeners', 08:59:41 INFO - 'TMPDIR': '/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/', 08:59:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:59:41 INFO - 'USER': 'cltbld', 08:59:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:59:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:59:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:59:41 INFO - 'XPC_FLAGS': '0x0', 08:59:41 INFO - 'XPC_SERVICE_NAME': '0', 08:59:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:59:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:59:41 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 08:59:41 INFO - Cleaning up... 08:59:41 INFO - Return code: 0 08:59:41 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:59:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:59:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:59:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:59:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:59:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:59:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:59:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1090b1b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1090b4768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca124a2090>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108e8fd30>, '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 0x108db6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108e84be8>, '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.52n0KLSWPF/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.3nP71L5h4l/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:59:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:59:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:59:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.52n0KLSWPF/Render', 08:59:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:59:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:59:41 INFO - 'HOME': '/Users/cltbld', 08:59:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:59:41 INFO - 'LOGNAME': 'cltbld', 08:59:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:59:41 INFO - 'MOZ_NO_REMOTE': '1', 08:59:41 INFO - 'NO_EM_RESTART': '1', 08:59:41 INFO - 'PAGER': '/bin/cat', 08:59:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:59:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:59:41 INFO - 'PWD': '/builds/slave/test', 08:59:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:59:41 INFO - 'SHELL': '/bin/bash', 08:59:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3nP71L5h4l/Listeners', 08:59:41 INFO - 'TMPDIR': '/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/', 08:59:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:59:41 INFO - 'USER': 'cltbld', 08:59:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:59:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:59:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:59:41 INFO - 'XPC_FLAGS': '0x0', 08:59:41 INFO - 'XPC_SERVICE_NAME': '0', 08:59:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:59:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:59:41 INFO - Downloading/unpacking psutil>=3.1.1 08:59:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:59:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:59:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:59:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:59:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:59:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:59:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:59:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:59:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:59:46 INFO - Installing collected packages: psutil 08:59:46 INFO - Running setup.py install for psutil 08:59:46 INFO - building 'psutil._psutil_osx' extension 08:59:46 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 08:59:46 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 08:59:46 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 08:59:46 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 08:59:46 INFO - building 'psutil._psutil_posix' extension 08:59:46 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 08:59:46 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 08:59:46 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 08:59:46 INFO - ^ 08:59:46 INFO - 1 warning generated. 08:59:46 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 08:59:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:59:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:59:46 INFO - Successfully installed psutil 08:59:46 INFO - Cleaning up... 08:59:47 INFO - Return code: 0 08:59:47 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:59:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:59:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:59:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:59:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:59:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:59:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:59: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1090b1b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1090b4768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca124a2090>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108e8fd30>, '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 0x108db6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108e84be8>, '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.52n0KLSWPF/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.3nP71L5h4l/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:59: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:59: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 mozsystemmonitor==0.3 08:59:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.52n0KLSWPF/Render', 08:59:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:59:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:59:47 INFO - 'HOME': '/Users/cltbld', 08:59:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:59:47 INFO - 'LOGNAME': 'cltbld', 08:59:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:59:47 INFO - 'MOZ_NO_REMOTE': '1', 08:59:47 INFO - 'NO_EM_RESTART': '1', 08:59:47 INFO - 'PAGER': '/bin/cat', 08:59:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:59:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:59:47 INFO - 'PWD': '/builds/slave/test', 08:59:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:59:47 INFO - 'SHELL': '/bin/bash', 08:59:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3nP71L5h4l/Listeners', 08:59:47 INFO - 'TMPDIR': '/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/', 08:59:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:59:47 INFO - 'USER': 'cltbld', 08:59:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:59:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:59:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:59:47 INFO - 'XPC_FLAGS': '0x0', 08:59:47 INFO - 'XPC_SERVICE_NAME': '0', 08:59:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:59:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:59:47 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:59:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:59:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:59:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:59:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:59:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:59:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:59:49 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:59:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:59:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:59:49 INFO - Installing collected packages: mozsystemmonitor 08:59:49 INFO - Running setup.py install for mozsystemmonitor 08:59:50 INFO - Successfully installed mozsystemmonitor 08:59:50 INFO - Cleaning up... 08:59:50 INFO - Return code: 0 08:59:50 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:59:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:59:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:59:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:59:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:59:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:59:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:59:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1090b1b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1090b4768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca124a2090>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108e8fd30>, '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 0x108db6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108e84be8>, '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.52n0KLSWPF/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.3nP71L5h4l/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:59:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:59:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 08:59:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.52n0KLSWPF/Render', 08:59:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:59:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:59:50 INFO - 'HOME': '/Users/cltbld', 08:59:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:59:50 INFO - 'LOGNAME': 'cltbld', 08:59:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:59:50 INFO - 'MOZ_NO_REMOTE': '1', 08:59:50 INFO - 'NO_EM_RESTART': '1', 08:59:50 INFO - 'PAGER': '/bin/cat', 08:59:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:59:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:59:50 INFO - 'PWD': '/builds/slave/test', 08:59:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:59:50 INFO - 'SHELL': '/bin/bash', 08:59:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3nP71L5h4l/Listeners', 08:59:50 INFO - 'TMPDIR': '/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/', 08:59:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:59:50 INFO - 'USER': 'cltbld', 08:59:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:59:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:59:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:59:50 INFO - 'XPC_FLAGS': '0x0', 08:59:50 INFO - 'XPC_SERVICE_NAME': '0', 08:59:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:59:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:59:50 INFO - Downloading/unpacking jsonschema==2.5.1 08:59:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:59:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:59:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:59:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:59:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:59:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:59:52 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:59:52 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:59: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 08:59: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 08:59: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 08:59: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 08:59: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 08:59: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 08:59:53 INFO - Downloading functools32-3.2.3-2.tar.gz 08:59:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:59:53 INFO - warning: no files found matching '*.txt' 08:59:53 INFO - no previously-included directories found matching 'build' 08:59:53 INFO - no previously-included directories found matching 'dist' 08:59:53 INFO - no previously-included directories found matching '.git*' 08:59:53 INFO - Installing collected packages: jsonschema, functools32 08:59:53 INFO - Running setup.py install for functools32 08:59:53 INFO - warning: no files found matching '*.txt' 08:59:53 INFO - no previously-included directories found matching 'build' 08:59:53 INFO - no previously-included directories found matching 'dist' 08:59:53 INFO - no previously-included directories found matching '.git*' 08:59:53 INFO - Successfully installed jsonschema functools32 08:59:53 INFO - Cleaning up... 08:59:53 INFO - Return code: 0 08:59:53 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:59:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:59:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:59:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:59:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:59:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:59:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:59:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1090b1b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1090b4768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca124a2090>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108e8fd30>, '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 0x108db6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108e84be8>, '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.52n0KLSWPF/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.3nP71L5h4l/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:59:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 08:59:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 08:59:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.52n0KLSWPF/Render', 08:59:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:59:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:59:53 INFO - 'HOME': '/Users/cltbld', 08:59:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:59:53 INFO - 'LOGNAME': 'cltbld', 08:59:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:59:53 INFO - 'MOZ_NO_REMOTE': '1', 08:59:53 INFO - 'NO_EM_RESTART': '1', 08:59:53 INFO - 'PAGER': '/bin/cat', 08:59:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:59:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:59:53 INFO - 'PWD': '/builds/slave/test', 08:59:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:59:53 INFO - 'SHELL': '/bin/bash', 08:59:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3nP71L5h4l/Listeners', 08:59:53 INFO - 'TMPDIR': '/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/', 08:59:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:59:53 INFO - 'USER': 'cltbld', 08:59:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:59:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:59:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:59:53 INFO - 'XPC_FLAGS': '0x0', 08:59:53 INFO - 'XPC_SERVICE_NAME': '0', 08:59:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:59:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:59:54 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:59:54 INFO - Cleaning up... 08:59:54 INFO - Return code: 0 08:59:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:59:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:59:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:59:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:59:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:59:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:59:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:59:54 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 0x1090b1b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1090b4768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca124a2090>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108e8fd30>, '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 0x108db6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108e84be8>, '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.52n0KLSWPF/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.3nP71L5h4l/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:59:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:59:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:59:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.52n0KLSWPF/Render', 08:59:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:59:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:59:54 INFO - 'HOME': '/Users/cltbld', 08:59:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:59:54 INFO - 'LOGNAME': 'cltbld', 08:59:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:59:54 INFO - 'MOZ_NO_REMOTE': '1', 08:59:54 INFO - 'NO_EM_RESTART': '1', 08:59:54 INFO - 'PAGER': '/bin/cat', 08:59:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:59:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:59:54 INFO - 'PWD': '/builds/slave/test', 08:59:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:59:54 INFO - 'SHELL': '/bin/bash', 08:59:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3nP71L5h4l/Listeners', 08:59:54 INFO - 'TMPDIR': '/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/', 08:59:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:59:54 INFO - 'USER': 'cltbld', 08:59:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:59:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:59:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:59:54 INFO - 'XPC_FLAGS': '0x0', 08:59:54 INFO - 'XPC_SERVICE_NAME': '0', 08:59:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:59:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:59:54 INFO - Downloading/unpacking blobuploader==1.2.4 08:59:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:59:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:59:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:59:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:59:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:59:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:59:56 INFO - Downloading blobuploader-1.2.4.tar.gz 08:59:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:59:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:59:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:59:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:59:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:59:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:59:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:59:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:59:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:59:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:59:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:59:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:59:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:59:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:59:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:59:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:59:58 INFO - Downloading docopt-0.6.1.tar.gz 08:59:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:59:58 INFO - Installing collected packages: blobuploader, requests, docopt 08:59:58 INFO - Running setup.py install for blobuploader 08:59:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:59:58 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:59:58 INFO - Running setup.py install for requests 08:59:58 INFO - Running setup.py install for docopt 08:59:59 INFO - Successfully installed blobuploader requests docopt 08:59:59 INFO - Cleaning up... 08:59:59 INFO - Return code: 0 08:59:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:59:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:59:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:59:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:59:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:59:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:59:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:59:59 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 0x1090b1b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1090b4768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca124a2090>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108e8fd30>, '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 0x108db6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108e84be8>, '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.52n0KLSWPF/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.3nP71L5h4l/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:59:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:59:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:59:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.52n0KLSWPF/Render', 08:59:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:59:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:59:59 INFO - 'HOME': '/Users/cltbld', 08:59:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:59:59 INFO - 'LOGNAME': 'cltbld', 08:59:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:59:59 INFO - 'MOZ_NO_REMOTE': '1', 08:59:59 INFO - 'NO_EM_RESTART': '1', 08:59:59 INFO - 'PAGER': '/bin/cat', 08:59:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:59:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:59:59 INFO - 'PWD': '/builds/slave/test', 08:59:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:59:59 INFO - 'SHELL': '/bin/bash', 08:59:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3nP71L5h4l/Listeners', 08:59:59 INFO - 'TMPDIR': '/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/', 08:59:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:59:59 INFO - 'USER': 'cltbld', 08:59:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:59:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:59:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:59:59 INFO - 'XPC_FLAGS': '0x0', 08:59:59 INFO - 'XPC_SERVICE_NAME': '0', 08:59:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:59:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:59:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:59:59 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-oK0xHa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:59:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:59:59 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-M2fl0p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:59:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:59:59 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-nyk9Sk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:59:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:59:59 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-a6eYGp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:59:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:59:59 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-V_5i6a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:59:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:59:59 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-0q1l2O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:00:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:00:00 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-mYR3ep-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:00:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:00:00 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-WrcVNT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:00:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:00:00 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-BSy4LH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:00:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:00:00 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-RcoLhz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:00:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:00:00 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-Pxjd5T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:00:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:00:00 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-KjnImj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:00:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:00:00 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-HC5Xl4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:00:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:00:00 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-LmzlMU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:00:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:00:00 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-x97YCC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:00:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:00:00 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-aeZ9mI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:00:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:00:01 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-LuIO5I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:00:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:00:01 INFO - Running setup.py install for manifestparser 09:00:01 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:00:01 INFO - Running setup.py install for mozcrash 09:00:01 INFO - Running setup.py install for mozdebug 09:00:01 INFO - Running setup.py install for mozdevice 09:00:01 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:00:01 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:00:01 INFO - Running setup.py install for mozfile 09:00:01 INFO - Running setup.py install for mozhttpd 09:00:02 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:00:02 INFO - Running setup.py install for mozinfo 09:00:02 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:00:02 INFO - Running setup.py install for mozInstall 09:00:02 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:00:02 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:00:02 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:00:02 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:00:02 INFO - Running setup.py install for mozleak 09:00:02 INFO - Running setup.py install for mozlog 09:00:02 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:00:02 INFO - Running setup.py install for moznetwork 09:00:02 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:00:02 INFO - Running setup.py install for mozprocess 09:00:02 INFO - Running setup.py install for mozprofile 09:00:03 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:00:03 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:00:03 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:00:03 INFO - Running setup.py install for mozrunner 09:00:03 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:00:03 INFO - Running setup.py install for mozscreenshot 09:00:03 INFO - Running setup.py install for moztest 09:00:03 INFO - Running setup.py install for mozversion 09:00:03 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:00:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:00:03 INFO - Cleaning up... 09:00:03 INFO - Return code: 0 09:00:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:00:03 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:00:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:00:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:00:03 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:00:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:00:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:00:03 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 0x1090b1b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1090b4768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca124a2090>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108e8fd30>, '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 0x108db6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108e84be8>, '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.52n0KLSWPF/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.3nP71L5h4l/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/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:00:03 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:00:03 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:00:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.52n0KLSWPF/Render', 09:00:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:00:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:00:03 INFO - 'HOME': '/Users/cltbld', 09:00:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:00:03 INFO - 'LOGNAME': 'cltbld', 09:00:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:00:03 INFO - 'MOZ_NO_REMOTE': '1', 09:00:03 INFO - 'NO_EM_RESTART': '1', 09:00:03 INFO - 'PAGER': '/bin/cat', 09:00:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:00:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:00:03 INFO - 'PWD': '/builds/slave/test', 09:00:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:00:03 INFO - 'SHELL': '/bin/bash', 09:00:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3nP71L5h4l/Listeners', 09:00:03 INFO - 'TMPDIR': '/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/', 09:00:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:00:03 INFO - 'USER': 'cltbld', 09:00:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:00:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:00:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:00:03 INFO - 'XPC_FLAGS': '0x0', 09:00:03 INFO - 'XPC_SERVICE_NAME': '0', 09:00:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:00:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:00:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:00:04 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-cejCyB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:00:04 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:00:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:00:04 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-cSn828-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:00:04 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:00:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:00:04 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-KWOmZ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:00:04 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:00:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:00:04 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-lmBIV7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:00:04 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:00:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:00:04 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-GT8iDB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:00:04 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:00:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:00:04 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-rT0xdy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:00:04 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:00:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:00:04 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-uLK3Ys-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:00:04 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:00:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:00:04 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-q5xHfz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:00:04 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:00:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:00:04 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-0ERyh3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:00:05 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:00:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:00:05 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-a641Hw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:00:05 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:00:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:00:05 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-W3NqKl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:00:05 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:00:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:00:05 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-Zl3du8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:00:05 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:00:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:00:05 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-Vw6BUV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:00:05 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:00:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:00:05 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-N9sm2n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:00:05 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:00:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:00:05 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-92Do4Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:00:05 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:00:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:00:05 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-tAzCWZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:00:05 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:00:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:00:05 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-HR2SeX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:00:05 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:00:05 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:00:05 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:00:05 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:00:05 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:00:05 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:00:05 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:00:05 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:00:05 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:00:05 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:00:05 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:00:05 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:00:05 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:00:08 INFO - Downloading blessings-1.6.tar.gz 09:00:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:00:08 INFO - Installing collected packages: blessings 09:00:08 INFO - Running setup.py install for blessings 09:00:08 INFO - Successfully installed blessings 09:00:08 INFO - Cleaning up... 09:00:08 INFO - Return code: 0 09:00:08 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:00:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:00:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:00:09 INFO - Reading from file tmpfile_stdout 09:00:09 INFO - Current package versions: 09:00:09 INFO - blessings == 1.6 09:00:09 INFO - blobuploader == 1.2.4 09:00:09 INFO - docopt == 0.6.1 09:00:09 INFO - functools32 == 3.2.3-2 09:00:09 INFO - jsonschema == 2.5.1 09:00:09 INFO - manifestparser == 1.1 09:00:09 INFO - mozInstall == 1.12 09:00:09 INFO - mozcrash == 1.0 09:00:09 INFO - mozdebug == 0.1 09:00:09 INFO - mozdevice == 0.49 09:00:09 INFO - mozfile == 1.2 09:00:09 INFO - mozhttpd == 0.7 09:00:09 INFO - mozinfo == 0.9 09:00:09 INFO - mozleak == 0.1 09:00:09 INFO - mozlog == 3.4 09:00:09 INFO - moznetwork == 0.27 09:00:09 INFO - mozprocess == 0.25 09:00:09 INFO - mozprofile == 0.28 09:00:09 INFO - mozrunner == 6.13 09:00:09 INFO - mozscreenshot == 0.1 09:00:09 INFO - mozsystemmonitor == 0.3 09:00:09 INFO - moztest == 0.8 09:00:09 INFO - mozversion == 1.4 09:00:09 INFO - psutil == 3.1.1 09:00:09 INFO - requests == 1.2.3 09:00:09 INFO - wsgiref == 0.1.2 09:00:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:00:09 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:00:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:00:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:00:09 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:00:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:00:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:00:09 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 0x1090b1b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1090b4768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca124a2090>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108e8fd30>, '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 0x108db6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108e84be8>, '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.52n0KLSWPF/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.3nP71L5h4l/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/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:00:09 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:00:09 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:00:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.52n0KLSWPF/Render', 09:00:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:00:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:00:09 INFO - 'HOME': '/Users/cltbld', 09:00:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:00:09 INFO - 'LOGNAME': 'cltbld', 09:00:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:00:09 INFO - 'MOZ_NO_REMOTE': '1', 09:00:09 INFO - 'NO_EM_RESTART': '1', 09:00:09 INFO - 'PAGER': '/bin/cat', 09:00:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:00:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:00:09 INFO - 'PWD': '/builds/slave/test', 09:00:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:00:09 INFO - 'SHELL': '/bin/bash', 09:00:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3nP71L5h4l/Listeners', 09:00:09 INFO - 'TMPDIR': '/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/', 09:00:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:00:09 INFO - 'USER': 'cltbld', 09:00:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:00:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:00:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:00:09 INFO - 'XPC_FLAGS': '0x0', 09:00:09 INFO - 'XPC_SERVICE_NAME': '0', 09:00:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:00:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:00:09 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:00:09 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:00:09 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:00:09 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:00:09 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:00:09 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:00:09 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:00:09 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:00:09 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:00:09 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:00:09 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:00:09 INFO - Cleaning up... 09:00:09 INFO - Return code: 0 09:00:09 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:00:09 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:00:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:00:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:00:09 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:00:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:00:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:00:09 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 0x1090b1b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1090b4768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca124a2090>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108e8fd30>, '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 0x108db6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108e84be8>, '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.52n0KLSWPF/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.3nP71L5h4l/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/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:00:09 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:00:09 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:00:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.52n0KLSWPF/Render', 09:00:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:00:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:00:09 INFO - 'HOME': '/Users/cltbld', 09:00:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:00:09 INFO - 'LOGNAME': 'cltbld', 09:00:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:00:09 INFO - 'MOZ_NO_REMOTE': '1', 09:00:09 INFO - 'NO_EM_RESTART': '1', 09:00:09 INFO - 'PAGER': '/bin/cat', 09:00:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:00:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:00:09 INFO - 'PWD': '/builds/slave/test', 09:00:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:00:09 INFO - 'SHELL': '/bin/bash', 09:00:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3nP71L5h4l/Listeners', 09:00:09 INFO - 'TMPDIR': '/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/', 09:00:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:00:09 INFO - 'USER': 'cltbld', 09:00:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:00:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:00:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:00:09 INFO - 'XPC_FLAGS': '0x0', 09:00:09 INFO - 'XPC_SERVICE_NAME': '0', 09:00:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:00:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:00:09 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:00:09 INFO - Cleaning up... 09:00:09 INFO - Return code: 0 09:00:09 INFO - Running post-action listener: _resource_record_post_action 09:00:09 INFO - Running post-action listener: _start_resource_monitoring 09:00:09 INFO - Starting resource monitoring. 09:00:09 INFO - [mozharness: 2017-03-09 17:00:09.725228Z] Finished create-virtualenv step (success) 09:00:09 INFO - [mozharness: 2017-03-09 17:00:09.726217Z] Running install step. 09:00:09 INFO - Running pre-action listener: _resource_record_pre_action 09:00:09 INFO - Running main action method: install 09:00:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:00:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:00:09 INFO - Reading from file tmpfile_stdout 09:00:09 INFO - Detecting whether we're running mozinstall >=1.0... 09:00:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:00:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:00:10 INFO - Reading from file tmpfile_stdout 09:00:10 INFO - Output received: 09:00:10 INFO - Usage: mozinstall [options] installer 09:00:10 INFO - Options: 09:00:10 INFO - -h, --help show this help message and exit 09:00:10 INFO - -d DEST, --destination=DEST 09:00:10 INFO - Directory to install application into. [default: 09:00:10 INFO - "/builds/slave/test"] 09:00:10 INFO - --app=APP Application being installed. [default: firefox] 09:00:10 INFO - mkdir: /builds/slave/test/build/application 09:00:10 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:00:10 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:00:30 INFO - Reading from file tmpfile_stdout 09:00:30 INFO - Output received: 09:00:30 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 09:00:30 INFO - Running post-action listener: _resource_record_post_action 09:00:30 INFO - [mozharness: 2017-03-09 17:00:30.007380Z] Finished install step (success) 09:00:30 INFO - [mozharness: 2017-03-09 17:00:30.007534Z] Running run-tests step. 09:00:30 INFO - Running pre-action listener: _resource_record_pre_action 09:00:30 INFO - Running main action method: run_tests 09:00:30 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:00:30 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:00:30 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:00:30 INFO - 2017-03-09 09:00:30.022 screenresolution[6480:120521] starting screenresolution argv=screenresolution get 09:00:30 INFO - 2017-03-09 09:00:30.025 screenresolution[6480:120521] Display 0: 1600x1200x32@60 09:00:30 INFO - 2017-03-09 09:00:30.030 screenresolution[6481:120524] starting screenresolution argv=screenresolution list 09:00:30 INFO - Available Modes on Display 0 09:00:30 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:00:30 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:00:30 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:00:30 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:00:30 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:00:30 INFO - Intel Iris: 09:00:30 INFO - Chipset Model: Intel Iris 09:00:30 INFO - Type: GPU 09:00:30 INFO - Bus: Built-In 09:00:30 INFO - VRAM (Dynamic, Max): 1536 MB 09:00:30 INFO - Vendor: Intel (0x8086) 09:00:30 INFO - Device ID: 0x0a2e 09:00:30 INFO - Revision ID: 0x0009 09:00:30 INFO - Displays: 09:00:30 INFO - Display: 09:00:30 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:00:30 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:00:30 INFO - Display Serial Number: 1600x1200 60 09:00:30 INFO - Main Display: Yes 09:00:30 INFO - Mirror: Off 09:00:30 INFO - Online: Yes 09:00:30 INFO - Rotation: Supported 09:00:30 INFO - Return code: 0 09:00:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:00:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:00:30 INFO - Python 2.7.3 09:00:30 INFO - Return code: 0 09:00:30 INFO - grabbing minidump binary from tooltool 09:00:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:00:30 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 0x108e8fd30>, '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 0x108db6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108e84be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:00:30 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:00:30 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:00:30 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:00:30 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:00:30 INFO - Return code: 0 09:00:30 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 09:00:30 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:00:30 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:00:30 INFO - ENV: RUST_BACKTRACE is now 1 09:00:30 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 09:00:30 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:00:30 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/DJ2IoMlAT-aayifG8cndxQ/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0365', '--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:00:30 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/DJ2IoMlAT-aayifG8cndxQ/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0365 --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:00:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.52n0KLSWPF/Render', 09:00:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:00:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:00:30 INFO - 'HOME': '/Users/cltbld', 09:00:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:00:30 INFO - 'LOGNAME': 'cltbld', 09:00:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:00:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 09:00:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:00:30 INFO - 'MOZ_NO_REMOTE': '1', 09:00:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:00:30 INFO - 'NO_EM_RESTART': '1', 09:00:30 INFO - 'PAGER': '/bin/cat', 09:00:30 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:00:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:00:30 INFO - 'PWD': '/builds/slave/test', 09:00:30 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:00:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:00:30 INFO - 'RUST_BACKTRACE': '1', 09:00:30 INFO - 'SHELL': '/bin/bash', 09:00:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3nP71L5h4l/Listeners', 09:00:30 INFO - 'TMPDIR': '/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/', 09:00:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:00:30 INFO - 'USER': 'cltbld', 09:00:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:00:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:00:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:00:30 INFO - 'XPC_FLAGS': '0x0', 09:00:30 INFO - 'XPC_SERVICE_NAME': '0', 09:00:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:00:30 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/DJ2IoMlAT-aayifG8cndxQ/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0365', '--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:00:30 INFO - mozversion application_buildid: 20170309072024 09:00:30 INFO - mozversion application_changeset: 3d8f875e7af5260119652056404f47e16760ea42 09:00:30 INFO - mozversion application_display_name: FirefoxDeveloperEdition 09:00:30 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:00:30 INFO - mozversion application_name: Firefox 09:00:30 INFO - mozversion application_remotingname: firefox-dev 09:00:30 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:00:30 INFO - mozversion application_vendor: Mozilla 09:00:30 INFO - mozversion application_version: 54.0a2 09:00:30 INFO - mozversion platform_buildid: 20170309072024 09:00:30 INFO - mozversion platform_changeset: 3d8f875e7af5260119652056404f47e16760ea42 09:00:30 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:00:30 INFO - mozversion platform_version: 54.0a2 09:00:30 INFO - using testdate: 1489078830 09:00:30 INFO - actual date: 1489078830 09:00:30 INFO - starting webserver on 'localhost:56995' 09:00:30 INFO - SUITE-START | Running 2 tests 09:00:30 INFO - TEST-START | dromaeo_css 09:00:30 INFO - operating with platform_type : mac_ 09:00:30 INFO - Initialising browser for dromaeo_css test... 09:00:30 INFO - TEST-INFO | started process 6491 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/tmpHAbMAW/profile http://localhost:56995/getInfo.html) 09:00:33 INFO - PROCESS | 6491 | __metrics Screen width/height:1600/1200 09:00:33 INFO - PROCESS | 6491 | colorDepth:24 09:00:33 INFO - PROCESS | 6491 | Browser inner width/height: 1024/689 09:00:33 INFO - PROCESS | 6491 | __metrics 09:00:33 INFO - PROCESS | 6491 | 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:00:33 INFO - PROCESS | 6491 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:00:34 INFO - TEST-INFO | 6491: exit 0 09:00:34 INFO - Browser initialized. 09:00:34 INFO - Running cycle 1/1 for dromaeo_css test... 09:00:34 INFO - TEST-INFO | started process 6494 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/tmpHAbMAW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:00:46 INFO - PROCESS | 6494 | RSS: Main: 214347776 09:00:46 INFO - PROCESS | 6494 | 09:03:50 INFO - PROCESS | 6494 | Cycle 1(1): loaded http://localhost:56995/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56995/tests/dromaeo/cssquery-ext.html) 09:03:53 INFO - PROCESS | 6494 | RSS: Main: 420118528 09:03:53 INFO - PROCESS | 6494 | 09:05:36 INFO - PROCESS | 6494 | ************************* 09:05:36 INFO - PROCESS | 6494 | A coding exception was thrown and uncaught in a Task. 09:05:36 INFO - PROCESS | 6494 | 09:05:36 ERROR - PROCESS | 6494 | Full message: TypeError: NetworkError when attempting to fetch resource. 09:05:36 INFO - PROCESS | 6494 | Full stack: 09:05:36 INFO - PROCESS | 6494 | ************************* 09:06:56 INFO - PROCESS | 6494 | Cycle 1(1): loaded http://localhost:56995/tests/dromaeo/cssquery-ext.html (next: http://localhost:56995/tests/dromaeo/cssquery-jquery.html) 09:06:57 INFO - PROCESS | 6494 | RSS: Main: 351481856 09:06:57 INFO - PROCESS | 6494 | 09:09:59 INFO - PROCESS | 6494 | Cycle 1(1): loaded http://localhost:56995/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56995/tests/dromaeo/cssquery-mootools.html) 09:10:00 INFO - PROCESS | 6494 | RSS: Main: 334614528 09:10:00 INFO - PROCESS | 6494 | 09:13:02 INFO - PROCESS | 6494 | Cycle 1(1): loaded http://localhost:56995/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56995/tests/dromaeo/cssquery-prototype.html) 09:13:03 INFO - PROCESS | 6494 | RSS: Main: 343977984 09:13:03 INFO - PROCESS | 6494 | 09:16:06 INFO - PROCESS | 6494 | Cycle 1(1): loaded http://localhost:56995/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56995/tests/dromaeo/cssquery-yui.html) 09:16:07 INFO - PROCESS | 6494 | RSS: Main: 321998848 09:16:07 INFO - PROCESS | 6494 | 09:19:10 INFO - PROCESS | 6494 | Cycle 1(1): loaded http://localhost:56995/tests/dromaeo/cssquery-yui.html (next: http://localhost:56995/tests/dromaeo/cssquery-dojo.html) 09:19:10 INFO - PROCESS | 6494 | RSS: Main: 486858752 09:19:10 INFO - PROCESS | 6494 | 09:19:10 INFO - PROCESS | 6494 | __start_tp_report 09:19:10 INFO - PROCESS | 6494 | _x_x_mozilla_page_load 09:19:10 INFO - PROCESS | 6494 | _x_x_mozilla_page_load_details 09:19:10 INFO - PROCESS | 6494 | |i|pagename|runs| 09:19:10 INFO - PROCESS | 6494 | |0;dojo.html;3122.7501799856013;3425.880094196703;3428.8799892003785;3456.3778519866446;3482.164280572662;6076;6099.939000609993;6136.969315153424;6137.570370074097;6151.292601350846;6102.17620621216;6119.204503414561;6146.170267013952;6153.569250152491;6166.229221347332;4826.155422801014;5398.217258497515;5469.5624350052;5473.233747275384;5510.779568817263;5388.649737767033;5394.514493695567;5433.8369848904595;5587.7485513152005;5603.831885043455;5467.562594992411;5501.174823776446;5513.476219759116;5517.724113794295;5524.309461317335;5497.505224529771;5500.064988951888;5506.366767821692;5507.614466987313;5513.42109078547;5317.787288508455;5426.996005738951;5438.782448702047;5439.5376393006645;5481.177823326493;5420.485053919911;5757.740901659436;6094.259734851126;6094.380596348918;6113.780377411019;6350.301466838644;6363;6363.93636063638;6380.138681278061;6387.361263873576;6381.234251889757;6406.199225096863;6503.512236582275;6551.344865513458;6589.472842172615;6153.907691384633;6211.68941552925;6214.130021796952;6228.781992630236;6260.405261500196;6391.616503009835;6409.070684750685;6647.76732814354;6688;6712.295209003082;6191.504679625619;6318.652474113968;6355.872882542416;6375.968120159369;6378.075179099097;5492.780288788484;6212.347703491068;6413.29453760086;6450.741970321228;6500;6446.8388290293115;6461.709223084972;6466.191726034246;6467.965125579884;6472.417482426604;6306.747730090745;6464.159659244362;6470.6441145737435;6487.935120648733;6566.934330656728;4387.166438376698;5200.92198617021;5208.296879921162;5212.035773381936;5212.452692467312;4643.489216186217;4659.324397962277;4669.322948172496;4672.976635116803;4684.742339171378;5968.731407086691;5971.820845374646;6006.309274433409;6028.758849645965;6038.18484504595;5318.521333080042;6354.936450635527;6377.808665740035;6378.617282962944;6495.805125846137;6149.938500614937;6153.98459254227;6154.323024467305;6160.815175544741;6161.199044124325;5764.596478246483;5767.942320576741;5773.422657734193;5789;5795.246617939725;6437.645929473737;6515.902261466176;6564.704588293443;6736.92209246528;6783.830404239835;6387.457066149429;6397.424231819158;6397.96801015992;6401.423871851555;6406.871862562816;6591.34086591337;6716.496262780409;6735.49483788708;6763.695633696397;6769.1876974763345;6491.05879647439;6491.4806815455595;6491.772787952399;6494.058361537645;6500.414962653384;6284.371562843679;6536.803895883131;6569.835754106186;6571.605703657605;6586.70359833799;6183.258009038944;6277.121203031488;6313.08460273267;6322.209723784527;6322.8735425290315;6233.906491402542;6256;6295.5907865988565;6308.053791931247;6362.204724409449;6300.243970723543;6333.113364128933;6334.303226645157;6348.523860710373;6355.173827402408;6376.489880809617;6381.904271436025;6392.488600911823;6414.166158399378;6440.162778838721;6047.516198704181;6106.816795496142;6138.478229350555;6141.9078713818435;6152.200213972155 09:19:10 INFO - PROCESS | 6494 | |1;ext.html;699.3740602161066;819.4386845011165;860.6385318166369;882.3691060891462;887.800244944887;38183.23633527328;38816.5065144137;39118.804405977964;39289.41065884014;40625.39061914074;39919.600803991954;40092;40160.598394016124;40217.798911005404;40226.99432514189;7226.241244669287;7383.298586634288;9029.593668284926;9176.403533770317;9194.77013074675;7329;7424.220456852034;7433.851322973537;10588.31175973563;10853.24027318088;10847.783044339109;10867.945660271727;10871.782564348709;10881;10881.347119172835;10756.78486430271;10811.297265677746;10846.132309415307;10847.132229421628;10868;7140.214576396592;7317.817054573625;7374.410047196211;10570.101541368993;10628.521716522775;27067.864660676572;27182.184534464;38686.032849178715;39284.60715392838;40654.79672601647;3836.9040773980596;3890.6692931100893;3920.980395098035;3939.684825213976;3968.603139686037;26599.20202393912;26917.596236056474;27427.862860685567;28088.719112808816;28574.857125714447;3090.2892334763133;3107.1455349778767;3107.7513798896034;3125.2811853273647;3132.4518209313505;329469;329760;330533;330602;330928.3453582765;40190.397144042865;43415.565844341785;49190.75404623026;49305.75347123241;50683;45274.54725452703;45847.541524584994;49968.50031499711;54850.72574637101;54915.45084549183;13373;13408.932955335356;13411;13415;13429.865701343057;11534.826977595343;11579.363135027654;11591.6522504325;11592.95663390299;11615.36115513638;12376;12391;12432.316222607662;12433.93783031079;12574.622761317176;5372.865678358073;5377.4084850666395;5412.648177868426;5422.75597598109;5423.376311724202;938.1509733691021;957.760559860035;965.3532133470451;972.9951350243346;990.6780296403554;24714.629280560806;24916.252512424657;27530.587041194398;28384.43231135407;28915.855420723183;1038.1331588124;1051;1060.5015642647943;1067.546292825546;1072.8980746829038;11359.716007099723;14181.503647372292;14678.54241326212;14898.776518352233;14902.627434314229;485224;496939;594023;594863;597644;38822;39803.40294895579;43898;44079.559204408186;44085.33871991923;1356.959291221265;1396.7765157574738;1403.0809819568199;1404.8665376789188;1408;21574.13703451907;22931.426714332276;24347.39131521726;24629.768511574708;25011.374715632253;36463.81768091142;36593.81703091467;37027.62972370242;39279;39927.00182495461;463808;466964;467009;467814.965551034;467863;27437.039703610277;27466.313342166606;27513.587296190173;27602;27604.619769011068;34433.31133377268;34829.30341393107;35249.82375088108;36008.81995590005;36013.45979810252;29098.418031638827;29281.41437171287;30369;30588.847055764578;30627.846860765552;29037;29297;29638.555421669123;29838.85080574583;30103;27710;30205.546916795825;30659.926902559197;30718.539221911244;30887;24910.750892490843;26791;26931.92272309164;27358.059063338653;27436.451270974867;15993.360265589246;21180.03328119669;21278.893605531874;21364.572708546053;21410.25064122748 09:19:10 INFO - PROCESS | 6494 | |2;jquery.html;382.80285652888784;427.2181907109988;429.6562749800159;431.1619432812187;441.8431456832822;15597.298121584528;20546.820987500803;21562.245321413753;22015.22946696866;22318.55362892743;19977.200911963504;20469.283575074875;20945.47636309093;21003.894980525114;21265.574688506258;5480.671159730409;5867.442592953663;6265.906011409833;6541.640209788459;6543.083968244449;6283.340249273829;6411.48708103353;6417;6480.837979050514;6483.4489068429;6480.287168411471;6485.994670826006;6873.621950792704;7123.750668726596;7341.669624866867;7030.718771249144;7240.094988126484;7314.012608297865;7348.706051757923;7357.889631655529;5914.9112763308585;7096.822579435504;7111.146662400493;7111.288871112899;7128.0377149084725;23876.40308992272;24315.635265470853;24673.383165421008;25056;25082.498350032896;3256.2022304535303;3290.802551846873;3301.636819949804;3345.2974875276223;3519.2961407718303;14941.551753447415;15460.304286307142;15484.07095574269;15492.070475771377;16064.875458717894;1650.678117767036;1915.205189846212;1994.1724184463576;2015.1637070615677;2048.805363490466;162744;163782.3621763779;164763;169538;176478.1176094124;14533.539890023461;18882.905585471985;19495.707564386546;19771.703424448646;19839.801601984083;29642;30845.383092338026;31009;31105.53341699831;31133.066008019796;8293.33653307734;8659.696910608098;8664.566771661392;9200.585973631069;9477.28920330978;7649.120351159577;7982.481138725964;8002.919970800334;8019.599020048974;8094.878576821352;8923.955380223188;9066.902721761719;9225.616157576284;9235.445873247627;9238.013827027222;3953.7627742335553;3985.70107241958;4000.7599544027453;4012.6990475714438;4019.437278780973;872.6422166911536;885.8361203177433;888;913.9588718507683;924.4453328003278;20165.899170504053;20595.794042059388;20678.276260330815;20679.27622533204;21023.78976210249;714.3927661487694;910.6630546697631;915.4919019943862;929.4980710416299;930.6463543853292;10220.693379198636;10531;10601.734956626146;10609.257351985287;10639.468026598639;701239;753244;761078;762518;774285;136232;152988;157326;159044;164525.17737411236;1142.714321419645;1154.5324143721807;1179.6402097360217;1181.5510106159777;1185.454690842205;16740.91629541893;17546.21042053085;17860.928344299384;17980.460586182435;18108.185131668844;59875.26817342748;62158.689206555486;62293.37706623057;62988;63936.68031659812;88163.55918220368;88190;88625;90899;91005;10536.57853685844;10821.080208182393;11162.102442584943;11173.553057877594;11366.033887119687;12381.133320667466;12422.875771242534;12605.558805441766;12755.808662869878;12784.360781961052;10893;10897.564097436014;10963.616273430393;10981.462595236833;11025.338479691245;9933;10109.595616175271;10658.786824263316;10733.355998640107;10821.891781082088;10366.378017318984;10563.20775941792;10938.562457501928;11168.106551476025;11203.271787333797;10717.624883129052;10762.46187690628;10865;11082.833757493805;11128.721781955515;10442.63450779219;10520.894791051991;10684.41235732011;10691.465426728788;10701.304415212986 09:19:10 INFO - PROCESS | 6494 | |3;mootools.html;1377.973409809692;1539.222692540267;1543.9845601543982;1563.7185306644799;1573.1033311012723;10629.04338609525;11193.776124477505;11203.66389008329;11213.383263920481;11228.943855280722;10594.576216951333;10876.945615271932;10964.396958167297;11079.335239885613;11107.666769996913;2312.7918487336137;2347.495288512969;2352.6353415220583;2353.3881190890406;2353.9176128835493;1970.448274483147;1993.6112458070681;2046.6827641715558;2247.6179049561615;2303.7005189325364;2286.131270117353;2288.7711228877147;2319.6288593824993;2320.153144102407;2326.5230627721276;1894.355918987551;2280.680704701335;2284.668723035167;2284.7029886114697;2296.7932886040253;2260.5365899990625;2321.442853715113;2322.2452702871633;2325.186184835311;2330.1727886600183;10950.959658832398;10982.670519884416;10984.835227471594;10987.560497580087;10991.505382257817;4609.147307748044;5581.832545023656;5614.663120212759;5621.156826476021;5623.212750214973;3262.4780035194253;3368.6294507604143;3536.504889315498;3538.292341531704;3541.557305336833;1213.7936550786387;1214.2471667566076;1784.5895444047942;1802.7295905614133;1899.259288877339;13087.88752956;15269.694606107816;15368.692626147415;15596.98619589723;15597.76603350962;4348.760818154969;4449.28811390176;4466.218411777926;4580.427446569179;4586.908261834745;11426.08591312693;11436.313821170756;11442.199046066862;11442.94278528602;11443.485043173077;5513.393526712059;5515.310586176728;5516.227728118067;5518.089515230023;5530.917036244459;4929.679570827885;5037.823676171316;5098.872528186825;5114.951434955825;5123.795048198031;3663.670269675742;3714.257148570297;3744.0826997385816;3772.0946972726897;3792.867249646249;956.7177682583655;967.4292167621137;972.1348000279756;982.1749730226501;986.3292960786733;912.5346073502561;920.5354032940187;922.6586163119689;937.1799675284126;980.0738302304254;6370.968145159244;6455.902496575593;6462.741490340428;6480.222373315232;6540.411362977355;945.2438049560325;956.2923436656824;964.3297907953905;964.782923842144;966.917811985975;3947.6644485219076;4093.672506199497;4219.683523735732;4231.322988321916;4243.087736136684;11592.492975913077;13588.660283492993;13711.314434278247;13711.794323085162;13715.451381944611;11979;13309.201447912963;13648;13657.726845463234;13897.930510347383;8106.513609183467;8892;9062.909370906207;9200.723978280663;10081.193504519768;6233.933480274364;6494.415502604788;6642.933570664231;6665.766698165541;6769.255381907888;12117.030637548798;12157.69605759863;12340.629781106582;12378.81431778506;12381;12255.877441225473;12388.256704597752;12588;12687.30219837881;12789.104762666524;8384.832303353776;8459.788505287417;8466.238038576557;8545.700900468453;8566.05773364917;10097.141742951932;10111.24165687591;10220.744481388025;10231.539580718736;10243;8796.340274479311;8932;9014.549272536216;9014.684486042957;9049;8690.435121717068;8740.388172827841;8761.605727742139;8804.911950880409;8986.14631609996;7677.769666910001;7840.215978402342;7846.725364612211;7847.764567062997;7849.411294153076;5653.660780353028;5666.2350582670815;5712.942870571241;5836.416358364129;5879.823605291848;5589;5652.63257888236;5831.970840145772;5895.587308888336;6048.969755151196 09:19:10 INFO - PROCESS | 6494 | |4;prototype.html;347.05600765916705;368.6654311392759;383.2660455228236;385.0969476577425;387.56979752474746;4871.342368780213;4955.4548999610015;5099.949000509994;5133.768980395882;5198;4227.682923780713;5006.824761133361;5020.573251273646;5025.3467049283545;5093.770780314885;4192.448793946244;4194.958050419503;4241.27898257297;4270.423492828475;4281.636060934817;3996.840126394941;4005.299072662287;4033.2740106780766;4207.305794543897;4261.509926358462;3906.7069969752242;3967.801609919507;4116.444280022203;4141.295979683461;4198.307279298912;3575.928481430383;3604.621514740954;3882.301185786557;4155.605217504332;4199.118185181115;3828.7511311764924;3835.7506762060375;3836.7122465814896;3901.0637447012796;3903.687704983623;4707.8587642370785;4722.881927951795;4995.5753760930365;5025.120603894304;5065.518775716301;4718.8584342469785;4820.566149046603;4832.395950506187;4846.200376937801;4866.391701037371;4548.0886437663585;5296.708681022542;5355.705436201008;5370.374996877132;5383.407825139271;3864.246471937973;4315.921019745064;4322;4401.823927042915;4407.515173330931;5053.065182941131;5172.379314482287;5287.757377016398;5527.866787308592;5648.576356773217;4299.656687105473;4430.62339701129;4445.266531022345;4458.888527786767;4513.074819662027;3891.922161556753;4495.257892685459;4495.865124046284;4505.7158709767555;4511.548845115462;3947.802280153028;4208.9789551052045;4371.409859668904;4860.805567777249;4888.169011268093;4893.657443978958;5336.386315573681;5426.484483974095;5428.941356435536;5461.7711015021305;1501.8360770403026;1538.0617823127884;1540.1683091130888;1544.8259322914666;1575.8818088643397;1067.4182570499097;1156.3871148291419;1159.368144361325;1159.907207423404;1206.312401930891;4957.3307603473795;4968.478309777493;4973.676711013773;5003.2745251938995;5143.254228136899;5728.193185339237;5747.683877386784;5752.570520699039;5763.9135412968835;5776.873509665575;4856.6886940526565;4942.4316203637045;4961.627877909171;5094.293411707045;5190.624484511607;2527.8609676467972;2567.537843188207;2889.2199106241196;2895.364119272604;2900.7824413169096;5207.062728708869;5287.841364759063;5544.362398324244;5772.278465191851;5898.262717160355;4909.631777616693;5432.320959880015;5443.863903402367;5638.915416268759;5650.406707295757;5084.8220312288895;5343.732813359395;5751.677114263659;5761.740721667535;5833.7374818133285;4510.797014134306;4678.836240731558;4995.55721375936;5540.390557038803;5609.158626206102;4605.844996177629;4723.858284251341;5380.063177256263;5415.647982881258;5583.832485025456;5016.297718319511;5256.817216126341;5431.321084864392;5589.385167631639;5590.440955904377;3739.8691045813266;3786.905327366838;4041.9393709093797;4091.8697196645185;4178.937315940202;4869.634777391639;4899.877503062452;5391.703456309784;5595.412481689364;5628.352739434854;5318.234518050669;5357.866053348697;5365.2220428036935;5371.892562148657;5454.754536045967;4915.5330243626795;5207.344254430343;5244.659097158673;5359.410464848941;5415.620906536662;4376.059147283349;4577.002063648316;4816.903661926672;5277.437729532627;5300.284461597635;4765.547273009059;5227.529522343008;5308.230306605597;5343.996001499438;5373.328333958255;4833.854984350334;5056.140456122542;5328.920066199088;5402.270693456333;5492.80775172867 09:19:10 INFO - PROCESS | 6494 | |5;yui.html;720.4704542161508;735.6358602491767;743.5835931878148;781.6326326626487;847.7838151271425;12145;14074;14451.494197703083;14558.05372650777;14564.05333653313;14307.570772876805;14317.212553309564;14318.069325493836;14322.570322890304;14423.711525769479;927.9025702301262;947.8815148106487;973.897740737223;983.5721461164417;986.1026465916018;955.928305377096;962.0764066496172;971.218169373654;974.3861367338602;976.9853452198223;1023.4115383654391;1025.7692019295673;1026.6612018034032;1027.4195079779938;1027.7379268286613;1016.7305663999047;1020.6631811502224;1021.6219998600491;1021.887592364843;1022.1260821997159;760.232165512836;762.5310434083054;762.980925476862;763.5800309829627;763.9809004774869;14869.330880110312;15612.063276203351;15650.295736691876;16077.839221607868;16305.918470407572;10903.83644245337;11639.35983520906;13826.516071937434;13881.167129972133;14216.502422415166;11438.428078596036;11748.941255293754;11845.822312665317;11856.822147667792;12149.210301330386;3632.237230181665;3683.465897444882;3693.242885208526;3707.277080969212;3722.7766334020043;97164.05671886593;99793.51135687607;100219;102507;125131;9101.544922753968;10665.626703065356;10702.411367374869;11307.208495405243;11369.033632141196;22788.772112278995;22843.885780570992;22854;22901.541969160524;22955.655665165035;7331.120265568166;7508.587027713528;7571.772846814604;7655.311022008046;7862.449628526063;4262.147570485853;4275.03811642378;4303.376010478463;4340.804663790137;4454;3397.286569820316;3493.615702272748;3496.947545786815;3498.8075655839175;3501.0197144799495;548.4241546376289;597.1937883856846;598.5002522893433;602.6414283501309;603.062238219564;661.2230629010893;676.6379986707088;679.9694013769392;697.9042902642904;701.3232230897107;8242.711505097293;9984.20126389887;10090.041446062613;10492.895071049192;10789.46052697362;608.622653954551;612.791650838717;644.3138057968249;646.7186773753432;650.72344253692;4631.93052104212;4985.725785081855;4988.775505102279;4989;4998.600111991032;96287.34294326637;104968.47515762372;108273.37589936158;109602.45198773955;109846;94162.0583794167;94729;95721;95864.52067739617;98014.01985980192;83384;84109;84520.57739711262;84659.5767021161;84733.57633211794;9663.13031827139;9670;9674.70975870725;9694.46680432583;9770.31607787448;53062;53535;54558;55390.72304638451;56154.75380984715;66116;67157.66421167862;67487;68273;68357.3164268351;11422.714432139262;11565.479553420284;11657.475413606238;11689.649310520697;12273.754524909273;12514.707561548237;12557.434915428645;12747.553835615709;13119.212847229197;13186.80219796723;11229.71925701864;11656.125790565571;11923.880761192624;11968.46141923598;12136.696582585506;11923.165378423428;12035;12057.51769929228;12170.57402990891;12850.357482126043;11538.192326537062;11643.359615221245;11958.342291174069;12018.579349722717;12525.874741252472;10222.846657300295;10227.232957528066;10349.379037257788;10631.149508039493;10758.682589942344;9968.352057116264;10074.496275186359;10115;10155.593776248867;10168.135708464568 09:19:10 INFO - PROCESS | 6494 | __end_tp_report 09:19:10 INFO - PROCESS | 6494 | __start_cc_report 09:19:10 INFO - PROCESS | 6494 | _x_x_mozilla_cycle_collect,2263 09:19:10 INFO - PROCESS | 6494 | __end_cc_report 09:19:10 INFO - PROCESS | 6494 | __startTimestamp1489079950909__endTimestamp 09:19:10 INFO - PROCESS | 6494 | 09:19:10 INFO - PROCESS | 6494 | ------- Summary: start ------- 09:19:10 INFO - PROCESS | 6494 | Number of tests: 6 09:19:10 INFO - PROCESS | 6494 | 09:19:10 INFO - PROCESS | 6494 | [#0] dojo.html Cycles:165 Average:5996.02 Median:6214.13 stddev:681.50 (11.0%) stddev-sans-first:645.24 09:19:10 INFO - PROCESS | 6494 | Values: 3122.8 3425.9 3428.9 3456.4 3482.2 6076.0 6099.9 6137.0 6137.6 6151.3 6102.2 6119.2 6146.2 6153.6 6166.2 4826.2 5398.2 5469.6 5473.2 5510.8 5388.6 5394.5 5433.8 5587.7 5603.8 5467.6 5501.2 5513.5 5517.7 5524.3 5497.5 5500.1 5506.4 5507.6 5513.4 5317.8 5427.0 5438.8 5439.5 5481.2 5420.5 5757.7 6094.3 6094.4 6113.8 6350.3 6363.0 6363.9 6380.1 6387.4 6381.2 6406.2 6503.5 6551.3 6589.5 6153.9 6211.7 6214.1 6228.8 6260.4 6391.6 6409.1 6647.8 6688.0 6712.3 6191.5 6318.7 6355.9 6376.0 6378.1 5492.8 6212.3 6413.3 6450.7 6500.0 6446.8 6461.7 6466.2 6468.0 6472.4 6306.7 6464.2 6470.6 6487.9 6566.9 4387.2 5200.9 5208.3 5212.0 5212.5 4643.5 4659.3 4669.3 4673.0 4684.7 5968.7 5971.8 6006.3 6028.8 6038.2 5318.5 6354.9 6377.8 6378.6 6495.8 6149.9 6154.0 6154.3 6160.8 6161.2 5764.6 5767.9 5773.4 5789.0 5795.2 6437.6 6515.9 6564.7 6736.9 6783.8 6387.5 6397.4 6398.0 6401.4 6406.9 6591.3 6716.5 6735.5 6763.7 6769.2 6491.1 6491.5 6491.8 6494.1 6500.4 6284.4 6536.8 6569.8 6571.6 6586.7 6183.3 6277.1 6313.1 6322.2 6322.9 6233.9 6256.0 6295.6 6308.1 6362.2 6300.2 6333.1 6334.3 6348.5 6355.2 6376.5 6381.9 6392.5 6414.2 6440.2 6047.5 6106.8 6138.5 6141.9 6152.2 09:19:10 INFO - PROCESS | 6494 | 09:19:10 INFO - PROCESS | 6494 | [#1] ext.html Cycles:180 Average:56509.58 Median:16988.64 stddev:123104.05 (724.6%) stddev-sans-first:123378.07 09:19:10 INFO - PROCESS | 6494 | Values: 699.4 819.4 860.6 882.4 887.8 38183.2 38816.5 39118.8 39289.4 40625.4 39919.6 40092.0 40160.6 40217.8 40227.0 7226.2 7383.3 9029.6 9176.4 9194.8 7329.0 7424.2 7433.9 10588.3 10853.2 10847.8 10867.9 10871.8 10881.0 10881.3 10756.8 10811.3 10846.1 10847.1 10868.0 7140.2 7317.8 7374.4 10570.1 10628.5 27067.9 27182.2 38686.0 39284.6 40654.8 3836.9 3890.7 3921.0 3939.7 3968.6 26599.2 26917.6 27427.9 28088.7 28574.9 3090.3 3107.1 3107.8 3125.3 3132.5 329469.0 329760.0 330533.0 330602.0 330928.3 40190.4 43415.6 49190.8 49305.8 50683.0 45274.5 45847.5 49968.5 54850.7 54915.5 13373.0 13408.9 13411.0 13415.0 13429.9 11534.8 11579.4 11591.7 11593.0 11615.4 12376.0 12391.0 12432.3 12433.9 12574.6 5372.9 5377.4 5412.6 5422.8 5423.4 938.2 957.8 965.4 973.0 990.7 24714.6 24916.3 27530.6 28384.4 28915.9 1038.1 1051.0 1060.5 1067.5 1072.9 11359.7 14181.5 14678.5 14898.8 14902.6 485224.0 496939.0 594023.0 594863.0 597644.0 38822.0 39803.4 43898.0 44079.6 44085.3 1357.0 1396.8 1403.1 1404.9 1408.0 21574.1 22931.4 24347.4 24629.8 25011.4 36463.8 36593.8 37027.6 39279.0 39927.0 463808.0 466964.0 467009.0 467815.0 467863.0 27437.0 27466.3 27513.6 27602.0 27604.6 34433.3 34829.3 35249.8 36008.8 36013.5 29098.4 29281.4 30369.0 30588.8 30627.8 29037.0 29297.0 29638.6 29838.9 30103.0 27710.0 30205.5 30659.9 30718.5 30887.0 24910.8 26791.0 26931.9 27358.1 27436.5 15993.4 21180.0 21278.9 21364.6 21410.3 09:19:10 INFO - PROCESS | 6494 | 09:19:10 INFO - PROCESS | 6494 | [#2] jquery.html Cycles:180 Average:43121.06 Median:24494.51 stddev:125722.00 (513.3%) stddev-sans-first:126033.73 09:19:10 INFO - PROCESS | 6494 | Values: 382.8 427.2 429.7 431.2 441.8 15597.3 20546.8 21562.2 22015.2 22318.6 19977.2 20469.3 20945.5 21003.9 21265.6 5480.7 5867.4 6265.9 6541.6 6543.1 6283.3 6411.5 6417.0 6480.8 6483.4 6480.3 6486.0 6873.6 7123.8 7341.7 7030.7 7240.1 7314.0 7348.7 7357.9 5914.9 7096.8 7111.1 7111.3 7128.0 23876.4 24315.6 24673.4 25056.0 25082.5 3256.2 3290.8 3301.6 3345.3 3519.3 14941.6 15460.3 15484.1 15492.1 16064.9 1650.7 1915.2 1994.2 2015.2 2048.8 162744.0 163782.4 164763.0 169538.0 176478.1 14533.5 18882.9 19495.7 19771.7 19839.8 29642.0 30845.4 31009.0 31105.5 31133.1 8293.3 8659.7 8664.6 9200.6 9477.3 7649.1 7982.5 8002.9 8019.6 8094.9 8924.0 9066.9 9225.6 9235.4 9238.0 3953.8 3985.7 4000.8 4012.7 4019.4 872.6 885.8 888.0 914.0 924.4 20165.9 20595.8 20678.3 20679.3 21023.8 714.4 910.7 915.5 929.5 930.6 10220.7 10531.0 10601.7 10609.3 10639.5 701239.0 753244.0 761078.0 762518.0 774285.0 136232.0 152988.0 157326.0 159044.0 164525.2 1142.7 1154.5 1179.6 1181.6 1185.5 16740.9 17546.2 17860.9 17980.5 18108.2 59875.3 62158.7 62293.4 62988.0 63936.7 88163.6 88190.0 88625.0 90899.0 91005.0 10536.6 10821.1 11162.1 11173.6 11366.0 12381.1 12422.9 12605.6 12755.8 12784.4 10893.0 10897.6 10963.6 10981.5 11025.3 9933.0 10109.6 10658.8 10733.4 10821.9 10366.4 10563.2 10938.6 11168.1 11203.3 10717.6 10762.5 10865.0 11082.8 11128.7 10442.6 10520.9 10684.4 10691.5 10701.3 09:19:10 INFO - PROCESS | 6494 | 09:19:10 INFO - PROCESS | 6494 | [#3] mootools.html Cycles:180 Average:6604.03 Median:3602.61 stddev:4167.64 (115.7%) stddev-sans-first:4160.83 09:19:10 INFO - PROCESS | 6494 | Values: 1378.0 1539.2 1544.0 1563.7 1573.1 10629.0 11193.8 11203.7 11213.4 11228.9 10594.6 10876.9 10964.4 11079.3 11107.7 2312.8 2347.5 2352.6 2353.4 2353.9 1970.4 1993.6 2046.7 2247.6 2303.7 2286.1 2288.8 2319.6 2320.2 2326.5 1894.4 2280.7 2284.7 2284.7 2296.8 2260.5 2321.4 2322.2 2325.2 2330.2 10951.0 10982.7 10984.8 10987.6 10991.5 4609.1 5581.8 5614.7 5621.2 5623.2 3262.5 3368.6 3536.5 3538.3 3541.6 1213.8 1214.2 1784.6 1802.7 1899.3 13087.9 15269.7 15368.7 15597.0 15597.8 4348.8 4449.3 4466.2 4580.4 4586.9 11426.1 11436.3 11442.2 11442.9 11443.5 5513.4 5515.3 5516.2 5518.1 5530.9 4929.7 5037.8 5098.9 5115.0 5123.8 3663.7 3714.3 3744.1 3772.1 3792.9 956.7 967.4 972.1 982.2 986.3 912.5 920.5 922.7 937.2 980.1 6371.0 6455.9 6462.7 6480.2 6540.4 945.2 956.3 964.3 964.8 966.9 3947.7 4093.7 4219.7 4231.3 4243.1 11592.5 13588.7 13711.3 13711.8 13715.5 11979.0 13309.2 13648.0 13657.7 13897.9 8106.5 8892.0 9062.9 9200.7 10081.2 6233.9 6494.4 6642.9 6665.8 6769.3 12117.0 12157.7 12340.6 12378.8 12381.0 12255.9 12388.3 12588.0 12687.3 12789.1 8384.8 8459.8 8466.2 8545.7 8566.1 10097.1 10111.2 10220.7 10231.5 10243.0 8796.3 8932.0 9014.5 9014.7 9049.0 8690.4 8740.4 8761.6 8804.9 8986.1 7677.8 7840.2 7846.7 7847.8 7849.4 5653.7 5666.2 5712.9 5836.4 5879.8 5589.0 5652.6 5832.0 5895.6 6049.0 09:19:10 INFO - PROCESS | 6494 | 09:19:10 INFO - PROCESS | 6494 | [#4] prototype.html Cycles:180 Average:4499.83 Median:4890.91 stddev:1246.42 (25.5%) stddev-sans-first:1210.32 09:19:10 INFO - PROCESS | 6494 | Values: 347.1 368.7 383.3 385.1 387.6 4871.3 4955.5 5099.9 5133.8 5198.0 4227.7 5006.8 5020.6 5025.3 5093.8 4192.4 4195.0 4241.3 4270.4 4281.6 3996.8 4005.3 4033.3 4207.3 4261.5 3906.7 3967.8 4116.4 4141.3 4198.3 3575.9 3604.6 3882.3 4155.6 4199.1 3828.8 3835.8 3836.7 3901.1 3903.7 4707.9 4722.9 4995.6 5025.1 5065.5 4718.9 4820.6 4832.4 4846.2 4866.4 4548.1 5296.7 5355.7 5370.4 5383.4 3864.2 4315.9 4322.0 4401.8 4407.5 5053.1 5172.4 5287.8 5527.9 5648.6 4299.7 4430.6 4445.3 4458.9 4513.1 3891.9 4495.3 4495.9 4505.7 4511.5 3947.8 4209.0 4371.4 4860.8 4888.2 4893.7 5336.4 5426.5 5428.9 5461.8 1501.8 1538.1 1540.2 1544.8 1575.9 1067.4 1156.4 1159.4 1159.9 1206.3 4957.3 4968.5 4973.7 5003.3 5143.3 5728.2 5747.7 5752.6 5763.9 5776.9 4856.7 4942.4 4961.6 5094.3 5190.6 2527.9 2567.5 2889.2 2895.4 2900.8 5207.1 5287.8 5544.4 5772.3 5898.3 4909.6 5432.3 5443.9 5638.9 5650.4 5084.8 5343.7 5751.7 5761.7 5833.7 4510.8 4678.8 4995.6 5540.4 5609.2 4605.8 4723.9 5380.1 5415.6 5583.8 5016.3 5256.8 5431.3 5589.4 5590.4 3739.9 3786.9 4041.9 4091.9 4178.9 4869.6 4899.9 5391.7 5595.4 5628.4 5318.2 5357.9 5365.2 5371.9 5454.8 4915.5 5207.3 5244.7 5359.4 5415.6 4376.1 4577.0 4816.9 5277.4 5300.3 4765.5 5227.5 5308.2 5344.0 5373.3 4833.9 5056.1 5328.9 5402.3 5492.8 09:19:10 INFO - PROCESS | 6494 | 09:19:10 INFO - PROCESS | 6494 | [#5] yui.html Cycles:180 Average:20749.66 Median:3497.88 stddev:30588.00 (874.5%) stddev-sans-first:30636.83 09:19:10 INFO - PROCESS | 6494 | Values: 720.5 735.6 743.6 781.6 847.8 12145.0 14074.0 14451.5 14558.1 14564.1 14307.6 14317.2 14318.1 14322.6 14423.7 927.9 947.9 973.9 983.6 986.1 955.9 962.1 971.2 974.4 977.0 1023.4 1025.8 1026.7 1027.4 1027.7 1016.7 1020.7 1021.6 1021.9 1022.1 760.2 762.5 763.0 763.6 764.0 14869.3 15612.1 15650.3 16077.8 16305.9 10903.8 11639.4 13826.5 13881.2 14216.5 11438.4 11748.9 11845.8 11856.8 12149.2 3632.2 3683.5 3693.2 3707.3 3722.8 97164.1 99793.5 100219.0 102507.0 125131.0 9101.5 10665.6 10702.4 11307.2 11369.0 22788.8 22843.9 22854.0 22901.5 22955.7 7331.1 7508.6 7571.8 7655.3 7862.4 4262.1 4275.0 4303.4 4340.8 4454.0 3397.3 3493.6 3496.9 3498.8 3501.0 548.4 597.2 598.5 602.6 603.1 661.2 676.6 680.0 697.9 701.3 8242.7 9984.2 10090.0 10492.9 10789.5 608.6 612.8 644.3 646.7 650.7 4631.9 4985.7 4988.8 4989.0 4998.6 96287.3 104968.5 108273.4 109602.5 109846.0 94162.1 94729.0 95721.0 95864.5 98014.0 83384.0 84109.0 84520.6 84659.6 84733.6 9663.1 9670.0 9674.7 9694.5 9770.3 53062.0 53535.0 54558.0 55390.7 56154.8 66116.0 67157.7 67487.0 68273.0 68357.3 11422.7 11565.5 11657.5 11689.6 12273.8 12514.7 12557.4 12747.6 13119.2 13186.8 11229.7 11656.1 11923.9 11968.5 12136.7 11923.2 12035.0 12057.5 12170.6 12850.4 11538.2 11643.4 11958.3 12018.6 12525.9 10222.8 10227.2 10349.4 10631.1 10758.7 9968.4 10074.5 10115.0 10155.6 10168.1 09:19:10 INFO - PROCESS | 6494 | -------- Summary: end -------- 09:19:10 INFO - PROCESS | 6494 | 09:19:11 INFO - TEST-INFO | 6494: exit 0 09:19:11 INFO - TEST-OK | dromaeo_css | took 1120991ms 09:19:11 INFO - TEST-START | kraken 09:19:11 INFO - operating with platform_type : mac_ 09:19:11 INFO - Initialising browser for kraken test... 09:19:11 INFO - TEST-INFO | started process 6497 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/tmpf_wjkC/profile http://localhost:56995/getInfo.html) 09:19:13 INFO - PROCESS | 6497 | __metrics Screen width/height:1600/1200 09:19:13 INFO - PROCESS | 6497 | colorDepth:24 09:19:13 INFO - PROCESS | 6497 | Browser inner width/height: 1024/689 09:19:13 INFO - PROCESS | 6497 | __metrics 09:19:13 INFO - PROCESS | 6497 | 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:19:13 INFO - PROCESS | 6497 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:19:14 INFO - TEST-INFO | 6497: exit 0 09:19:14 INFO - Browser initialized. 09:19:14 INFO - Running cycle 1/1 for kraken test... 09:19:14 INFO - TEST-INFO | started process 6498 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/tmpf_wjkC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:19:26 INFO - PROCESS | 6498 | RSS: Main: 214761472 09:19:26 INFO - PROCESS | 6498 | 09:19:29 INFO - PROCESS | 6498 | Cycle 1(1): loaded http://localhost:56995/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56995/tests/kraken/driver.html?testName=audio-beat-detection) 09:19:30 INFO - PROCESS | 6498 | RSS: Main: 267800576 09:19:30 INFO - PROCESS | 6498 | 09:19:33 INFO - PROCESS | 6498 | Cycle 1(1): loaded http://localhost:56995/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56995/tests/kraken/driver.html?testName=audio-dft) 09:19:33 INFO - PROCESS | 6498 | RSS: Main: 277528576 09:19:33 INFO - PROCESS | 6498 | 09:19:36 INFO - PROCESS | 6498 | Cycle 1(1): loaded http://localhost:56995/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56995/tests/kraken/driver.html?testName=audio-fft) 09:19:37 INFO - PROCESS | 6498 | RSS: Main: 374681600 09:19:37 INFO - PROCESS | 6498 | 09:19:39 INFO - PROCESS | 6498 | Cycle 1(1): loaded http://localhost:56995/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56995/tests/kraken/driver.html?testName=audio-oscillator) 09:19:40 INFO - PROCESS | 6498 | RSS: Main: 278650880 09:19:40 INFO - PROCESS | 6498 | 09:19:42 INFO - PROCESS | 6498 | Cycle 1(1): loaded http://localhost:56995/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56995/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:19:42 INFO - PROCESS | 6498 | RSS: Main: 280186880 09:19:42 INFO - PROCESS | 6498 | 09:19:45 INFO - PROCESS | 6498 | Cycle 1(1): loaded http://localhost:56995/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56995/tests/kraken/driver.html?testName=imaging-darkroom) 09:19:46 INFO - PROCESS | 6498 | RSS: Main: 320348160 09:19:46 INFO - PROCESS | 6498 | 09:19:49 INFO - PROCESS | 6498 | Cycle 1(1): loaded http://localhost:56995/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56995/tests/kraken/driver.html?testName=imaging-desaturate) 09:19:50 INFO - PROCESS | 6498 | RSS: Main: 321744896 09:19:50 INFO - PROCESS | 6498 | 09:19:53 INFO - PROCESS | 6498 | Cycle 1(1): loaded http://localhost:56995/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56995/tests/kraken/driver.html?testName=json-parse-financial) 09:19:53 INFO - PROCESS | 6498 | RSS: Main: 320884736 09:19:53 INFO - PROCESS | 6498 | 09:19:55 INFO - PROCESS | 6498 | Cycle 1(1): loaded http://localhost:56995/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56995/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:19:56 INFO - PROCESS | 6498 | RSS: Main: 295714816 09:19:56 INFO - PROCESS | 6498 | 09:19:57 INFO - PROCESS | 6498 | Cycle 1(1): loaded http://localhost:56995/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56995/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:19:58 INFO - PROCESS | 6498 | RSS: Main: 298946560 09:19:58 INFO - PROCESS | 6498 | 09:20:00 INFO - PROCESS | 6498 | Cycle 1(1): loaded http://localhost:56995/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56995/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:20:01 INFO - PROCESS | 6498 | RSS: Main: 305278976 09:20:01 INFO - PROCESS | 6498 | 09:20:04 INFO - PROCESS | 6498 | Cycle 1(1): loaded http://localhost:56995/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56995/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:20:05 INFO - PROCESS | 6498 | RSS: Main: 321146880 09:20:05 INFO - PROCESS | 6498 | 09:20:07 INFO - PROCESS | 6498 | Cycle 1(1): loaded http://localhost:56995/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56995/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:20:08 INFO - PROCESS | 6498 | RSS: Main: 314068992 09:20:08 INFO - PROCESS | 6498 | 09:20:10 INFO - PROCESS | 6498 | Cycle 1(1): loaded http://localhost:56995/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56995/tests/kraken/driver.html?testName=ai-astar) 09:20:10 INFO - PROCESS | 6498 | RSS: Main: 358588416 09:20:10 INFO - PROCESS | 6498 | 09:20:10 INFO - PROCESS | 6498 | __start_tp_report 09:20:10 INFO - PROCESS | 6498 | _x_x_mozilla_page_load 09:20:10 INFO - PROCESS | 6498 | _x_x_mozilla_page_load_details 09:20:10 INFO - PROCESS | 6498 | |i|pagename|runs| 09:20:10 INFO - PROCESS | 6498 | |0;ai-astar;117;115;115;115;114;115;116;115;116;117 09:20:10 INFO - PROCESS | 6498 | |1;audio-beat-detection;133;110;108;142;109;112;128;132;135;109 09:20:10 INFO - PROCESS | 6498 | |2;audio-dft;187;186;183;185;186;183;183;183;184;182 09:20:10 INFO - PROCESS | 6498 | |3;audio-fft;84;60;58;91;65;62;61;61;76;59 09:20:10 INFO - PROCESS | 6498 | |4;audio-oscillator;92;69;87;69;70;69;82;68;68;83 09:20:10 INFO - PROCESS | 6498 | |5;imaging-gaussian-blur;86;86;86;86;86;86;87;86;85;86 09:20:10 INFO - PROCESS | 6498 | |6;imaging-darkroom;94;93;94;94;94;94;103;93;93;94 09:20:10 INFO - PROCESS | 6498 | |7;imaging-desaturate;85;85;82;83;84;86;83;82;86;83 09:20:10 INFO - PROCESS | 6498 | |8;json-parse-financial;63;63;63;60;67;92;96;97;78;64 09:20:10 INFO - PROCESS | 6498 | |9;json-stringify-tinderbox;54;60;59;64;59;56;58;58;57;59 09:20:10 INFO - PROCESS | 6498 | |10;stanford-crypto-aes;87;86;83;83;79;78;85;82;84;90 09:20:10 INFO - PROCESS | 6498 | |11;stanford-crypto-ccm;138;140;138;139;135;137;138;140;218;143 09:20:10 INFO - PROCESS | 6498 | |12;stanford-crypto-pbkdf2;167;165;168;165;165;164;161;166;214;174 09:20:10 INFO - PROCESS | 6498 | |13;stanford-crypto-sha256-iterative;64;62;65;64;64;62;63;64;65;65 09:20:10 INFO - PROCESS | 6498 | __end_tp_report 09:20:10 INFO - PROCESS | 6498 | __start_cc_report 09:20:10 INFO - PROCESS | 6498 | _x_x_mozilla_cycle_collect,2103 09:20:10 INFO - PROCESS | 6498 | __end_cc_report 09:20:10 INFO - PROCESS | 6498 | __startTimestamp1489080010518__endTimestamp 09:20:10 INFO - PROCESS | 6498 | 09:20:10 INFO - PROCESS | 6498 | ------- Summary: start ------- 09:20:10 INFO - PROCESS | 6498 | Number of tests: 14 09:20:10 INFO - PROCESS | 6498 | 09:20:10 INFO - PROCESS | 6498 | [#0] ai-astar Cycles:10 Average:115.50 Median:115.50 stddev:0.97 (0.8%) stddev-sans-first:0.87 09:20:10 INFO - PROCESS | 6498 | Values: 117.0 115.0 115.0 115.0 114.0 115.0 116.0 115.0 116.0 117.0 09:20:10 INFO - PROCESS | 6498 | 09:20:10 INFO - PROCESS | 6498 | [#1] audio-beat-detection Cycles:10 Average:121.80 Median:130.00 stddev:13.35 (10.3%) stddev-sans-first:13.53 09:20:10 INFO - PROCESS | 6498 | Values: 133.0 110.0 108.0 142.0 109.0 112.0 128.0 132.0 135.0 109.0 09:20:10 INFO - PROCESS | 6498 | 09:20:10 INFO - PROCESS | 6498 | [#2] audio-dft Cycles:10 Average:184.20 Median:184.50 stddev:1.69 (0.9%) stddev-sans-first:1.45 09:20:10 INFO - PROCESS | 6498 | Values: 187.0 186.0 183.0 185.0 186.0 183.0 183.0 183.0 184.0 182.0 09:20:10 INFO - PROCESS | 6498 | 09:20:10 INFO - PROCESS | 6498 | [#3] audio-fft Cycles:10 Average:67.70 Median:63.50 stddev:11.72 (18.5%) stddev-sans-first:10.84 09:20:10 INFO - PROCESS | 6498 | Values: 84.0 60.0 58.0 91.0 65.0 62.0 61.0 61.0 76.0 59.0 09:20:10 INFO - PROCESS | 6498 | 09:20:10 INFO - PROCESS | 6498 | [#4] audio-oscillator Cycles:10 Average:75.70 Median:76.00 stddev:9.26 (12.2%) stddev-sans-first:7.72 09:20:10 INFO - PROCESS | 6498 | Values: 92.0 69.0 87.0 69.0 70.0 69.0 82.0 68.0 68.0 83.0 09:20:10 INFO - PROCESS | 6498 | 09:20:10 INFO - PROCESS | 6498 | [#5] imaging-gaussian-blur Cycles:10 Average:86.00 Median:86.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 09:20:10 INFO - PROCESS | 6498 | Values: 86.0 86.0 86.0 86.0 86.0 86.0 87.0 86.0 85.0 86.0 09:20:10 INFO - PROCESS | 6498 | 09:20:10 INFO - PROCESS | 6498 | [#6] imaging-darkroom Cycles:10 Average:94.60 Median:94.00 stddev:2.99 (3.2%) stddev-sans-first:3.16 09:20:10 INFO - PROCESS | 6498 | Values: 94.0 93.0 94.0 94.0 94.0 94.0 103.0 93.0 93.0 94.0 09:20:10 INFO - PROCESS | 6498 | 09:20:10 INFO - PROCESS | 6498 | [#7] imaging-desaturate Cycles:10 Average:83.90 Median:84.50 stddev:1.52 (1.8%) stddev-sans-first:1.56 09:20:10 INFO - PROCESS | 6498 | Values: 85.0 85.0 82.0 83.0 84.0 86.0 83.0 82.0 86.0 83.0 09:20:10 INFO - PROCESS | 6498 | 09:20:10 INFO - PROCESS | 6498 | [#8] json-parse-financial Cycles:10 Average:74.30 Median:72.50 stddev:15.13 (20.9%) stddev-sans-first:15.48 09:20:10 INFO - PROCESS | 6498 | Values: 63.0 63.0 63.0 60.0 67.0 92.0 96.0 97.0 78.0 64.0 09:20:10 INFO - PROCESS | 6498 | 09:20:10 INFO - PROCESS | 6498 | [#9] json-stringify-tinderbox Cycles:10 Average:58.40 Median:59.00 stddev:2.63 (4.5%) stddev-sans-first:2.26 09:20:10 INFO - PROCESS | 6498 | Values: 54.0 60.0 59.0 64.0 59.0 56.0 58.0 58.0 57.0 59.0 09:20:10 INFO - PROCESS | 6498 | 09:20:10 INFO - PROCESS | 6498 | [#10] stanford-crypto-aes Cycles:10 Average:83.70 Median:84.50 stddev:3.59 (4.3%) stddev-sans-first:3.61 09:20:10 INFO - PROCESS | 6498 | Values: 87.0 86.0 83.0 83.0 79.0 78.0 85.0 82.0 84.0 90.0 09:20:10 INFO - PROCESS | 6498 | 09:20:10 INFO - PROCESS | 6498 | [#11] stanford-crypto-ccm Cycles:10 Average:146.60 Median:139.50 stddev:25.18 (18.0%) stddev-sans-first:26.51 09:20:10 INFO - PROCESS | 6498 | Values: 138.0 140.0 138.0 139.0 135.0 137.0 138.0 140.0 218.0 143.0 09:20:10 INFO - PROCESS | 6498 | 09:20:10 INFO - PROCESS | 6498 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.90 Median:166.50 stddev:15.51 (9.3%) stddev-sans-first:16.39 09:20:10 INFO - PROCESS | 6498 | Values: 167.0 165.0 168.0 165.0 165.0 164.0 161.0 166.0 214.0 174.0 09:20:10 INFO - PROCESS | 6498 | 09:20:10 INFO - PROCESS | 6498 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.80 Median:64.00 stddev:1.14 (1.8%) stddev-sans-first:1.20 09:20:10 INFO - PROCESS | 6498 | Values: 64.0 62.0 65.0 64.0 64.0 62.0 63.0 64.0 65.0 65.0 09:20:10 INFO - PROCESS | 6498 | -------- Summary: end -------- 09:20:10 INFO - PROCESS | 6498 | 09:20:11 INFO - TEST-INFO | 6498: exit 0 09:20:11 INFO - TEST-OK | kraken | took 60090ms 09:20:11 INFO - SUITE-END | took 1181s 09:20:12 INFO - Completed test suite (00:19:41) 09:20:12 INFO - javascript benchmark 09:20:12 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7538.479310371745, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3122.7501799856013, 3425.880094196703, 3428.8799892003785, 3456.3778519866446, 3482.164280572662, 6076.0, 6099.939000609993, 6136.969315153424, 6137.570370074097, 6151.292601350846, 6102.17620621216, 6119.204503414561, 6146.170267013952, 6153.569250152491, 6166.229221347332, 4826.155422801014, 5398.217258497515, 5469.5624350052, 5473.233747275384, 5510.779568817263, 5388.649737767033, 5394.514493695567, 5433.8369848904595, 5587.7485513152005, 5603.831885043455, 5467.562594992411, 5501.174823776446, 5513.476219759116, 5517.724113794295, 5524.309461317335, 5497.505224529771, 5500.064988951888, 5506.366767821692, 5507.614466987313, 5513.42109078547, 5317.787288508455, 5426.996005738951, 5438.782448702047, 5439.5376393006645, 5481.177823326493, 5420.485053919911, 5757.740901659436, 6094.259734851126, 6094.380596348918, 6113.780377411019, 6350.301466838644, 6363.0, 6363.93636063638, 6380.138681278061, 6387.361263873576, 6381.234251889757, 6406.199225096863, 6503.512236582275, 6551.344865513458, 6589.472842172615, 6153.907691384633, 6211.68941552925, 6214.130021796952, 6228.781992630236, 6260.405261500196, 6391.616503009835, 6409.070684750685, 6647.76732814354, 6688.0, 6712.295209003082, 6191.504679625619, 6318.652474113968, 6355.872882542416, 6375.968120159369, 6378.075179099097, 5492.780288788484, 6212.347703491068, 6413.29453760086, 6450.741970321228, 6500.0, 6446.8388290293115, 6461.709223084972, 6466.191726034246, 6467.965125579884, 6472.417482426604, 6306.747730090745, 6464.159659244362, 6470.6441145737435, 6487.935120648733, 6566.934330656728, 4387.166438376698, 5200.92198617021, 5208.296879921162, 5212.035773381936, 5212.452692467312, 4643.489216186217, 4659.324397962277, 4669.322948172496, 4672.976635116803, 4684.742339171378, 5968.731407086691, 5971.820845374646, 6006.309274433409, 6028.758849645965, 6038.18484504595, 5318.521333080042, 6354.936450635527, 6377.808665740035, 6378.617282962944, 6495.805125846137, 6149.938500614937, 6153.98459254227, 6154.323024467305, 6160.815175544741, 6161.199044124325, 5764.596478246483, 5767.942320576741, 5773.422657734193, 5789.0, 5795.246617939725, 6437.645929473737, 6515.902261466176, 6564.704588293443, 6736.92209246528, 6783.830404239835, 6387.457066149429, 6397.424231819158, 6397.96801015992, 6401.423871851555, 6406.871862562816, 6591.34086591337, 6716.496262780409, 6735.49483788708, 6763.695633696397, 6769.1876974763345, 6491.05879647439, 6491.4806815455595, 6491.772787952399, 6494.058361537645, 6500.414962653384, 6284.371562843679, 6536.803895883131, 6569.835754106186, 6571.605703657605, 6586.70359833799, 6183.258009038944, 6277.121203031488, 6313.08460273267, 6322.209723784527, 6322.8735425290315, 6233.906491402542, 6256.0, 6295.5907865988565, 6308.053791931247, 6362.204724409449, 6300.243970723543, 6333.113364128933, 6334.303226645157, 6348.523860710373, 6355.173827402408, 6376.489880809617, 6381.904271436025, 6392.488600911823, 6414.166158399378, 6440.162778838721, 6047.516198704181, 6106.816795496142, 6138.478229350555, 6141.9078713818435, 6152.200213972155], "value": 5951.021961896243, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [699.3740602161066, 819.4386845011165, 860.6385318166369, 882.3691060891462, 887.800244944887, 38183.23633527328, 38816.5065144137, 39118.804405977964, 39289.41065884014, 40625.39061914074, 39919.600803991954, 40092.0, 40160.598394016124, 40217.798911005404, 40226.99432514189, 7226.241244669287, 7383.298586634288, 9029.593668284926, 9176.403533770317, 9194.77013074675, 7329.0, 7424.220456852034, 7433.851322973537, 10588.31175973563, 10853.24027318088, 10847.783044339109, 10867.945660271727, 10871.782564348709, 10881.0, 10881.347119172835, 10756.78486430271, 10811.297265677746, 10846.132309415307, 10847.132229421628, 10868.0, 7140.214576396592, 7317.817054573625, 7374.410047196211, 10570.101541368993, 10628.521716522775, 27067.864660676572, 27182.184534464, 38686.032849178715, 39284.60715392838, 40654.79672601647, 3836.9040773980596, 3890.6692931100893, 3920.980395098035, 3939.684825213976, 3968.603139686037, 26599.20202393912, 26917.596236056474, 27427.862860685567, 28088.719112808816, 28574.857125714447, 3090.2892334763133, 3107.1455349778767, 3107.7513798896034, 3125.2811853273647, 3132.4518209313505, 329469.0, 329760.0, 330533.0, 330602.0, 330928.3453582765, 40190.397144042865, 43415.565844341785, 49190.75404623026, 49305.75347123241, 50683.0, 45274.54725452703, 45847.541524584994, 49968.50031499711, 54850.72574637101, 54915.45084549183, 13373.0, 13408.932955335356, 13411.0, 13415.0, 13429.865701343057, 11534.826977595343, 11579.363135027654, 11591.6522504325, 11592.95663390299, 11615.36115513638, 12376.0, 12391.0, 12432.316222607662, 12433.93783031079, 12574.622761317176, 5372.865678358073, 5377.4084850666395, 5412.648177868426, 5422.75597598109, 5423.376311724202, 938.1509733691021, 957.760559860035, 965.3532133470451, 972.9951350243346, 990.6780296403554, 24714.629280560806, 24916.252512424657, 27530.587041194398, 28384.43231135407, 28915.855420723183, 1038.1331588124, 1051.0, 1060.5015642647943, 1067.546292825546, 1072.8980746829038, 11359.716007099723, 14181.503647372292, 14678.54241326212, 14898.776518352233, 14902.627434314229, 485224.0, 496939.0, 594023.0, 594863.0, 597644.0, 38822.0, 39803.40294895579, 43898.0, 44079.559204408186, 44085.33871991923, 1356.959291221265, 1396.7765157574738, 1403.0809819568199, 1404.8665376789188, 1408.0, 21574.13703451907, 22931.426714332276, 24347.39131521726, 24629.768511574708, 25011.374715632253, 36463.81768091142, 36593.81703091467, 37027.62972370242, 39279.0, 39927.00182495461, 463808.0, 466964.0, 467009.0, 467814.965551034, 467863.0, 27437.039703610277, 27466.313342166606, 27513.587296190173, 27602.0, 27604.619769011068, 34433.31133377268, 34829.30341393107, 35249.82375088108, 36008.81995590005, 36013.45979810252, 29098.418031638827, 29281.41437171287, 30369.0, 30588.847055764578, 30627.846860765552, 29037.0, 29297.0, 29638.555421669123, 29838.85080574583, 30103.0, 27710.0, 30205.546916795825, 30659.926902559197, 30718.539221911244, 30887.0, 24910.750892490843, 26791.0, 26931.92272309164, 27358.059063338653, 27436.451270974867, 15993.360265589246, 21180.03328119669, 21278.893605531874, 21364.572708546053, 21410.25064122748], "value": 17582.522025862967, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [382.80285652888784, 427.2181907109988, 429.6562749800159, 431.1619432812187, 441.8431456832822, 15597.298121584528, 20546.820987500803, 21562.245321413753, 22015.22946696866, 22318.55362892743, 19977.200911963504, 20469.283575074875, 20945.47636309093, 21003.894980525114, 21265.574688506258, 5480.671159730409, 5867.442592953663, 6265.906011409833, 6541.640209788459, 6543.083968244449, 6283.340249273829, 6411.48708103353, 6417.0, 6480.837979050514, 6483.4489068429, 6480.287168411471, 6485.994670826006, 6873.621950792704, 7123.750668726596, 7341.669624866867, 7030.718771249144, 7240.094988126484, 7314.012608297865, 7348.706051757923, 7357.889631655529, 5914.9112763308585, 7096.822579435504, 7111.146662400493, 7111.288871112899, 7128.0377149084725, 23876.40308992272, 24315.635265470853, 24673.383165421008, 25056.0, 25082.498350032896, 3256.2022304535303, 3290.802551846873, 3301.636819949804, 3345.2974875276223, 3519.2961407718303, 14941.551753447415, 15460.304286307142, 15484.07095574269, 15492.070475771377, 16064.875458717894, 1650.678117767036, 1915.205189846212, 1994.1724184463576, 2015.1637070615677, 2048.805363490466, 162744.0, 163782.3621763779, 164763.0, 169538.0, 176478.1176094124, 14533.539890023461, 18882.905585471985, 19495.707564386546, 19771.703424448646, 19839.801601984083, 29642.0, 30845.383092338026, 31009.0, 31105.53341699831, 31133.066008019796, 8293.33653307734, 8659.696910608098, 8664.566771661392, 9200.585973631069, 9477.28920330978, 7649.120351159577, 7982.481138725964, 8002.919970800334, 8019.599020048974, 8094.878576821352, 8923.955380223188, 9066.902721761719, 9225.616157576284, 9235.445873247627, 9238.013827027222, 3953.7627742335553, 3985.70107241958, 4000.7599544027453, 4012.6990475714438, 4019.437278780973, 872.6422166911536, 885.8361203177433, 888.0, 913.9588718507683, 924.4453328003278, 20165.899170504053, 20595.794042059388, 20678.276260330815, 20679.27622533204, 21023.78976210249, 714.3927661487694, 910.6630546697631, 915.4919019943862, 929.4980710416299, 930.6463543853292, 10220.693379198636, 10531.0, 10601.734956626146, 10609.257351985287, 10639.468026598639, 701239.0, 753244.0, 761078.0, 762518.0, 774285.0, 136232.0, 152988.0, 157326.0, 159044.0, 164525.17737411236, 1142.714321419645, 1154.5324143721807, 1179.6402097360217, 1181.5510106159777, 1185.454690842205, 16740.91629541893, 17546.21042053085, 17860.928344299384, 17980.460586182435, 18108.185131668844, 59875.26817342748, 62158.689206555486, 62293.37706623057, 62988.0, 63936.68031659812, 88163.55918220368, 88190.0, 88625.0, 90899.0, 91005.0, 10536.57853685844, 10821.080208182393, 11162.102442584943, 11173.553057877594, 11366.033887119687, 12381.133320667466, 12422.875771242534, 12605.558805441766, 12755.808662869878, 12784.360781961052, 10893.0, 10897.564097436014, 10963.616273430393, 10981.462595236833, 11025.338479691245, 9933.0, 10109.595616175271, 10658.786824263316, 10733.355998640107, 10821.891781082088, 10366.378017318984, 10563.20775941792, 10938.562457501928, 11168.106551476025, 11203.271787333797, 10717.624883129052, 10762.46187690628, 10865.0, 11082.833757493805, 11128.721781955515, 10442.63450779219, 10520.894791051991, 10684.41235732011, 10691.465426728788, 10701.304415212986], "value": 11233.74715322209, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1377.973409809692, 1539.222692540267, 1543.9845601543982, 1563.7185306644799, 1573.1033311012723, 10629.04338609525, 11193.776124477505, 11203.66389008329, 11213.383263920481, 11228.943855280722, 10594.576216951333, 10876.945615271932, 10964.396958167297, 11079.335239885613, 11107.666769996913, 2312.7918487336137, 2347.495288512969, 2352.6353415220583, 2353.3881190890406, 2353.9176128835493, 1970.448274483147, 1993.6112458070681, 2046.6827641715558, 2247.6179049561615, 2303.7005189325364, 2286.131270117353, 2288.7711228877147, 2319.6288593824993, 2320.153144102407, 2326.5230627721276, 1894.355918987551, 2280.680704701335, 2284.668723035167, 2284.7029886114697, 2296.7932886040253, 2260.5365899990625, 2321.442853715113, 2322.2452702871633, 2325.186184835311, 2330.1727886600183, 10950.959658832398, 10982.670519884416, 10984.835227471594, 10987.560497580087, 10991.505382257817, 4609.147307748044, 5581.832545023656, 5614.663120212759, 5621.156826476021, 5623.212750214973, 3262.4780035194253, 3368.6294507604143, 3536.504889315498, 3538.292341531704, 3541.557305336833, 1213.7936550786387, 1214.2471667566076, 1784.5895444047942, 1802.7295905614133, 1899.259288877339, 13087.88752956, 15269.694606107816, 15368.692626147415, 15596.98619589723, 15597.76603350962, 4348.760818154969, 4449.28811390176, 4466.218411777926, 4580.427446569179, 4586.908261834745, 11426.08591312693, 11436.313821170756, 11442.199046066862, 11442.94278528602, 11443.485043173077, 5513.393526712059, 5515.310586176728, 5516.227728118067, 5518.089515230023, 5530.917036244459, 4929.679570827885, 5037.823676171316, 5098.872528186825, 5114.951434955825, 5123.795048198031, 3663.670269675742, 3714.257148570297, 3744.0826997385816, 3772.0946972726897, 3792.867249646249, 956.7177682583655, 967.4292167621137, 972.1348000279756, 982.1749730226501, 986.3292960786733, 912.5346073502561, 920.5354032940187, 922.6586163119689, 937.1799675284126, 980.0738302304254, 6370.968145159244, 6455.902496575593, 6462.741490340428, 6480.222373315232, 6540.411362977355, 945.2438049560325, 956.2923436656824, 964.3297907953905, 964.782923842144, 966.917811985975, 3947.6644485219076, 4093.672506199497, 4219.683523735732, 4231.322988321916, 4243.087736136684, 11592.492975913077, 13588.660283492993, 13711.314434278247, 13711.794323085162, 13715.451381944611, 11979.0, 13309.201447912963, 13648.0, 13657.726845463234, 13897.930510347383, 8106.513609183467, 8892.0, 9062.909370906207, 9200.723978280663, 10081.193504519768, 6233.933480274364, 6494.415502604788, 6642.933570664231, 6665.766698165541, 6769.255381907888, 12117.030637548798, 12157.69605759863, 12340.629781106582, 12378.81431778506, 12381.0, 12255.877441225473, 12388.256704597752, 12588.0, 12687.30219837881, 12789.104762666524, 8384.832303353776, 8459.788505287417, 8466.238038576557, 8545.700900468453, 8566.05773364917, 10097.141742951932, 10111.24165687591, 10220.744481388025, 10231.539580718736, 10243.0, 8796.340274479311, 8932.0, 9014.549272536216, 9014.684486042957, 9049.0, 8690.435121717068, 8740.388172827841, 8761.605727742139, 8804.911950880409, 8986.14631609996, 7677.769666910001, 7840.215978402342, 7846.725364612211, 7847.764567062997, 7849.411294153076, 5653.660780353028, 5666.2350582670815, 5712.942870571241, 5836.416358364129, 5879.823605291848, 5589.0, 5652.63257888236, 5831.970840145772, 5895.587308888336, 6048.969755151196], "value": 5035.861036925366, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [347.05600765916705, 368.6654311392759, 383.2660455228236, 385.0969476577425, 387.56979752474746, 4871.342368780213, 4955.4548999610015, 5099.949000509994, 5133.768980395882, 5198.0, 4227.682923780713, 5006.824761133361, 5020.573251273646, 5025.3467049283545, 5093.770780314885, 4192.448793946244, 4194.958050419503, 4241.27898257297, 4270.423492828475, 4281.636060934817, 3996.840126394941, 4005.299072662287, 4033.2740106780766, 4207.305794543897, 4261.509926358462, 3906.7069969752242, 3967.801609919507, 4116.444280022203, 4141.295979683461, 4198.307279298912, 3575.928481430383, 3604.621514740954, 3882.301185786557, 4155.605217504332, 4199.118185181115, 3828.7511311764924, 3835.7506762060375, 3836.7122465814896, 3901.0637447012796, 3903.687704983623, 4707.8587642370785, 4722.881927951795, 4995.5753760930365, 5025.120603894304, 5065.518775716301, 4718.8584342469785, 4820.566149046603, 4832.395950506187, 4846.200376937801, 4866.391701037371, 4548.0886437663585, 5296.708681022542, 5355.705436201008, 5370.374996877132, 5383.407825139271, 3864.246471937973, 4315.921019745064, 4322.0, 4401.823927042915, 4407.515173330931, 5053.065182941131, 5172.379314482287, 5287.757377016398, 5527.866787308592, 5648.576356773217, 4299.656687105473, 4430.62339701129, 4445.266531022345, 4458.888527786767, 4513.074819662027, 3891.922161556753, 4495.257892685459, 4495.865124046284, 4505.7158709767555, 4511.548845115462, 3947.802280153028, 4208.9789551052045, 4371.409859668904, 4860.805567777249, 4888.169011268093, 4893.657443978958, 5336.386315573681, 5426.484483974095, 5428.941356435536, 5461.7711015021305, 1501.8360770403026, 1538.0617823127884, 1540.1683091130888, 1544.8259322914666, 1575.8818088643397, 1067.4182570499097, 1156.3871148291419, 1159.368144361325, 1159.907207423404, 1206.312401930891, 4957.3307603473795, 4968.478309777493, 4973.676711013773, 5003.2745251938995, 5143.254228136899, 5728.193185339237, 5747.683877386784, 5752.570520699039, 5763.9135412968835, 5776.873509665575, 4856.6886940526565, 4942.4316203637045, 4961.627877909171, 5094.293411707045, 5190.624484511607, 2527.8609676467972, 2567.537843188207, 2889.2199106241196, 2895.364119272604, 2900.7824413169096, 5207.062728708869, 5287.841364759063, 5544.362398324244, 5772.278465191851, 5898.262717160355, 4909.631777616693, 5432.320959880015, 5443.863903402367, 5638.915416268759, 5650.406707295757, 5084.8220312288895, 5343.732813359395, 5751.677114263659, 5761.740721667535, 5833.7374818133285, 4510.797014134306, 4678.836240731558, 4995.55721375936, 5540.390557038803, 5609.158626206102, 4605.844996177629, 4723.858284251341, 5380.063177256263, 5415.647982881258, 5583.832485025456, 5016.297718319511, 5256.817216126341, 5431.321084864392, 5589.385167631639, 5590.440955904377, 3739.8691045813266, 3786.905327366838, 4041.9393709093797, 4091.8697196645185, 4178.937315940202, 4869.634777391639, 4899.877503062452, 5391.703456309784, 5595.412481689364, 5628.352739434854, 5318.234518050669, 5357.866053348697, 5365.2220428036935, 5371.892562148657, 5454.754536045967, 4915.5330243626795, 5207.344254430343, 5244.659097158673, 5359.410464848941, 5415.620906536662, 4376.059147283349, 4577.002063648316, 4816.903661926672, 5277.437729532627, 5300.284461597635, 4765.547273009059, 5227.529522343008, 5308.230306605597, 5343.996001499438, 5373.328333958255, 4833.854984350334, 5056.140456122542, 5328.920066199088, 5402.270693456333, 5492.80775172867], "value": 4138.317930598253, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [720.4704542161508, 735.6358602491767, 743.5835931878148, 781.6326326626487, 847.7838151271425, 12145.0, 14074.0, 14451.494197703083, 14558.05372650777, 14564.05333653313, 14307.570772876805, 14317.212553309564, 14318.069325493836, 14322.570322890304, 14423.711525769479, 927.9025702301262, 947.8815148106487, 973.897740737223, 983.5721461164417, 986.1026465916018, 955.928305377096, 962.0764066496172, 971.218169373654, 974.3861367338602, 976.9853452198223, 1023.4115383654391, 1025.7692019295673, 1026.6612018034032, 1027.4195079779938, 1027.7379268286613, 1016.7305663999047, 1020.6631811502224, 1021.6219998600491, 1021.887592364843, 1022.1260821997159, 760.232165512836, 762.5310434083054, 762.980925476862, 763.5800309829627, 763.9809004774869, 14869.330880110312, 15612.063276203351, 15650.295736691876, 16077.839221607868, 16305.918470407572, 10903.83644245337, 11639.35983520906, 13826.516071937434, 13881.167129972133, 14216.502422415166, 11438.428078596036, 11748.941255293754, 11845.822312665317, 11856.822147667792, 12149.210301330386, 3632.237230181665, 3683.465897444882, 3693.242885208526, 3707.277080969212, 3722.7766334020043, 97164.05671886593, 99793.51135687607, 100219.0, 102507.0, 125131.0, 9101.544922753968, 10665.626703065356, 10702.411367374869, 11307.208495405243, 11369.033632141196, 22788.772112278995, 22843.885780570992, 22854.0, 22901.541969160524, 22955.655665165035, 7331.120265568166, 7508.587027713528, 7571.772846814604, 7655.311022008046, 7862.449628526063, 4262.147570485853, 4275.03811642378, 4303.376010478463, 4340.804663790137, 4454.0, 3397.286569820316, 3493.615702272748, 3496.947545786815, 3498.8075655839175, 3501.0197144799495, 548.4241546376289, 597.1937883856846, 598.5002522893433, 602.6414283501309, 603.062238219564, 661.2230629010893, 676.6379986707088, 679.9694013769392, 697.9042902642904, 701.3232230897107, 8242.711505097293, 9984.20126389887, 10090.041446062613, 10492.895071049192, 10789.46052697362, 608.622653954551, 612.791650838717, 644.3138057968249, 646.7186773753432, 650.72344253692, 4631.93052104212, 4985.725785081855, 4988.775505102279, 4989.0, 4998.600111991032, 96287.34294326637, 104968.47515762372, 108273.37589936158, 109602.45198773955, 109846.0, 94162.0583794167, 94729.0, 95721.0, 95864.52067739617, 98014.01985980192, 83384.0, 84109.0, 84520.57739711262, 84659.5767021161, 84733.57633211794, 9663.13031827139, 9670.0, 9674.70975870725, 9694.46680432583, 9770.31607787448, 53062.0, 53535.0, 54558.0, 55390.72304638451, 56154.75380984715, 66116.0, 67157.66421167862, 67487.0, 68273.0, 68357.3164268351, 11422.714432139262, 11565.479553420284, 11657.475413606238, 11689.649310520697, 12273.754524909273, 12514.707561548237, 12557.434915428645, 12747.553835615709, 13119.212847229197, 13186.80219796723, 11229.71925701864, 11656.125790565571, 11923.880761192624, 11968.46141923598, 12136.696582585506, 11923.165378423428, 12035.0, 12057.51769929228, 12170.57402990891, 12850.357482126043, 11538.192326537062, 11643.359615221245, 11958.342291174069, 12018.579349722717, 12525.874741252472, 10222.846657300295, 10227.232957528066, 10349.379037257788, 10631.149508039493, 10758.682589942344, 9968.352057116264, 10074.496275186359, 10115.0, 10155.593776248867, 10168.135708464568], "value": 7491.481359991177, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1427.1, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 115.0, 115.0, 115.0, 114.0, 115.0, 116.0, 115.0, 116.0, 117.0], "value": 115.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 110.0, 108.0, 142.0, 109.0, 112.0, 128.0, 132.0, 135.0, 109.0], "value": 121.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [187.0, 186.0, 183.0, 185.0, 186.0, 183.0, 183.0, 183.0, 184.0, 182.0], "value": 184.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 60.0, 58.0, 91.0, 65.0, 62.0, 61.0, 61.0, 76.0, 59.0], "value": 67.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 69.0, 87.0, 69.0, 70.0, 69.0, 82.0, 68.0, 68.0, 83.0], "value": 75.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 86.0, 86.0, 86.0, 86.0, 87.0, 86.0, 85.0, 86.0], "value": 86.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 93.0, 94.0, 94.0, 94.0, 94.0, 103.0, 93.0, 93.0, 94.0], "value": 94.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 82.0, 83.0, 84.0, 86.0, 83.0, 82.0, 86.0, 83.0], "value": 83.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 63.0, 60.0, 67.0, 92.0, 96.0, 97.0, 78.0, 64.0], "value": 74.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 60.0, 59.0, 64.0, 59.0, 56.0, 58.0, 58.0, 57.0, 59.0], "value": 58.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 83.0, 83.0, 79.0, 78.0, 85.0, 82.0, 84.0, 90.0], "value": 83.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 140.0, 138.0, 139.0, 135.0, 137.0, 138.0, 140.0, 218.0, 143.0], "value": 146.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 165.0, 168.0, 165.0, 165.0, 164.0, 161.0, 166.0, 214.0, 174.0], "value": 170.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 62.0, 65.0, 64.0, 64.0, 62.0, 63.0, 64.0, 65.0, 65.0], "value": 63.8, "unit": "score"}]}]} 09:20:12 INFO - Return code: 0 09:20:12 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:20:12 ERROR - # TBPL SUCCESS # 09:20:12 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:20:12 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:20:12 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:20:12 INFO - 2017-03-09 09:20:12.344 screenresolution[6502:122992] starting screenresolution argv=screenresolution get 09:20:12 INFO - 2017-03-09 09:20:12.347 screenresolution[6502:122992] Display 0: 1600x1200x32@60 09:20:12 INFO - 2017-03-09 09:20:12.353 screenresolution[6503:122995] starting screenresolution argv=screenresolution list 09:20:12 INFO - Available Modes on Display 0 09:20:12 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:20:12 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:20:12 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:20:12 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:20:12 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:20:12 INFO - Intel Iris: 09:20:12 INFO - Chipset Model: Intel Iris 09:20:12 INFO - Type: GPU 09:20:12 INFO - Bus: Built-In 09:20:12 INFO - VRAM (Dynamic, Max): 1536 MB 09:20:12 INFO - Vendor: Intel (0x8086) 09:20:12 INFO - Device ID: 0x0a2e 09:20:12 INFO - Revision ID: 0x0009 09:20:12 INFO - Displays: 09:20:12 INFO - Display: 09:20:12 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:20:12 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:20:12 INFO - Display Serial Number: 1600x1200 60 09:20:12 INFO - Main Display: Yes 09:20:12 INFO - Mirror: Off 09:20:12 INFO - Online: Yes 09:20:12 INFO - Rotation: Supported 09:20:12 INFO - Return code: 0 09:20:12 INFO - Running post-action listener: _resource_record_post_action 09:20:12 INFO - [mozharness: 2017-03-09 17:20:12.587402Z] Finished run-tests step (success) 09:20:12 INFO - Running post-run listener: _resource_record_post_run 09:20:12 INFO - Total resource usage - Wall time: 1202s; CPU: 54.0%; Read bytes: 1379328; Write bytes: 509634560; Read time: 16; Write time: 1549 09:20:12 INFO - TinderboxPrint: CPU usage
54.0% 09:20:12 INFO - TinderboxPrint: I/O read bytes / time
1,379,328 / 16 09:20:12 INFO - TinderboxPrint: I/O write bytes / time
509,634,560 / 1,549 09:20:12 INFO - TinderboxPrint: CPU idle
2,214.0 (46.0%) 09:20:12 INFO - TinderboxPrint: CPU system
961.4 (20.0%) 09:20:12 INFO - TinderboxPrint: CPU user
1,634.4 (34.0%) 09:20:12 INFO - TinderboxPrint: Swap in / out
210,763,776 / 0 09:20:12 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 205990400; Write bytes: 202635264; Read time: 15761; Write time: 412 09:20:12 INFO - run-tests - Wall time: 1183s; CPU: 54.0%; Read bytes: 1264640; Write bytes: 295903232; Read time: 15; Write time: 1097 09:20:13 INFO - Running post-run listener: _upload_blobber_files 09:20:13 INFO - Blob upload gear active. 09:20:13 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:20:13 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 09:20:13 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'] 09:20:13 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 09:20:13 INFO - (blobuploader) - INFO - Open directory for files ... 09:20:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:20:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:20:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:20:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:20:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:20:14 INFO - (blobuploader) - INFO - Done attempting. 09:20:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:20:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:20:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:20:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:20:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:20:15 INFO - (blobuploader) - INFO - Done attempting. 09:20:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 09:20:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:20:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:20:15 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 09:20:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:20:15 INFO - (blobuploader) - INFO - Done attempting. 09:20:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:20:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:20:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:20:18 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:20:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:20:18 INFO - (blobuploader) - INFO - Done attempting. 09:20:18 INFO - (blobuploader) - INFO - Iteration through files over. 09:20:18 INFO - Return code: 0 09:20:18 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:20:18 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:20:18 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/af18a92bbe88bd1461761299976fea3d5837a282487b2ec3c5d7a2b1bf5ba39dd074e765201ad72fe2e943fbe771303308812834593044ff8d8c994f533c1c3c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8c0da51b563f44457acd15dab2fd8c8a3793ece098bf9621455d7872c8c1245a02428a72d911dc629328b2429790bd2de3feee24bba1e20534d0a89f4dabaee8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/45b0340aec56a34211f26646cad194808f682c24c0ca4f3803453af72ca2da30634d666bd62f913a6b3a3c5c82106aa86f8975cc9b8f026a7beffbe31ba4079a", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4872d23bf2033e57a6491afe98c188c18cb8a636629d2f0bb59a2dbeb9a9c95fc62b5ec3dd23fb62326135900ee320527c362d0a75994149c8f4c2076c6e76f2"} 09:20:18 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:20:18 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:20:18 INFO - Contents: 09:20:18 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/af18a92bbe88bd1461761299976fea3d5837a282487b2ec3c5d7a2b1bf5ba39dd074e765201ad72fe2e943fbe771303308812834593044ff8d8c994f533c1c3c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8c0da51b563f44457acd15dab2fd8c8a3793ece098bf9621455d7872c8c1245a02428a72d911dc629328b2429790bd2de3feee24bba1e20534d0a89f4dabaee8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/45b0340aec56a34211f26646cad194808f682c24c0ca4f3803453af72ca2da30634d666bd62f913a6b3a3c5c82106aa86f8975cc9b8f026a7beffbe31ba4079a", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4872d23bf2033e57a6491afe98c188c18cb8a636629d2f0bb59a2dbeb9a9c95fc62b5ec3dd23fb62326135900ee320527c362d0a75994149c8f4c2076c6e76f2"} 09:20:18 INFO - Running post-run listener: copy_logs_to_upload_dir 09:20:18 INFO - Copying logs to upload dir... 09:20:18 INFO - mkdir: /builds/slave/test/build/upload/logs 09:20:18 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1282.073845 ========= master_lag: 2.73 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 24 secs) (at 2017-03-09 09:20:20.984264) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-09 09:20:20.987470) ========= 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.52n0KLSWPF/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.3nP71L5h4l/Listeners TMPDIR=/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/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/af18a92bbe88bd1461761299976fea3d5837a282487b2ec3c5d7a2b1bf5ba39dd074e765201ad72fe2e943fbe771303308812834593044ff8d8c994f533c1c3c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8c0da51b563f44457acd15dab2fd8c8a3793ece098bf9621455d7872c8c1245a02428a72d911dc629328b2429790bd2de3feee24bba1e20534d0a89f4dabaee8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/45b0340aec56a34211f26646cad194808f682c24c0ca4f3803453af72ca2da30634d666bd62f913a6b3a3c5c82106aa86f8975cc9b8f026a7beffbe31ba4079a", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4872d23bf2033e57a6491afe98c188c18cb8a636629d2f0bb59a2dbeb9a9c95fc62b5ec3dd23fb62326135900ee320527c362d0a75994149c8f4c2076c6e76f2"} build_url:https://queue.taskcluster.net/v1/task/DJ2IoMlAT-aayifG8cndxQ/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011399 build_url: 'https://queue.taskcluster.net/v1/task/DJ2IoMlAT-aayifG8cndxQ/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/af18a92bbe88bd1461761299976fea3d5837a282487b2ec3c5d7a2b1bf5ba39dd074e765201ad72fe2e943fbe771303308812834593044ff8d8c994f533c1c3c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8c0da51b563f44457acd15dab2fd8c8a3793ece098bf9621455d7872c8c1245a02428a72d911dc629328b2429790bd2de3feee24bba1e20534d0a89f4dabaee8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/45b0340aec56a34211f26646cad194808f682c24c0ca4f3803453af72ca2da30634d666bd62f913a6b3a3c5c82106aa86f8975cc9b8f026a7beffbe31ba4079a", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4872d23bf2033e57a6491afe98c188c18cb8a636629d2f0bb59a2dbeb9a9c95fc62b5ec3dd23fb62326135900ee320527c362d0a75994149c8f4c2076c6e76f2"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-09 09:20:21.026458) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-09 09:20:21.026781) ========= 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.52n0KLSWPF/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.3nP71L5h4l/Listeners TMPDIR=/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/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.005379 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-09 09:20:21.076737) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-09 09:20:21.077166) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-09 09:20:21.077607) ========= ========= Total master_lag: 2.88 =========