builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0022 starttime: 1494435043.38 results: success (0) buildid: 20170509092824 builduid: c1cc6ebbdb7a4cdeb7b37fa552aa6c40 revision: 4ac208f317b37f7ed2e669d5ca23064ebc979103 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-10 09:50:43.382543) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-10 09:50:43.383305) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-10 09:50:43.383918) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-10 09:50:43.413138) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-10 09:50:43.413707) ========= 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.w1oewBjS4H/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.b5TpYj8dlu/Listeners TMPDIR=/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/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-05-10 09:50:43-- 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% 13.7M=0.001s 2017-05-10 09:50:43 (13.7 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.127430 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-10 09:50:43.566745) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-10 09:50:43.567099) ========= 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.w1oewBjS4H/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.b5TpYj8dlu/Listeners TMPDIR=/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/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.036687 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-10 09:50:43.626588) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-05-10 09:50:43.627074) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 4ac208f317b37f7ed2e669d5ca23064ebc979103 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 4ac208f317b37f7ed2e669d5ca23064ebc979103 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.w1oewBjS4H/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.b5TpYj8dlu/Listeners TMPDIR=/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/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-05-10 09:50:43,740 truncating revision to first 12 chars 2017-05-10 09:50:43,740 Setting DEBUG logging. 2017-05-10 09:50:43,740 attempt 1/10 2017-05-10 09:50:43,740 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/4ac208f317b3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-10 09:50:45,488 unpacking tar archive at: mozilla-beta-4ac208f317b3/testing/mozharness/ program finished with exit code 0 elapsedTime=2.034695 ========= master_lag: 0.28 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-05-10 09:50:45.939822) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-10 09:50:45.940244) ========= script_repo_revision: 4ac208f317b37f7ed2e669d5ca23064ebc979103 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-10 09:50:45.940712) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-10 09:50:45.941066) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-10 09:50:45.961392) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2017-05-10 09:50:45.961746) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.w1oewBjS4H/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.b5TpYj8dlu/Listeners TMPDIR=/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 09:50:46 INFO - MultiFileLogger online at 20170510 09:50:46 in /builds/slave/test 09:50:46 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 09:50:46 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:50:46 INFO - {'append_to_log': False, 09:50:46 INFO - 'base_work_dir': '/builds/slave/test', 09:50:46 INFO - 'blob_upload_branch': 'Mozilla-Beta', 09:50:46 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:50:46 INFO - 'branch': 'Mozilla-Beta', 09:50:46 INFO - 'buildbot_json_path': 'buildprops.json', 09:50:46 INFO - 'config_files': ('talos/mac_config.py',), 09:50:46 INFO - 'default_actions': ('clobber', 09:50:46 INFO - 'read-buildbot-config', 09:50:46 INFO - 'download-and-extract', 09:50:46 INFO - 'populate-webroot', 09:50:46 INFO - 'create-virtualenv', 09:50:46 INFO - 'install', 09:50:46 INFO - 'run-tests'), 09:50:46 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:50:46 INFO - 'download_minidump_stackwalk': True, 09:50:46 INFO - 'download_symbols': 'ondemand', 09:50:46 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:50:46 INFO - 'tooltool.py': '/tools/tooltool.py', 09:50:46 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:50:46 INFO - '/tools/misc-python/virtualenv.py')}, 09:50:46 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:50:46 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:50:46 INFO - 'gecko_profile': False, 09:50:46 INFO - 'gecko_profile_interval': 0, 09:50:46 INFO - 'installer_path': 'installer.exe', 09:50:46 INFO - 'log_level': 'info', 09:50:46 INFO - 'log_name': 'talos', 09:50:46 INFO - 'log_to_console': True, 09:50:46 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 09:50:46 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 09:50:46 INFO - 'opt_config_files': (), 09:50:46 INFO - 'pip_index': False, 09:50:46 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:50:46 INFO - 'cmd': ('bash', 09:50:46 INFO - '-c', 09:50:46 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:50:46 INFO - 'enabled': True, 09:50:46 INFO - 'halt_on_failure': False, 09:50:46 INFO - 'name': 'check_screen_resolution'},), 09:50:46 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:50:46 INFO - 'cmd': ('bash', 09:50:46 INFO - '-c', 09:50:46 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:50:46 INFO - 'enabled': True, 09:50:46 INFO - 'halt_on_failure': False, 09:50:46 INFO - 'name': 'check_screen_resolution'},), 09:50:46 INFO - 'run_cmd_checks_enabled': True, 09:50:46 INFO - 'suite': 'dromaeojs', 09:50:46 INFO - 'system_bits': '32', 09:50:46 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:50:46 INFO - 'title': 't-yosemite-r7-0022', 09:50:46 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:50:46 INFO - 'use_talos_json': True, 09:50:46 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:50:46 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:50:46 INFO - 'work_dir': 'build'} 09:50:46 INFO - [mozharness: 2017-05-10 16:50:46.182960Z] Running clobber step. 09:50:46 INFO - Running pre-action listener: _resource_record_pre_action 09:50:46 INFO - Running main action method: clobber 09:50:46 INFO - rmtree: /builds/slave/test/build 09:50:46 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:50:48 INFO - Running post-action listener: _resource_record_post_action 09:50:48 INFO - [mozharness: 2017-05-10 16:50:48.823877Z] Finished clobber step (success) 09:50:48 INFO - [mozharness: 2017-05-10 16:50:48.824138Z] Running read-buildbot-config step. 09:50:48 INFO - Running pre-action listener: _resource_record_pre_action 09:50:48 INFO - Running main action method: read_buildbot_config 09:50:48 INFO - Using buildbot properties: 09:50:48 INFO - { 09:50:48 INFO - "project": "", 09:50:48 INFO - "product": "firefox", 09:50:48 INFO - "script_repo_revision": "production", 09:50:48 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 09:50:48 INFO - "repository": "", 09:50:48 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 09:50:48 INFO - "buildid": "20170509092824", 09:50:48 INFO - "pgo_build": "False", 09:50:48 INFO - "basedir": "/builds/slave/test", 09:50:48 INFO - "buildnumber": 8, 09:50:48 INFO - "slavename": "t-yosemite-r7-0022", 09:50:48 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 09:50:48 INFO - "platform": "yosemite_r7", 09:50:48 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 09:50:48 INFO - "branch": "mozilla-beta", 09:50:48 INFO - "repo_path": "releases/mozilla-beta", 09:50:48 INFO - "revision": "4ac208f317b37f7ed2e669d5ca23064ebc979103", 09:50:48 INFO - "stage_platform": "macosx64", 09:50:48 INFO - "builduid": "c1cc6ebbdb7a4cdeb7b37fa552aa6c40", 09:50:48 INFO - "slavebuilddir": "test" 09:50:48 INFO - } 09:50:48 INFO - Found installer url https://queue.taskcluster.net/v1/task/diq9pxQVRB6jX2zUUFIpTw/artifacts/public/build/firefox-54.0.en-US.mac.dmg. 09:50:48 INFO - Running post-action listener: _resource_record_post_action 09:50:48 INFO - [mozharness: 2017-05-10 16:50:48.829955Z] Finished read-buildbot-config step (success) 09:50:48 INFO - [mozharness: 2017-05-10 16:50:48.830177Z] Running download-and-extract step. 09:50:48 INFO - Running pre-action listener: _resource_record_pre_action 09:50:48 INFO - Running main action method: download_and_extract 09:50:48 INFO - mkdir: /builds/slave/test/build/tests 09:50:48 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:50:48 INFO - trying https://queue.taskcluster.net/v1/task/diq9pxQVRB6jX2zUUFIpTw/artifacts/public/build/firefox-54.0.en-US.mac.test_packages.json 09:50:48 INFO - Downloading https://queue.taskcluster.net/v1/task/diq9pxQVRB6jX2zUUFIpTw/artifacts/public/build/firefox-54.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0.en-US.mac.test_packages.json 09:50:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/diq9pxQVRB6jX2zUUFIpTw/artifacts/public/build/firefox-54.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-54.0.en-US.mac.test_packages.json'}, attempt #1 09:50:49 INFO - Downloaded 1287 bytes. 09:50:49 INFO - Reading from file /builds/slave/test/build/firefox-54.0.en-US.mac.test_packages.json 09:50:49 INFO - Using the following test package requirements: 09:50:49 INFO - {u'awsy': [u'firefox-54.0.en-US.mac.common.tests.zip', 09:50:49 INFO - u'firefox-54.0.en-US.mac.awsy.tests.zip'], 09:50:49 INFO - u'common': [u'firefox-54.0.en-US.mac.common.tests.zip'], 09:50:49 INFO - u'cppunittest': [u'firefox-54.0.en-US.mac.common.tests.zip', 09:50:49 INFO - u'firefox-54.0.en-US.mac.cppunittest.tests.zip'], 09:50:49 INFO - u'gtest': [u'firefox-54.0.en-US.mac.common.tests.zip', 09:50:49 INFO - u'firefox-54.0.en-US.mac.gtest.tests.zip'], 09:50:49 INFO - u'jittest': [u'firefox-54.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 09:50:49 INFO - u'mochitest': [u'firefox-54.0.en-US.mac.common.tests.zip', 09:50:49 INFO - u'firefox-54.0.en-US.mac.mochitest.tests.zip'], 09:50:49 INFO - u'mozbase': [u'firefox-54.0.en-US.mac.common.tests.zip'], 09:50:49 INFO - u'reftest': [u'firefox-54.0.en-US.mac.common.tests.zip', 09:50:49 INFO - u'firefox-54.0.en-US.mac.reftest.tests.zip'], 09:50:49 INFO - u'talos': [u'firefox-54.0.en-US.mac.common.tests.zip', 09:50:49 INFO - u'firefox-54.0.en-US.mac.talos.tests.zip'], 09:50:49 INFO - u'web-platform': [u'firefox-54.0.en-US.mac.common.tests.zip', 09:50:49 INFO - u'firefox-54.0.en-US.mac.web-platform.tests.zip'], 09:50:49 INFO - u'xpcshell': [u'firefox-54.0.en-US.mac.common.tests.zip', 09:50:49 INFO - u'firefox-54.0.en-US.mac.xpcshell.tests.zip']} 09:50:49 INFO - Downloading packages: [u'firefox-54.0.en-US.mac.common.tests.zip'] for test suite category: common 09:50:49 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/diq9pxQVRB6jX2zUUFIpTw/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip 09:50:49 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/diq9pxQVRB6jX2zUUFIpTw/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip'}, attempt #1 09:50:49 INFO - Fetch https://queue.taskcluster.net/v1/task/diq9pxQVRB6jX2zUUFIpTw/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip into memory 09:50:51 INFO - Expected file size: 51223859 09:50:51 INFO - Obtained file size: 51223859 09:51:07 INFO - Downloading packages: [u'firefox-54.0.en-US.mac.common.tests.zip', u'firefox-54.0.en-US.mac.talos.tests.zip'] for test suite category: talos 09:51:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/diq9pxQVRB6jX2zUUFIpTw/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip 09:51:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/diq9pxQVRB6jX2zUUFIpTw/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip'}, attempt #1 09:51:07 INFO - Fetch https://queue.taskcluster.net/v1/task/diq9pxQVRB6jX2zUUFIpTw/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip into memory 09:51:09 INFO - Expected file size: 51223859 09:51:09 INFO - Obtained file size: 51223859 09:51:24 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/diq9pxQVRB6jX2zUUFIpTw/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip 09:51:24 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/diq9pxQVRB6jX2zUUFIpTw/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip'}, attempt #1 09:51:24 INFO - Fetch https://queue.taskcluster.net/v1/task/diq9pxQVRB6jX2zUUFIpTw/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip into memory 09:51:25 INFO - Expected file size: 14404449 09:51:25 INFO - Obtained file size: 14404449 09:51:26 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:51:26 INFO - trying https://queue.taskcluster.net/v1/task/diq9pxQVRB6jX2zUUFIpTw/artifacts/public/build/firefox-54.0.en-US.mac.dmg 09:51:26 INFO - Downloading https://queue.taskcluster.net/v1/task/diq9pxQVRB6jX2zUUFIpTw/artifacts/public/build/firefox-54.0.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0.en-US.mac.dmg 09:51:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/diq9pxQVRB6jX2zUUFIpTw/artifacts/public/build/firefox-54.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0.en-US.mac.dmg'}, attempt #1 09:51:27 INFO - Downloaded 59570664 bytes. 09:51:27 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/diq9pxQVRB6jX2zUUFIpTw/artifacts/public/build/firefox-54.0.en-US.mac.dmg 09:51:27 INFO - mkdir: /builds/slave/test/properties 09:51:27 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:51:27 INFO - Writing to file /builds/slave/test/properties/build_url 09:51:27 INFO - Contents: 09:51:27 INFO - build_url:https://queue.taskcluster.net/v1/task/diq9pxQVRB6jX2zUUFIpTw/artifacts/public/build/firefox-54.0.en-US.mac.dmg 09:51:28 INFO - Running post-action listener: _resource_record_post_action 09:51:28 INFO - Running post-action listener: set_extra_try_arguments 09:51:28 INFO - [mozharness: 2017-05-10 16:51:28.512325Z] Finished download-and-extract step (success) 09:51:28 INFO - [mozharness: 2017-05-10 16:51:28.512453Z] Running populate-webroot step. 09:51:28 INFO - Running pre-action listener: _resource_record_pre_action 09:51:28 INFO - Running main action method: populate_webroot 09:51:28 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:51:28 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:51:28 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:51:28 INFO - '--tppagecycles', 09:51:28 INFO - '7'], 09:51:28 INFO - 'tests': ['tsvgm']}}, 09:51:28 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:51:28 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:51:28 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:51:28 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:51:28 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:51:28 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:51:28 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 09:51:28 INFO - 'talos_options': ['--disable-e10s'], 09:51:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:51:28 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 09:51:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:51:28 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 09:51:28 INFO - 'talos_options': ['--disable-e10s'], 09:51:28 INFO - 'tests': ['damp', 'tps']}, 09:51:28 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 09:51:28 INFO - 'tests': ['damp', 'tps']}, 09:51:28 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:51:28 INFO - 'tests': ['dromaeo_dom']}, 09:51:28 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:51:28 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:51:28 INFO - 'tests': ['basic_compositor_video']}, 09:51:28 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:51:28 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:51:28 INFO - 'tests': ['a11yr', 09:51:28 INFO - 'ts_paint', 09:51:28 INFO - 'tpaint', 09:51:28 INFO - 'sessionrestore', 09:51:28 INFO - 'sessionrestore_no_auto_restore', 09:51:28 INFO - 'tabpaint']}, 09:51:28 INFO - 'other-e10s': {'tests': ['a11yr', 09:51:28 INFO - 'ts_paint', 09:51:28 INFO - 'tpaint', 09:51:28 INFO - 'sessionrestore', 09:51:28 INFO - 'sessionrestore_no_auto_restore', 09:51:28 INFO - 'tabpaint']}, 09:51:28 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:51:28 INFO - 'ts_paint', 09:51:28 INFO - 'tpaint', 09:51:28 INFO - 'sessionrestore', 09:51:28 INFO - 'sessionrestore_no_auto_restore', 09:51:28 INFO - 'tabpaint']}, 09:51:28 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:51:28 INFO - 'ts_paint', 09:51:28 INFO - 'tpaint', 09:51:28 INFO - 'sessionrestore', 09:51:28 INFO - 'sessionrestore_no_auto_restore', 09:51:28 INFO - 'tabpaint']}, 09:51:28 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:51:28 INFO - 'tests': ['a11yr', 09:51:28 INFO - 'ts_paint', 09:51:28 INFO - 'tpaint', 09:51:28 INFO - 'sessionrestore', 09:51:28 INFO - 'sessionrestore_no_auto_restore', 09:51:28 INFO - 'tabpaint']}, 09:51:28 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:51:28 INFO - 'tests': ['a11yr', 09:51:28 INFO - 'ts_paint', 09:51:28 INFO - 'tpaint', 09:51:28 INFO - 'sessionrestore', 09:51:28 INFO - 'sessionrestore_no_auto_restore', 09:51:28 INFO - 'tabpaint']}, 09:51:28 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:51:28 INFO - 'tests': ['tsvgx', 09:51:28 INFO - 'tsvgr_opacity', 09:51:28 INFO - 'tart', 09:51:28 INFO - 'tscrollx', 09:51:28 INFO - 'cart', 09:51:28 INFO - 'tsvg_static']}, 09:51:28 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:51:28 INFO - 'tsvgr_opacity', 09:51:28 INFO - 'tart', 09:51:28 INFO - 'tscrollx', 09:51:28 INFO - 'cart', 09:51:28 INFO - 'tsvg_static']}, 09:51:28 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 09:51:28 INFO - 'talos_options': ['--disable-e10s'], 09:51:28 INFO - 'tests': ['tp5o']}, 09:51:28 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 09:51:28 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 09:51:28 INFO - 'talos_options': ['--disable-e10s', 09:51:28 INFO - '--xperf_path', 09:51:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:51:28 INFO - 'tests': ['tp5n']}, 09:51:28 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 09:51:28 INFO - 'talos_options': ['--xperf_path', 09:51:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:51:28 INFO - 'tests': ['tp5n']}}, 09:51:28 INFO - 'talos.zip': {'path': '', 09:51:28 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:51:28 INFO - Running post-action listener: _resource_record_post_action 09:51:28 INFO - [mozharness: 2017-05-10 16:51:28.531253Z] Finished populate-webroot step (success) 09:51:28 INFO - [mozharness: 2017-05-10 16:51:28.531386Z] Running create-virtualenv step. 09:51:28 INFO - Running pre-action listener: _resource_record_pre_action 09:51:28 INFO - Running main action method: create_virtualenv 09:51:28 INFO - Creating virtualenv /builds/slave/test/build/venv 09:51:28 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 09:51:28 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:51:28 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:51:28 INFO - Using real prefix '/tools/python27' 09:51:28 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:51:29 INFO - Installing distribute.............................................................................................................................................................................................done. 09:51:32 INFO - Installing pip.................done. 09:51:32 INFO - Return code: 0 09:51:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:51:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:51:32 INFO - Reading from file tmpfile_stdout 09:51:32 INFO - Output received: 09:51:32 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 09:51:32 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:51:32 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:51:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:51:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:32 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:51:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:51:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:32 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 0x10f2c2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f2c5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc8ead49980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f0a0d30>, '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 0x10efc7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f095be8>, '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.w1oewBjS4H/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.b5TpYj8dlu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/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:51:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 09:51:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:51:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.w1oewBjS4H/Render', 09:51:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:51:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:51:32 INFO - 'HOME': '/Users/cltbld', 09:51:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:51:32 INFO - 'LOGNAME': 'cltbld', 09:51:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:51:32 INFO - 'MOZ_NO_REMOTE': '1', 09:51:32 INFO - 'NO_EM_RESTART': '1', 09:51:32 INFO - 'PAGER': '/bin/cat', 09:51:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:51:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:51:32 INFO - 'PWD': '/builds/slave/test', 09:51:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:51:32 INFO - 'SHELL': '/bin/bash', 09:51:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.b5TpYj8dlu/Listeners', 09:51:32 INFO - 'TMPDIR': '/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/', 09:51:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:51:32 INFO - 'USER': 'cltbld', 09:51:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:51:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:51:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:51:32 INFO - 'XPC_FLAGS': '0x0', 09:51:32 INFO - 'XPC_SERVICE_NAME': '0', 09:51:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:51:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:51:32 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 09:51:32 INFO - Cleaning up... 09:51:32 INFO - Return code: 0 09:51:32 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:51:32 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:51:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:51:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:32 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:51:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:51:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:32 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 0x10f2c2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f2c5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc8ead49980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f0a0d30>, '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 0x10efc7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f095be8>, '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.w1oewBjS4H/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.b5TpYj8dlu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/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:51:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 09:51:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 09:51:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.w1oewBjS4H/Render', 09:51:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:51:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:51:32 INFO - 'HOME': '/Users/cltbld', 09:51:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:51:32 INFO - 'LOGNAME': 'cltbld', 09:51:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:51:32 INFO - 'MOZ_NO_REMOTE': '1', 09:51:32 INFO - 'NO_EM_RESTART': '1', 09:51:32 INFO - 'PAGER': '/bin/cat', 09:51:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:51:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:51:32 INFO - 'PWD': '/builds/slave/test', 09:51:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:51:32 INFO - 'SHELL': '/bin/bash', 09:51:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.b5TpYj8dlu/Listeners', 09:51:32 INFO - 'TMPDIR': '/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/', 09:51:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:51:32 INFO - 'USER': 'cltbld', 09:51:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:51:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:51:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:51:32 INFO - 'XPC_FLAGS': '0x0', 09:51:32 INFO - 'XPC_SERVICE_NAME': '0', 09:51:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:51:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:51:33 INFO - Downloading/unpacking psutil>=3.1.1 09:51:33 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:51:33 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:51:33 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:51:33 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:51:33 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:51:33 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:51:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:51:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:51:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:51:35 INFO - Installing collected packages: psutil 09:51:35 INFO - Running setup.py install for psutil 09:51:35 INFO - building 'psutil._psutil_osx' extension 09:51:35 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 09:51:36 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 09:51:36 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 09:51:36 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 09:51:36 INFO - building 'psutil._psutil_posix' extension 09:51:36 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 09:51:36 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 09:51:36 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 09:51:36 INFO - ^ 09:51:36 INFO - 1 warning generated. 09:51:36 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 09:51:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:51:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:51:36 INFO - Successfully installed psutil 09:51:36 INFO - Cleaning up... 09:51:36 INFO - Return code: 0 09:51:36 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:51:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:51:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:51:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:51:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:51:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:36 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 0x10f2c2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f2c5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc8ead49980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f0a0d30>, '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 0x10efc7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f095be8>, '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.w1oewBjS4H/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.b5TpYj8dlu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/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:51:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 09:51:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 09:51:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.w1oewBjS4H/Render', 09:51:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:51:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:51:36 INFO - 'HOME': '/Users/cltbld', 09:51:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:51:36 INFO - 'LOGNAME': 'cltbld', 09:51:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:51:36 INFO - 'MOZ_NO_REMOTE': '1', 09:51:36 INFO - 'NO_EM_RESTART': '1', 09:51:36 INFO - 'PAGER': '/bin/cat', 09:51:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:51:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:51:36 INFO - 'PWD': '/builds/slave/test', 09:51:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:51:36 INFO - 'SHELL': '/bin/bash', 09:51:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.b5TpYj8dlu/Listeners', 09:51:36 INFO - 'TMPDIR': '/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/', 09:51:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:51:36 INFO - 'USER': 'cltbld', 09:51:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:51:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:51:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:51:36 INFO - 'XPC_FLAGS': '0x0', 09:51:36 INFO - 'XPC_SERVICE_NAME': '0', 09:51:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:51:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:51:36 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:51:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:51:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:51:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:51:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:51:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:51:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:51:38 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:51:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:51:38 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:51:38 INFO - Installing collected packages: mozsystemmonitor 09:51:38 INFO - Running setup.py install for mozsystemmonitor 09:51:38 INFO - Successfully installed mozsystemmonitor 09:51:38 INFO - Cleaning up... 09:51:38 INFO - Return code: 0 09:51:38 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:51:38 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:51:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:51:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:38 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:51:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:51:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:38 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 0x10f2c2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f2c5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc8ead49980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f0a0d30>, '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 0x10efc7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f095be8>, '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.w1oewBjS4H/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.b5TpYj8dlu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/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:51:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 09:51:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 09:51:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.w1oewBjS4H/Render', 09:51:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:51:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:51:38 INFO - 'HOME': '/Users/cltbld', 09:51:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:51:38 INFO - 'LOGNAME': 'cltbld', 09:51:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:51:38 INFO - 'MOZ_NO_REMOTE': '1', 09:51:38 INFO - 'NO_EM_RESTART': '1', 09:51:38 INFO - 'PAGER': '/bin/cat', 09:51:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:51:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:51:38 INFO - 'PWD': '/builds/slave/test', 09:51:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:51:38 INFO - 'SHELL': '/bin/bash', 09:51:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.b5TpYj8dlu/Listeners', 09:51:38 INFO - 'TMPDIR': '/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/', 09:51:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:51:38 INFO - 'USER': 'cltbld', 09:51:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:51:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:51:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:51:38 INFO - 'XPC_FLAGS': '0x0', 09:51:38 INFO - 'XPC_SERVICE_NAME': '0', 09:51:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:51:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:51:38 INFO - Downloading/unpacking jsonschema==2.5.1 09:51:38 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:51:38 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:51:38 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:51:38 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:51:38 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:51:38 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:51:40 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:51:40 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:51:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:51:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:51:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:51:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:51:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:51:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:51:40 INFO - Downloading functools32-3.2.3-2.tar.gz 09:51:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:51:40 INFO - warning: no files found matching '*.txt' 09:51:40 INFO - no previously-included directories found matching 'build' 09:51:40 INFO - no previously-included directories found matching 'dist' 09:51:40 INFO - no previously-included directories found matching '.git*' 09:51:40 INFO - Installing collected packages: jsonschema, functools32 09:51:40 INFO - Running setup.py install for functools32 09:51:40 INFO - warning: no files found matching '*.txt' 09:51:40 INFO - no previously-included directories found matching 'build' 09:51:40 INFO - no previously-included directories found matching 'dist' 09:51:40 INFO - no previously-included directories found matching '.git*' 09:51:40 INFO - Successfully installed jsonschema functools32 09:51:40 INFO - Cleaning up... 09:51:40 INFO - Return code: 0 09:51:40 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:51:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:51:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:51:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51: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')]} 09:51:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:51:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51: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', '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 0x10f2c2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f2c5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc8ead49980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f0a0d30>, '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 0x10efc7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f095be8>, '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.w1oewBjS4H/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.b5TpYj8dlu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/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:51: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 09:51: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 functools32==3.2.3-2 09:51:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.w1oewBjS4H/Render', 09:51:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:51:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:51:41 INFO - 'HOME': '/Users/cltbld', 09:51:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:51:41 INFO - 'LOGNAME': 'cltbld', 09:51:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:51:41 INFO - 'MOZ_NO_REMOTE': '1', 09:51:41 INFO - 'NO_EM_RESTART': '1', 09:51:41 INFO - 'PAGER': '/bin/cat', 09:51:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:51:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:51:41 INFO - 'PWD': '/builds/slave/test', 09:51:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:51:41 INFO - 'SHELL': '/bin/bash', 09:51:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.b5TpYj8dlu/Listeners', 09:51:41 INFO - 'TMPDIR': '/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/', 09:51:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:51:41 INFO - 'USER': 'cltbld', 09:51:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:51:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:51:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:51:41 INFO - 'XPC_FLAGS': '0x0', 09:51:41 INFO - 'XPC_SERVICE_NAME': '0', 09:51:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:51:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:51:41 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:51:41 INFO - Cleaning up... 09:51:41 INFO - Return code: 0 09:51:41 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:51: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')]} 09:51:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:51:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51: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')]} 09:51:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:51:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:42 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 0x10f2c2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f2c5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc8ead49980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f0a0d30>, '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 0x10efc7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f095be8>, '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.w1oewBjS4H/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.b5TpYj8dlu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/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:51:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:51:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:51:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.w1oewBjS4H/Render', 09:51:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:51:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:51:42 INFO - 'HOME': '/Users/cltbld', 09:51:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:51:42 INFO - 'LOGNAME': 'cltbld', 09:51:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:51:42 INFO - 'MOZ_NO_REMOTE': '1', 09:51:42 INFO - 'NO_EM_RESTART': '1', 09:51:42 INFO - 'PAGER': '/bin/cat', 09:51:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:51:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:51:42 INFO - 'PWD': '/builds/slave/test', 09:51:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:51:42 INFO - 'SHELL': '/bin/bash', 09:51:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.b5TpYj8dlu/Listeners', 09:51:42 INFO - 'TMPDIR': '/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/', 09:51:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:51:42 INFO - 'USER': 'cltbld', 09:51:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:51:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:51:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:51:42 INFO - 'XPC_FLAGS': '0x0', 09:51:42 INFO - 'XPC_SERVICE_NAME': '0', 09:51:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:51:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:51:42 INFO - Downloading/unpacking blobuploader==1.2.4 09:51:42 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:51:42 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:51:42 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:51:42 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:51:42 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:51:42 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:51:44 INFO - Downloading blobuploader-1.2.4.tar.gz 09:51:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:51:44 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:51:44 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:51:44 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:51:44 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:51:44 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:51:44 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:51:44 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:51:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:51:44 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:51:44 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:51:44 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:51:44 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:51:44 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:51:44 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:51:44 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:51:45 INFO - Downloading docopt-0.6.1.tar.gz 09:51:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:51:45 INFO - Installing collected packages: blobuploader, requests, docopt 09:51:45 INFO - Running setup.py install for blobuploader 09:51:45 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:51:45 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:51:45 INFO - Running setup.py install for requests 09:51:45 INFO - Running setup.py install for docopt 09:51:46 INFO - Successfully installed blobuploader requests docopt 09:51:46 INFO - Cleaning up... 09:51:46 INFO - Return code: 0 09:51:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:51:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:51:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:51:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:51:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:51:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:46 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 0x10f2c2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f2c5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc8ead49980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f0a0d30>, '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 0x10efc7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f095be8>, '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.w1oewBjS4H/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.b5TpYj8dlu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/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:51:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:51:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:51:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.w1oewBjS4H/Render', 09:51:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:51:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:51:46 INFO - 'HOME': '/Users/cltbld', 09:51:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:51:46 INFO - 'LOGNAME': 'cltbld', 09:51:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:51:46 INFO - 'MOZ_NO_REMOTE': '1', 09:51:46 INFO - 'NO_EM_RESTART': '1', 09:51:46 INFO - 'PAGER': '/bin/cat', 09:51:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:51:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:51:46 INFO - 'PWD': '/builds/slave/test', 09:51:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:51:46 INFO - 'SHELL': '/bin/bash', 09:51:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.b5TpYj8dlu/Listeners', 09:51:46 INFO - 'TMPDIR': '/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/', 09:51:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:51:46 INFO - 'USER': 'cltbld', 09:51:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:51:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:51:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:51:46 INFO - 'XPC_FLAGS': '0x0', 09:51:46 INFO - 'XPC_SERVICE_NAME': '0', 09:51:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:51:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:51:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:51:46 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-EAXKyg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:51:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:51:46 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-H9pbup-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:51:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:51:46 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-85qedT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:51:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:51:46 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-s8qOxQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:51:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:51:46 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-HX1rzy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:51:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:51:46 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-KQLII6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:51:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:51:46 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-1SbWEX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:51:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:51:47 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-RtWgBa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:51:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:51:47 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-38ipiK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:51:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:51:47 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-0ZMrR0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:51:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:51:47 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-8swy9W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:51:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:51:47 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-eGx1fq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:51:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:51:47 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-vdiRqh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:51:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:51:47 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-MkpCtt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:51:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:51:47 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-LMO51p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:51:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:51:47 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-wFl1c3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:51:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:51:48 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-ukXkoA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:51:48 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:51:48 INFO - Running setup.py install for manifestparser 09:51:48 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:51:48 INFO - Running setup.py install for mozcrash 09:51:48 INFO - Running setup.py install for mozdebug 09:51:48 INFO - Running setup.py install for mozdevice 09:51:48 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:51:48 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:51:48 INFO - Running setup.py install for mozfile 09:51:48 INFO - Running setup.py install for mozhttpd 09:51:48 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:51:49 INFO - Running setup.py install for mozinfo 09:51:49 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:51:49 INFO - Running setup.py install for mozInstall 09:51:49 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:51:49 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:51:49 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:51:49 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:51:49 INFO - Running setup.py install for mozleak 09:51:49 INFO - Running setup.py install for mozlog 09:51:49 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:51:49 INFO - Running setup.py install for moznetwork 09:51:49 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:51:49 INFO - Running setup.py install for mozprocess 09:51:49 INFO - Running setup.py install for mozprofile 09:51:50 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:51:50 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:51:50 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:51:50 INFO - Running setup.py install for mozrunner 09:51:50 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:51:50 INFO - Running setup.py install for mozscreenshot 09:51:50 INFO - Running setup.py install for moztest 09:51:50 INFO - Running setup.py install for mozversion 09:51:50 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:51:50 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:51:50 INFO - Cleaning up... 09:51:50 INFO - Return code: 0 09:51:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:51: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')]} 09:51:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:51:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51: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')]} 09:51:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:51:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:50 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 0x10f2c2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f2c5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc8ead49980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f0a0d30>, '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 0x10efc7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f095be8>, '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.w1oewBjS4H/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.b5TpYj8dlu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/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:51:50 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:51:50 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:51:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.w1oewBjS4H/Render', 09:51:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:51:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:51:50 INFO - 'HOME': '/Users/cltbld', 09:51:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:51:50 INFO - 'LOGNAME': 'cltbld', 09:51:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:51:50 INFO - 'MOZ_NO_REMOTE': '1', 09:51:50 INFO - 'NO_EM_RESTART': '1', 09:51:50 INFO - 'PAGER': '/bin/cat', 09:51:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:51:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:51:50 INFO - 'PWD': '/builds/slave/test', 09:51:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:51:50 INFO - 'SHELL': '/bin/bash', 09:51:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.b5TpYj8dlu/Listeners', 09:51:50 INFO - 'TMPDIR': '/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/', 09:51:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:51:50 INFO - 'USER': 'cltbld', 09:51:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:51:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:51:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:51:50 INFO - 'XPC_FLAGS': '0x0', 09:51:50 INFO - 'XPC_SERVICE_NAME': '0', 09:51:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:51:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:51:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:51:50 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-adASVF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:51:51 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:51:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:51:51 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-ugGVgV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:51:51 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:51:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:51:51 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-cctI9H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:51:51 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:51:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:51:51 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-IU7jNH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:51:51 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:51:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:51:51 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-eNf95I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:51:51 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:51:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:51:51 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-uH2bu5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:51:51 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:51:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:51:51 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-421fW7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:51:51 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:51:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:51:51 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-CHzdIJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:51:51 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:51:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:51:51 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-eyxRKF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:51:51 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:51:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:51:51 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-Uw__j3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:51:52 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:51:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:51:52 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-2fOMsO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:51:52 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:51:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:51:52 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-vRXyEz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:51:52 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:51:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:51:52 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-GmBhLX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:51:52 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:51:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:51:52 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-8MGHMj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:51:52 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:51:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:51:52 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-Qey4Ku-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:51:52 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:51:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:51:52 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-T1h0MH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:51:52 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:51:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:51:52 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-SHitLy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:51:52 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:51:52 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:51:52 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:51:52 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:51:52 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:51:52 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:51:52 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:51:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:51:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:51:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:51:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:51:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:51:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:51:54 INFO - Downloading blessings-1.6.tar.gz 09:51:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:51:54 INFO - Installing collected packages: blessings 09:51:54 INFO - Running setup.py install for blessings 09:51:54 INFO - Successfully installed blessings 09:51:54 INFO - Cleaning up... 09:51:54 INFO - Return code: 0 09:51:54 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:51:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:51:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:51:54 INFO - Reading from file tmpfile_stdout 09:51:54 INFO - Current package versions: 09:51:54 INFO - blessings == 1.6 09:51:54 INFO - blobuploader == 1.2.4 09:51:54 INFO - docopt == 0.6.1 09:51:54 INFO - functools32 == 3.2.3-2 09:51:54 INFO - jsonschema == 2.5.1 09:51:54 INFO - manifestparser == 1.1 09:51:54 INFO - mozInstall == 1.12 09:51:54 INFO - mozcrash == 1.0 09:51:54 INFO - mozdebug == 0.1 09:51:54 INFO - mozdevice == 0.49 09:51:54 INFO - mozfile == 1.2 09:51:54 INFO - mozhttpd == 0.7 09:51:54 INFO - mozinfo == 0.9 09:51:54 INFO - mozleak == 0.1 09:51:54 INFO - mozlog == 3.4 09:51:54 INFO - moznetwork == 0.27 09:51:54 INFO - mozprocess == 0.25 09:51:54 INFO - mozprofile == 0.28 09:51:54 INFO - mozrunner == 6.13 09:51:54 INFO - mozscreenshot == 0.1 09:51:54 INFO - mozsystemmonitor == 0.3 09:51:54 INFO - moztest == 0.8 09:51:54 INFO - mozversion == 1.4 09:51:54 INFO - psutil == 3.1.1 09:51:54 INFO - requests == 1.2.3 09:51:54 INFO - wsgiref == 0.1.2 09:51:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:51: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')]} 09:51:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:51:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51: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')]} 09:51:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:51:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:54 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 0x10f2c2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f2c5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc8ead49980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f0a0d30>, '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 0x10efc7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f095be8>, '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.w1oewBjS4H/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.b5TpYj8dlu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/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:51:54 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:51:54 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:51:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.w1oewBjS4H/Render', 09:51:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:51:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:51:54 INFO - 'HOME': '/Users/cltbld', 09:51:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:51:54 INFO - 'LOGNAME': 'cltbld', 09:51:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:51:54 INFO - 'MOZ_NO_REMOTE': '1', 09:51:54 INFO - 'NO_EM_RESTART': '1', 09:51:54 INFO - 'PAGER': '/bin/cat', 09:51:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:51:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:51:54 INFO - 'PWD': '/builds/slave/test', 09:51:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:51:54 INFO - 'SHELL': '/bin/bash', 09:51:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.b5TpYj8dlu/Listeners', 09:51:54 INFO - 'TMPDIR': '/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/', 09:51:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:51:54 INFO - 'USER': 'cltbld', 09:51:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:51:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:51:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:51:54 INFO - 'XPC_FLAGS': '0x0', 09:51:54 INFO - 'XPC_SERVICE_NAME': '0', 09:51:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:51:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:51:55 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:51:55 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:51:55 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:51:55 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:51:55 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:51:55 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:51:55 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:51:55 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:51:55 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:51:55 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:51:55 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:51:55 INFO - Cleaning up... 09:51:55 INFO - Return code: 0 09:51:55 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:51:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:51:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:51:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:51:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:51:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:55 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 0x10f2c2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f2c5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc8ead49980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f0a0d30>, '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 0x10efc7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f095be8>, '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.w1oewBjS4H/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.b5TpYj8dlu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/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:51:55 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:51:55 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:51:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.w1oewBjS4H/Render', 09:51:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:51:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:51:55 INFO - 'HOME': '/Users/cltbld', 09:51:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:51:55 INFO - 'LOGNAME': 'cltbld', 09:51:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:51:55 INFO - 'MOZ_NO_REMOTE': '1', 09:51:55 INFO - 'NO_EM_RESTART': '1', 09:51:55 INFO - 'PAGER': '/bin/cat', 09:51:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:51:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:51:55 INFO - 'PWD': '/builds/slave/test', 09:51:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:51:55 INFO - 'SHELL': '/bin/bash', 09:51:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.b5TpYj8dlu/Listeners', 09:51:55 INFO - 'TMPDIR': '/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/', 09:51:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:51:55 INFO - 'USER': 'cltbld', 09:51:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:51:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:51:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:51:55 INFO - 'XPC_FLAGS': '0x0', 09:51:55 INFO - 'XPC_SERVICE_NAME': '0', 09:51:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:51:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:51:55 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:51:55 INFO - Cleaning up... 09:51:55 INFO - Return code: 0 09:51:55 INFO - Running post-action listener: _resource_record_post_action 09:51:55 INFO - Running post-action listener: _start_resource_monitoring 09:51:55 INFO - Starting resource monitoring. 09:51:55 INFO - [mozharness: 2017-05-10 16:51:55.393067Z] Finished create-virtualenv step (success) 09:51:55 INFO - [mozharness: 2017-05-10 16:51:55.394006Z] Running install step. 09:51:55 INFO - Running pre-action listener: _resource_record_pre_action 09:51:55 INFO - Running main action method: install 09:51:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:51:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:51:55 INFO - Reading from file tmpfile_stdout 09:51:55 INFO - Detecting whether we're running mozinstall >=1.0... 09:51:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:51:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:51:55 INFO - Reading from file tmpfile_stdout 09:51:55 INFO - Output received: 09:51:55 INFO - Usage: mozinstall [options] installer 09:51:55 INFO - Options: 09:51:55 INFO - -h, --help show this help message and exit 09:51:55 INFO - -d DEST, --destination=DEST 09:51:55 INFO - Directory to install application into. [default: 09:51:55 INFO - "/builds/slave/test"] 09:51:55 INFO - --app=APP Application being installed. [default: firefox] 09:51:55 INFO - mkdir: /builds/slave/test/build/application 09:51:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-54.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 09:51:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-54.0.en-US.mac.dmg --destination /builds/slave/test/build/application 09:52:10 INFO - Reading from file tmpfile_stdout 09:52:10 INFO - Output received: 09:52:10 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 09:52:10 INFO - Running post-action listener: _resource_record_post_action 09:52:10 INFO - [mozharness: 2017-05-10 16:52:10.818113Z] Finished install step (success) 09:52:10 INFO - [mozharness: 2017-05-10 16:52:10.818245Z] Running run-tests step. 09:52:10 INFO - Running pre-action listener: _resource_record_pre_action 09:52:10 INFO - Running main action method: run_tests 09:52:10 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:52:10 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:52:10 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:52:10 INFO - 2017-05-10 09:52:10.830 screenresolution[1633:7538] starting screenresolution argv=screenresolution get 09:52:10 INFO - 2017-05-10 09:52:10.833 screenresolution[1633:7538] Display 0: 1600x1200x32@60 09:52:10 INFO - 2017-05-10 09:52:10.839 screenresolution[1634:7540] starting screenresolution argv=screenresolution list 09:52:10 INFO - Available Modes on Display 0 09:52:10 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:52:10 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:52:10 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:52:10 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:52:11 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:52:11 INFO - Intel Iris: 09:52:11 INFO - Chipset Model: Intel Iris 09:52:11 INFO - Type: GPU 09:52:11 INFO - Bus: Built-In 09:52:11 INFO - VRAM (Dynamic, Max): 1536 MB 09:52:11 INFO - Vendor: Intel (0x8086) 09:52:11 INFO - Device ID: 0x0a2e 09:52:11 INFO - Revision ID: 0x0009 09:52:11 INFO - Displays: 09:52:11 INFO - Display: 09:52:11 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:52:11 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:52:11 INFO - Display Serial Number: 1600x1200 60 09:52:11 INFO - Main Display: Yes 09:52:11 INFO - Mirror: Off 09:52:11 INFO - Online: Yes 09:52:11 INFO - Rotation: Supported 09:52:11 INFO - Return code: 0 09:52:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:52:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:52:11 INFO - Python 2.7.3 09:52:11 INFO - Return code: 0 09:52:11 INFO - grabbing minidump binary from tooltool 09:52:11 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:52:11 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 0x10f0a0d30>, '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 0x10efc7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f095be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:52:11 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:52:11 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:52:11 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:52:11 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:52:11 INFO - Return code: 0 09:52:11 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 09:52:11 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:52:11 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:52:11 INFO - ENV: RUST_BACKTRACE is now 1 09:52:11 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 09:52:11 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:52:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/diq9pxQVRB6jX2zUUFIpTw/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0022', '--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:52:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/diq9pxQVRB6jX2zUUFIpTw/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0022 --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:52:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.w1oewBjS4H/Render', 09:52:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:52:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:52:11 INFO - 'HOME': '/Users/cltbld', 09:52:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:52:11 INFO - 'LOGNAME': 'cltbld', 09:52:11 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:52:11 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 09:52:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:52:11 INFO - 'MOZ_NO_REMOTE': '1', 09:52:11 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:52:11 INFO - 'NO_EM_RESTART': '1', 09:52:11 INFO - 'PAGER': '/bin/cat', 09:52:11 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:52:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:52:11 INFO - 'PWD': '/builds/slave/test', 09:52:11 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:52:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:52:11 INFO - 'RUST_BACKTRACE': '1', 09:52:11 INFO - 'SHELL': '/bin/bash', 09:52:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.b5TpYj8dlu/Listeners', 09:52:11 INFO - 'TMPDIR': '/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/', 09:52:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:52:11 INFO - 'USER': 'cltbld', 09:52:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:52:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:52:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:52:11 INFO - 'XPC_FLAGS': '0x0', 09:52:11 INFO - 'XPC_SERVICE_NAME': '0', 09:52:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:52:11 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/diq9pxQVRB6jX2zUUFIpTw/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0022', '--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:52:11 INFO - mozversion application_buildid: 20170509092824 09:52:11 INFO - mozversion application_changeset: 4ac208f317b37f7ed2e669d5ca23064ebc979103 09:52:11 INFO - mozversion application_display_name: Firefox 09:52:11 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:52:11 INFO - mozversion application_name: Firefox 09:52:11 INFO - mozversion application_remotingname: firefox 09:52:11 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 09:52:11 INFO - mozversion application_vendor: Mozilla 09:52:11 INFO - mozversion application_version: 54.0 09:52:11 INFO - mozversion platform_buildid: 20170509092824 09:52:11 INFO - mozversion platform_changeset: 4ac208f317b37f7ed2e669d5ca23064ebc979103 09:52:11 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 09:52:11 INFO - mozversion platform_version: 54.0 09:52:11 INFO - using testdate: 1494435131 09:52:11 INFO - actual date: 1494435131 09:52:11 INFO - starting webserver on 'localhost:49248' 09:52:11 INFO - SUITE-START | Running 2 tests 09:52:11 INFO - TEST-START | dromaeo_css 09:52:11 INFO - operating with platform_type : mac_ 09:52:11 INFO - Initialising browser for dromaeo_css test... 09:52:11 INFO - TEST-INFO | started process 1644 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/tmpfititY/profile http://localhost:49248/getInfo.html) 09:52:13 INFO - PROCESS | 1644 | __metrics Screen width/height:1600/1200 09:52:13 INFO - PROCESS | 1644 | colorDepth:24 09:52:13 INFO - PROCESS | 1644 | Browser inner width/height: 1024/689 09:52:13 INFO - PROCESS | 1644 | __metrics 09:52:13 INFO - PROCESS | 1644 | 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:52:13 INFO - PROCESS | 1644 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:52:14 INFO - TEST-INFO | 1644: exit 0 09:52:14 INFO - Browser initialized. 09:52:14 INFO - Running cycle 1/1 for dromaeo_css test... 09:52:14 INFO - TEST-INFO | started process 1647 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/tmpfititY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:52:26 INFO - PROCESS | 1647 | RSS: Main: 165330944 09:52:26 INFO - PROCESS | 1647 | 09:55:30 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49248/tests/dromaeo/cssquery-ext.html) 09:55:31 INFO - PROCESS | 1647 | RSS: Main: 309170176 09:55:31 INFO - PROCESS | 1647 | 09:58:34 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-ext.html (next: http://localhost:49248/tests/dromaeo/cssquery-jquery.html) 09:58:35 INFO - PROCESS | 1647 | RSS: Main: 303374336 09:58:35 INFO - PROCESS | 1647 | 10:01:37 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49248/tests/dromaeo/cssquery-mootools.html) 10:01:38 INFO - PROCESS | 1647 | RSS: Main: 287068160 10:01:38 INFO - PROCESS | 1647 | 10:04:40 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49248/tests/dromaeo/cssquery-prototype.html) 10:04:41 INFO - PROCESS | 1647 | RSS: Main: 296775680 10:04:41 INFO - PROCESS | 1647 | 10:07:44 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49248/tests/dromaeo/cssquery-yui.html) 10:07:45 INFO - PROCESS | 1647 | RSS: Main: 261980160 10:07:45 INFO - PROCESS | 1647 | 10:10:48 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-yui.html (next: http://localhost:49248/tests/dromaeo/cssquery-dojo.html) 10:10:48 INFO - PROCESS | 1647 | RSS: Main: 362786816 10:10:48 INFO - PROCESS | 1647 | 10:10:48 INFO - PROCESS | 1647 | __start_tp_report 10:10:48 INFO - PROCESS | 1647 | _x_x_mozilla_page_load 10:10:48 INFO - PROCESS | 1647 | _x_x_mozilla_page_load_details 10:10:48 INFO - PROCESS | 1647 | |i|pagename|runs| 10:10:48 INFO - PROCESS | 1647 | |0;dojo.html;2849.5013372659787;3224.9516257256137;3595.6044835068155;3625.3111908737355;3637.727170462216;6126.7855625053135;6195.132681424593;6203.782867599629;6217.316095229521;6244.875102497947;6183.319834818167;6216.937830621692;6228.065790131483;6228.750849966007;6231.439170474657;5524.4199359067225;5541.501264886159;5575.581831362644;5601.80393686221;5681.573881958849;5400.162974738922;5432.538234250093;5435;5656;5664.688442135681;5540.168974653794;5544.695041772701;5549.001179787637;5554.833354999357;5555.694386829481;5501.229827824088;5531.778728850841;5537.861553461195;5542.140968149944;5546.112621980504;5397.568194544427;5499.230107784913;5505.504504594605;5520.834374968757;5525.392206857243;5092;6194.690265486753;6214.130021796952;6215.2541694996435;6222.5644204905675;5396.892062158735;6284.151639528696;6393.328700486429;6413.871722565569;6441.3880681335195;5751.338596061465;6660.633665148415;6667;6688.197416310025;6696.732130714766;6151.753929842801;6241.687915604201;6285.340039295854;6297.779577714758;6311.621302721851;6447.709853056624;6485;6596.835079122964;6836.487263455261;6840.281770414134;6344.143540622049;6381.617102973836;6438.066480360415;6474.482041436674;6487;6606.900896486556;6613.272540020594;6617.503687223478;6627.237867645186;6644.83387915306;6316;6395.648239346788;6540.607563546202;6543.280239173687;6559.573627714183;6376.29860715321;6396.136521569621;6413.807585772434;6425.871482570323;6562.80311590653;5328.893422131613;5332.626716129911;5333.280007198979;5336.813211537577;5366.007288651534;4725.3384526166365;4727.267273572602;4751.64362672801;4755.95244047562;4793.640476964172;6106.225468276498;6132.642724909311;6208.72060757267;6276.686165691697;6324.462420694201;6345.809625711236;6350.333215012357;6383.904241436382;6498.577592456475;6535.607863528204;5229.686218826807;6309.369063093745;6334.904976425358;6377.202849643794;6402.583832050902;5785.929603023455;5863.032599621015;5869.442402971711;5870.618409803435;5877.177195192677;6508.837279068061;6553.115329430657;6738.528303018742;6850.417714494224;6913.1358580177475;6570.671466426755;6611.438027767694;6639.767608133692;6646.501512386493;6651.700673469609;6821.658917054227;6870.931290687029;6872.45020398357;6881.380675739208;6904.27505111956;6314.873702526015;6356.396142366468;6459.289478157305;6501.902471463027;6560.704768285344;6462.741490340334;6492.740290388331;6527;6635.6350400728425;6655.633940133339;6145.692715364304;6444.709988050456;6451.903221451588;6459.192600924885;6462.321456247214;6274.341194174546;6321.936780632135;6450.322716114928;6473.935260647521;6477.740890364333;6281.59169653971;6288.056791481315;6373.044043393528;6379.744810207725;6395.360463953567;6425.453836423956;6454.741810327534;6460.709268082854;6464.997925321582;6465.870682586416;6230.50155987529;6310.11658367838;6370.331115232834;6374;6383 10:10:48 INFO - PROCESS | 1647 | |1;ext.html;780.16911988732;812.6261919517021;829.6100832608673;907.6369452219111;913.7989642278696;28653.71346286539;28928;30059.84970075152;30113;41302;42528.78735606318;42697.57302426975;42800;42811.57188428115;42854.57145428545;9598.088181622734;9772.07165319297;9781.315307928448;9786.3638863474;9798.510074496282;7779.222077792232;7917.445778795487;8321.916780832174;9616.663416780415;9760.90239097607;11472.71318217043;11557.075433965263;11642.068634509218;11732.824007639892;11901;11699.18105732599;11745.236559623598;11745.765084698343;11767.41162941858;11768.705782355424;9617.374870633457;11431.14266430021;11474.48364823585;11487.138464615187;11512.481938312796;39860.00349991273;40132.19735605272;40181.99545011369;40212.195756085006;40295.79852100721;4043.777592232426;4123.628873401408;4124.381342798604;4125.938110928339;4160.043190066272;27332;27429.45141097167;28205.717942820513;28805.279868003257;29381.70618293811;3134.905952821419;3264.918377040593;3270.345930813823;3290.1610089427045;3342.1477523231665;344846;351108;351293;351407;351743;50188.49811501838;50227.748861256194;50289.74855125701;50307.7423064419;50363.74090647763;52089.21866172011;52091.739541302806;52127.47872521226;52222;52246;14319.78520322196;14650.633734156518;14652.487162949246;14664.193469359288;14666.413343466354;12748.681282967815;12749.745005099847;12750.48998040068;12771.61685149447;12778.23330600167;10437.217208709377;10631.989960953697;10644.361338319726;11502.597409090642;11624.476898539586;5337.172738225581;5464.398916119224;5501.697406642673;5504.889902201933;5524.779008839601;756.2966441209618;911.9635214591342;986.5215370545279;994.1152374386802;1029.0738335497963;27558.86220568884;28275.858620706764;28408.147755567366;28944.276393090342;28957.56563651547;1063.8138325792954;1064.7284942339654;1103.2773533335678;1103.61925135828;1106.3859557945257;13649.727005460034;14770.039947403384;14969.850301496846;14991.925040374947;15063.171525566198;423279;423436;423603;423760;425523;48702.26946595804;49151;55225.72387138039;55253;57169.428305716414;1476.8892333074848;1521.8706409955278;1522.9695406092037;1527.0990115831712;1530.7091652586196;29346.706532934397;30037.54943675803;30146.24634384158;30460.181211254243;30637.387252254382;46089.308660369454;46295;46320.7683961578;46354.536454635025;46422.53577464182;398569;398711;450768;538097;550686.2465687646;33827.66172338245;33969.830150849084;34085;34174;34760.78337258184;42919.356209657504;43110.78444607757;43174.35238471488;43254;43488.69533913988;29467.41065178727;30090;30135;30280.697193028667;30907.381852363276;29748.553771693874;30007.399852003273;30838.92063777757;30883.69116308898;30980.53529197109;34223.31553368869;35744;36314.63685363218;36427.27145457129;36666.8166659165;29964.70035299619;30053.398932021675;30067.849660751555;30399.696003039688;30859.382812343178;23805.523889522457;23858.761412385655;23983.52032959296;24319.878400607882;24429.38926526851 10:10:48 INFO - PROCESS | 1647 | |2;jquery.html;411.9629233368996;419.3437270671401;438.9319655453406;439.91642546339773;444.09626410255095;20223.696644550324;21468;22449.87750612467;22655.433614159654;22828.771712282873;18863.811361886375;22583.435414114654;22730.977106030226;23135.652965205492;23481.708506032162;6576.769813056544;6692.431143352821;6929.7574584889535;6940.895886561706;6944.305569443066;6705.597664140168;6828;6846.863062738742;6865.725370985155;6882.242953275136;6529;6748.426383757386;6826.795196144099;6867.07294515239;6895.862082758342;6713.93286067138;6755.121834161577;6814.080099186596;6821.317868213188;6824.965875170592;6619.205695316593;6660.966695166493;6672.232693240291;6690.19717633887;6706.497012724065;26795.732042679712;26941.461170776474;27022.919083236648;27058.729412706016;27314.45371092567;2392.712874455059;2915.1395825170835;2976.479116154686;2991.4615369233748;3009.759219262454;10985.725356866062;14950.40198392063;14975;15029.849701502955;15574.831887608474;1776.3782676063404;2053.37372101509;2078.9480262993393;2113.3871177358546;2118.7775283595156;136016.6398336014;137967;138144;140962.29518852444;142464;15786.526404207892;20650.380488585368;20693;20853.976173455067;20932.79067209339;33391.33217335688;33982.49026264608;34150;34213;34247;8672.046074931752;10821.9458902705;11223.887761122285;11286.322820630789;11370;9095.81808363829;9117.77205569866;9136.314776391664;9293.303002274857;9296.535173241311;9586.424814511152;9599.616015359308;9661.101669499121;9782;9826.164775993977;3070.8925187618775;3937.1928754605237;3992.1017771001875;3992.401139828991;4150.190712810973;1068.732816795801;1110.7056629993058;1119.9664010079712;1130.6438471881331;1169.502961241469;20416.693749593767;22083.779162208495;22520.887395562917;22591.548169036527;22627.20804771825;1065.4406436620836;1067.546292825546;1110.7389763405592;1110.7722916802036;1115.358668765447;11229.438528073564;11937.88062119385;11960;12011.579594714143;12019.158658893793;749391;757861.4748483776;762719;770719;785769;107077.92922070835;119377.8062219384;119444.40277798555;121704;125488.37255813663;1279.181323952671;1284.8072789081525;1324.0136098606408;1324.0202250334683;1328.9867101329057;17916.731249031534;19178.712319314942;19205.615887681888;19291.4212573623;19294.324698636043;50948.726281841766;51379.74310128575;51646.48353516567;51804.74097629639;52547.73726131345;67366;69159.65420172867;69317.65341173262;69483.65258173677;71031;9341.532923353941;11281.943590281997;11575.88424115748;11795.11536634773;11979.34113623759;12412.937935310265;12416;12638.684032899251;12794.936025320187;12809.487620495076;10855.67432977012;10997.505112269808;11148.386838723947;11228.606998755004;11379.886201138213;10177.134943529883;10244.48777561104;10287.84568231492;10509.527071281658;10567.418791966209;11151.996320331209;11224.438778060901;11516.251443656136;11609.825852612386;11655.88344116548;11576.305421674726;11859.05127589808;11938;11941.582044628396;11951.984081353183;10819.729506762395;10955.945220273848;11017.504212310625;11018.669439916815;11221.943890280496 10:10:48 INFO - PROCESS | 1647 | |3;mootools.html;1535.286091967235;1580.1941010084856;1590.9363625454982;1619.813721422037;1659.2450435052053;9006.504642244674;11574.884251157486;11595.072394208464;11599.420028998547;11622.825657615122;10812.891871081287;11092.057175140102;11196.776064478727;11206.66380008599;11253.718657033558;2479.1323036937065;2516.7609077137645;2518.5214809186286;2520.936976575591;2522.369407648088;2450.5834008218644;2475.900963961439;2524.1039431002005;2525.734797846218;2526.090607381341;2477.2196758021164;2477.665515155458;2494.114589320792;2516.006177559863;2517.3203235126507;2143;2411.8182090775567;2418.2745176446997;2467.0748469324003;2481.7146028206807;2448.0574978633354;2483.453640199153;2485.1302044284357;2491.539065272912;2495.0768215760286;11132.888671113265;11369.260998035184;11385.715357116056;11394.088472922229;11408.828867566994;5929.73316200772;6114.449699527064;6125.479334256594;6127.448529632355;6130.2030736004035;3088.258817883714;3733.21602463483;3808.257389808988;3813.466114743938;3821.2357528494413;1136.1081550982522;1255.2782150263636;1269.4668239339408;1297.3383574377042;1311.4229738914942;14331.06848054873;14630;14957.551273461813;15811.288492017888;15989.840101598951;4708.623310135181;4884.95115048852;4887.36464259644;4899.926501102486;4928.28539861718;11975.041996640248;11975.88024119765;11986.460609272604;11995.460204290828;12009.919107280386;5136.409312929061;5283.233931080049;5881.911771323434;5972.790952316648;6013.579049466495;5317.707526086102;5486.1770734389365;5563.721813909369;5566.638168519034;5570.526505247019;3683.6132206117973;3974.7615143091507;3986.5216174059296;4072.0023594219606;4072.979635101865;1000.2847963705985;1075.44077079918;1078.5254488025244;1090.0734375780683;1090.7763908398758;913.1918252346721;923.1414784250711;942.2226663002913;968.6851773173747;1001.6744558018673;6489.221293444817;6509.2839787623325;6611.768588099393;6780.355866192704;6803.0135630333325;824.575343697996;947.3557980573277;960.4285450157146;968.9563969621383;1036.6060896859144;3426.777259478126;4112.814923328458;4273.786310684453;4291.270484017725;4352.955290730202;13638.386272617756;14251.073680210753;14269.429222831179;14274.000819942712;14297.428102875976;13676.179429234278;13843.930780346236;14135.717285654435;14165.93755468344;14214.715705686036;10053.296269261082;10274.640387586398;10424;10441.947790261;10546.525406356732;6830.146231721035;6874.587524748531;6895.5173137881875;6951.582905025714;6997.37023667852;11576.94211528937;12411.255324680547;12532;12539.498420063095;12670.429830657458;12728.363581821057;12850.742985140057;12924.353782310658;12933.870661293644;12976.221426714428;9250.306227033134;9493.335466517277;9512.191463725661;9517.52412379392;9519.952805191286;8093.433459657767;10415.739606509898;10446.843297350393;10551.41967191781;10571.101456376295;8756.868646970428;8830.514321712368;8924.732258032269;8952.462852228888;8962.641578824408;8580.914190858011;8581.485110893116;8646.394752367525;8646.567671616269;8661.480311181349;7788;7882.369410447265;7917;7936.84126317482;7943.920560794318;5824.854378640398;5830.854228644318;5863.618864773776;6018.277806663228;6057.818265452043;5500.394956554695;5589.021921163699;5940.3168635605725;6086.02623580225;6219.782307619212 10:10:48 INFO - PROCESS | 1647 | |4;prototype.html;350.80530305680355;390.8749200255918;393.4354201720531;395.29242655646397;396.16607042176236;4478.888027799307;5097.770600322985;5448.15114548052;5539.086050801618;5606.971965140168;4694.671373003891;5170.482951704827;5250.396204436491;5260.922360419159;5408.972955135218;4237.8769626049125;4383.3424986252;4427.77861106945;4439.533848945863;4478.843240486575;3723.460098285747;3961.9603803962023;4484.708493947899;4492.742761497921;4502.8874278142985;3736.7384283100196;4060.7157498975084;4240.427542281799;4284.764337961411;4439.2675208590545;3601.477785721069;4063.3092374296143;4388.319810429389;4392.626626736731;4398.406215160944;3371.3257348530146;4089.4683691120263;4109.958900410988;4116.176764647053;4140.503139623264;4360.585744354281;4951.078863470534;5064.924026139611;5307.389650190239;5384.811531596414;4887.608991280689;5031.496850314976;5081.678763521474;5118.795248190068;5145;5753.626014309057;5761.423857614247;5810.622309549908;5836.416358364129;5840.4451577100535;4510.571495707903;4564.383808185886;4628.282616194495;4632.050429661911;4674.252119660872;4766.76166191689;5740.68426236561;5867.266591675998;5912.398544640345;6011.939880601226;3858.479105320802;4139.379093136054;4385.736855788663;4390.846320378835;4660.277656963176;4206.747595144301;4488;4511.684182107221;4813.95186048142;4820.638452116105;3967.3652215645357;4501.919539310542;4754.619630429557;5059.595232381401;5102.540771330598;4752.667313288037;5014.066770939042;5081.59347252219;5540.667559946335;5717.942820571741;1464.3630020940925;1602.1748799368336;1614.9757753633705;1625.7154997875325;1652.570331713739;1042.2391654092403;1162.6222925832747;1190.9285442873456;1197.6407077876602;1225.96935076622;5042.873928151826;5488.615796894259;5493;5498.532624726863;5519.282493275929;4894.559489645949;5556.166465066518;5614.175392997292;5706.657600543981;5714.657120572779;4340.631046361032;4562.452505699271;5404.8108316208745;5468.56648791292;5563.7774489019985;2616.0118310084094;2792.7765778737653;2913.6357955255594;2929.8866430756175;3084.506478963355;5696.515796157373;5835.306601688064;6072.453479186806;6144.692765361714;6170.315912578043;5056.84829455117;5559.972200138974;5652.0674088774895;5808.332041815161;6032.306284777219;5186.510474972035;5610.671571297948;5636.689982051026;5650.745716442852;5977.940220597825;5700.372958974426;5880.235929221302;5954.4938680210935;5977.6114552553945;6007.48936340416;4990.451050384382;5831.912521312099;5841.912371314519;5846.473817356458;5855.916655418761;5500.642458240201;5522.7573795895605;5943.108533719977;5987.820365389045;6010.338862725184;4673.719576825401;5182.714950677749;5204.2714020036465;5244.9737751310995;5268.525832675077;5474.839122267185;5586.022446072003;5741.856453588526;6001.309849367379;6059.394060593905;5039.244113383022;5054.924176137288;5206.921896171636;5494.851387202796;5623.8594035149445;5722.599418040697;5755.942440575541;5759.337676167294;5774.162746401832;5780;4733.644976626836;5296.814611488579;5357.330333708286;5683.374828768915;5704.942950570441;4829.4204695435365;4873.29434697853;5171.844844654666;5624.85937851557;5727.226824378656;4967.652264341606;5326;5439.836804895859;5662.188099808021;5663.725661726078 10:10:48 INFO - PROCESS | 1647 | |5;yui.html;766.750805988054;769.5998080997881;889.7864512516998;893.0979710492402;909.2498688581921;15996.520104396872;16247.846136990664;16660.58348541287;17465.301387944466;18394.724079138825;14222.786658200135;16389.5902602435;16435.58911027222;16642.916785416055;17889;984.3454103021483;1000.929934904557;1002.013017178079;1005.3013155856682;1012.5848402155118;989.2333441582795;992.4541502173812;993.6869885985927;999.6001599360242;1021.101430740947;1040.3133931605141;1041.0006393861902;1043.4209013997267;1044.1020722178957;1044.879838818538;1039.8648175737105;1040.5525623981684;1040.7762331098813;1041.312733595827;1042.280826229899;769.2807225244414;769.8537277917178;772.1390649425906;772.4361216312068;772.9652165652559;14204.431822727078;17458.30166793327;17466.039367834765;18406.35577754772;18695.532611684815;14625.78061329081;14922.403103875831;15040.097594144278;15076.698466030728;15281;10389.753229612495;10783.83824242637;11929.224600401032;12260.325682087481;12416.81374779379;3247.8376081195847;3787.7537960032787;3875.302445559798;3904.6876249899938;3995.200959808021;113336;117750.82249177484;120379.39810300981;120448;121670;11435;11625.88374116248;11634.825477617842;11812.232204906653;11874.406279685982;22220.111195551995;22537.323880283617;23875.403114922265;23893.641595375735;23916.402089947544;8159.918400816035;8194.918050819535;8349.95825020871;8463.322934165251;8517.57412129391;3772.39641657339;4457.286834106592;4624.699394539344;4711.1519926413575;4856.955754512796;3577.624349443323;3674.356987527172;3676.2279921216846;3715.3869611514338;3732.1042949692423;658.7101675262869;663.1147418196762;671.3152584363921;675.7567275780715;675.9729610815513;674.7874419557921;693.774523279936;702.5714314268292;724.7825652304288;764.1212605503715;8631.827363452696;9409.435433873989;10639.41483218415;10859.511321990529;11020.338779673246;709.5033476566424;715.9606221657755;721.6355740351089;724.1635910523248;729.7482368582937;4850.611951043908;5163.302954101224;5228.64091217163;5273.472652734696;5305.336832895888;87092;88992.11007889967;106953;108078.45960770146;108515;84745.57627211824;95125;95128.52435737777;98159;98789.50605246928;37697.81151094282;37884.81057594749;59065.86538942319;83513.74557655041;86674;9827.11555959967;10291.639792607222;10319.277650564389;10322;10334.534945927602;35366.64633353634;54372;56105;57309.42690573041;57867.42132578789;57023.71488142699;69898.65050674714;71474;71550.92673609796;71896.56206875938;11592.710182245512;11644.76710465769;11873.228240164362;11954.521819127138;12368.567100151451;13420.39608217613;13513.662158446117;13740.793888091886;13780.635191092379;14342.426302947766;12090.274583524664;12524.37378131108;12673.493060277855;12760;13084.411201495765;11985;12490.250584964931;12679.683007924506;12857.778511041435;13106.803397949228;11895.464704088165;12356.320402377956;12358.876411236131;12546.749065018832;12589.43347549344;8899.288056955558;9346.345755797029;9500.714978550655;9528.809423811346;9583.185429238592;9774.589045513894;10420;10429.904859989896;10458.058774710313;10462.581496740046 10:10:48 INFO - PROCESS | 1647 | __end_tp_report 10:10:48 INFO - PROCESS | 1647 | __start_cc_report 10:10:48 INFO - PROCESS | 1647 | _x_x_mozilla_cycle_collect,1369 10:10:48 INFO - PROCESS | 1647 | __end_cc_report 10:10:48 INFO - PROCESS | 1647 | __startTimestamp1494436248933__endTimestamp 10:10:48 INFO - PROCESS | 1647 | 10:10:48 INFO - PROCESS | 1647 | ------- Summary: start ------- 10:10:48 INFO - PROCESS | 1647 | Number of tests: 6 10:10:48 INFO - PROCESS | 1647 | 10:10:48 INFO - PROCESS | 1647 | [#0] dojo.html Cycles:165 Average:6085.59 Median:6321.94 stddev:689.86 (10.9%) stddev-sans-first:643.58 10:10:48 INFO - PROCESS | 1647 | Values: 2849.5 3225.0 3595.6 3625.3 3637.7 6126.8 6195.1 6203.8 6217.3 6244.9 6183.3 6216.9 6228.1 6228.8 6231.4 5524.4 5541.5 5575.6 5601.8 5681.6 5400.2 5432.5 5435.0 5656.0 5664.7 5540.2 5544.7 5549.0 5554.8 5555.7 5501.2 5531.8 5537.9 5542.1 5546.1 5397.6 5499.2 5505.5 5520.8 5525.4 5092.0 6194.7 6214.1 6215.3 6222.6 5396.9 6284.2 6393.3 6413.9 6441.4 5751.3 6660.6 6667.0 6688.2 6696.7 6151.8 6241.7 6285.3 6297.8 6311.6 6447.7 6485.0 6596.8 6836.5 6840.3 6344.1 6381.6 6438.1 6474.5 6487.0 6606.9 6613.3 6617.5 6627.2 6644.8 6316.0 6395.6 6540.6 6543.3 6559.6 6376.3 6396.1 6413.8 6425.9 6562.8 5328.9 5332.6 5333.3 5336.8 5366.0 4725.3 4727.3 4751.6 4756.0 4793.6 6106.2 6132.6 6208.7 6276.7 6324.5 6345.8 6350.3 6383.9 6498.6 6535.6 5229.7 6309.4 6334.9 6377.2 6402.6 5785.9 5863.0 5869.4 5870.6 5877.2 6508.8 6553.1 6738.5 6850.4 6913.1 6570.7 6611.4 6639.8 6646.5 6651.7 6821.7 6870.9 6872.5 6881.4 6904.3 6314.9 6356.4 6459.3 6501.9 6560.7 6462.7 6492.7 6527.0 6635.6 6655.6 6145.7 6444.7 6451.9 6459.2 6462.3 6274.3 6321.9 6450.3 6473.9 6477.7 6281.6 6288.1 6373.0 6379.7 6395.4 6425.5 6454.7 6460.7 6465.0 6465.9 6230.5 6310.1 6370.3 6374.0 6383.0 10:10:48 INFO - PROCESS | 1647 | 10:10:48 INFO - PROCESS | 1647 | [#1] ext.html Cycles:180 Average:55446.82 Median:34027.42 stddev:110934.30 (326.0%) stddev-sans-first:111169.57 10:10:48 INFO - PROCESS | 1647 | Values: 780.2 812.6 829.6 907.6 913.8 28653.7 28928.0 30059.8 30113.0 41302.0 42528.8 42697.6 42800.0 42811.6 42854.6 9598.1 9772.1 9781.3 9786.4 9798.5 7779.2 7917.4 8321.9 9616.7 9760.9 11472.7 11557.1 11642.1 11732.8 11901.0 11699.2 11745.2 11745.8 11767.4 11768.7 9617.4 11431.1 11474.5 11487.1 11512.5 39860.0 40132.2 40182.0 40212.2 40295.8 4043.8 4123.6 4124.4 4125.9 4160.0 27332.0 27429.5 28205.7 28805.3 29381.7 3134.9 3264.9 3270.3 3290.2 3342.1 344846.0 351108.0 351293.0 351407.0 351743.0 50188.5 50227.7 50289.7 50307.7 50363.7 52089.2 52091.7 52127.5 52222.0 52246.0 14319.8 14650.6 14652.5 14664.2 14666.4 12748.7 12749.7 12750.5 12771.6 12778.2 10437.2 10632.0 10644.4 11502.6 11624.5 5337.2 5464.4 5501.7 5504.9 5524.8 756.3 912.0 986.5 994.1 1029.1 27558.9 28275.9 28408.1 28944.3 28957.6 1063.8 1064.7 1103.3 1103.6 1106.4 13649.7 14770.0 14969.9 14991.9 15063.2 423279.0 423436.0 423603.0 423760.0 425523.0 48702.3 49151.0 55225.7 55253.0 57169.4 1476.9 1521.9 1523.0 1527.1 1530.7 29346.7 30037.5 30146.2 30460.2 30637.4 46089.3 46295.0 46320.8 46354.5 46422.5 398569.0 398711.0 450768.0 538097.0 550686.2 33827.7 33969.8 34085.0 34174.0 34760.8 42919.4 43110.8 43174.4 43254.0 43488.7 29467.4 30090.0 30135.0 30280.7 30907.4 29748.6 30007.4 30838.9 30883.7 30980.5 34223.3 35744.0 36314.6 36427.3 36666.8 29964.7 30053.4 30067.8 30399.7 30859.4 23805.5 23858.8 23983.5 24319.9 24429.4 10:10:48 INFO - PROCESS | 1647 | 10:10:48 INFO - PROCESS | 1647 | [#2] jquery.html Cycles:180 Average:41435.61 Median:11793.39 stddev:126277.38 (1070.7%) stddev-sans-first:126594.05 10:10:48 INFO - PROCESS | 1647 | Values: 412.0 419.3 438.9 439.9 444.1 20223.7 21468.0 22449.9 22655.4 22828.8 18863.8 22583.4 22731.0 23135.7 23481.7 6576.8 6692.4 6929.8 6940.9 6944.3 6705.6 6828.0 6846.9 6865.7 6882.2 6529.0 6748.4 6826.8 6867.1 6895.9 6713.9 6755.1 6814.1 6821.3 6825.0 6619.2 6661.0 6672.2 6690.2 6706.5 26795.7 26941.5 27022.9 27058.7 27314.5 2392.7 2915.1 2976.5 2991.5 3009.8 10985.7 14950.4 14975.0 15029.8 15574.8 1776.4 2053.4 2078.9 2113.4 2118.8 136016.6 137967.0 138144.0 140962.3 142464.0 15786.5 20650.4 20693.0 20854.0 20932.8 33391.3 33982.5 34150.0 34213.0 34247.0 8672.0 10821.9 11223.9 11286.3 11370.0 9095.8 9117.8 9136.3 9293.3 9296.5 9586.4 9599.6 9661.1 9782.0 9826.2 3070.9 3937.2 3992.1 3992.4 4150.2 1068.7 1110.7 1120.0 1130.6 1169.5 20416.7 22083.8 22520.9 22591.5 22627.2 1065.4 1067.5 1110.7 1110.8 1115.4 11229.4 11937.9 11960.0 12011.6 12019.2 749391.0 757861.5 762719.0 770719.0 785769.0 107077.9 119377.8 119444.4 121704.0 125488.4 1279.2 1284.8 1324.0 1324.0 1329.0 17916.7 19178.7 19205.6 19291.4 19294.3 50948.7 51379.7 51646.5 51804.7 52547.7 67366.0 69159.7 69317.7 69483.7 71031.0 9341.5 11281.9 11575.9 11795.1 11979.3 12412.9 12416.0 12638.7 12794.9 12809.5 10855.7 10997.5 11148.4 11228.6 11379.9 10177.1 10244.5 10287.8 10509.5 10567.4 11152.0 11224.4 11516.3 11609.8 11655.9 11576.3 11859.1 11938.0 11941.6 11952.0 10819.7 10955.9 11017.5 11018.7 11221.9 10:10:48 INFO - PROCESS | 1647 | 10:10:48 INFO - PROCESS | 1647 | [#3] mootools.html Cycles:180 Average:6850.05 Median:2521.65 stddev:4283.20 (169.9%) stddev-sans-first:4276.60 10:10:48 INFO - PROCESS | 1647 | Values: 1535.3 1580.2 1590.9 1619.8 1659.2 9006.5 11574.9 11595.1 11599.4 11622.8 10812.9 11092.1 11196.8 11206.7 11253.7 2479.1 2516.8 2518.5 2520.9 2522.4 2450.6 2475.9 2524.1 2525.7 2526.1 2477.2 2477.7 2494.1 2516.0 2517.3 2143.0 2411.8 2418.3 2467.1 2481.7 2448.1 2483.5 2485.1 2491.5 2495.1 11132.9 11369.3 11385.7 11394.1 11408.8 5929.7 6114.4 6125.5 6127.4 6130.2 3088.3 3733.2 3808.3 3813.5 3821.2 1136.1 1255.3 1269.5 1297.3 1311.4 14331.1 14630.0 14957.6 15811.3 15989.8 4708.6 4885.0 4887.4 4899.9 4928.3 11975.0 11975.9 11986.5 11995.5 12009.9 5136.4 5283.2 5881.9 5972.8 6013.6 5317.7 5486.2 5563.7 5566.6 5570.5 3683.6 3974.8 3986.5 4072.0 4073.0 1000.3 1075.4 1078.5 1090.1 1090.8 913.2 923.1 942.2 968.7 1001.7 6489.2 6509.3 6611.8 6780.4 6803.0 824.6 947.4 960.4 969.0 1036.6 3426.8 4112.8 4273.8 4291.3 4353.0 13638.4 14251.1 14269.4 14274.0 14297.4 13676.2 13843.9 14135.7 14165.9 14214.7 10053.3 10274.6 10424.0 10441.9 10546.5 6830.1 6874.6 6895.5 6951.6 6997.4 11576.9 12411.3 12532.0 12539.5 12670.4 12728.4 12850.7 12924.4 12933.9 12976.2 9250.3 9493.3 9512.2 9517.5 9520.0 8093.4 10415.7 10446.8 10551.4 10571.1 8756.9 8830.5 8924.7 8952.5 8962.6 8580.9 8581.5 8646.4 8646.6 8661.5 7788.0 7882.4 7917.0 7936.8 7943.9 5824.9 5830.9 5863.6 6018.3 6057.8 5500.4 5589.0 5940.3 6086.0 6219.8 10:10:48 INFO - PROCESS | 1647 | 10:10:48 INFO - PROCESS | 1647 | [#4] prototype.html Cycles:180 Average:4741.68 Median:5110.67 stddev:1333.95 (26.1%) stddev-sans-first:1296.34 10:10:48 INFO - PROCESS | 1647 | Values: 350.8 390.9 393.4 395.3 396.2 4478.9 5097.8 5448.2 5539.1 5607.0 4694.7 5170.5 5250.4 5260.9 5409.0 4237.9 4383.3 4427.8 4439.5 4478.8 3723.5 3962.0 4484.7 4492.7 4502.9 3736.7 4060.7 4240.4 4284.8 4439.3 3601.5 4063.3 4388.3 4392.6 4398.4 3371.3 4089.5 4110.0 4116.2 4140.5 4360.6 4951.1 5064.9 5307.4 5384.8 4887.6 5031.5 5081.7 5118.8 5145.0 5753.6 5761.4 5810.6 5836.4 5840.4 4510.6 4564.4 4628.3 4632.1 4674.3 4766.8 5740.7 5867.3 5912.4 6011.9 3858.5 4139.4 4385.7 4390.8 4660.3 4206.7 4488.0 4511.7 4814.0 4820.6 3967.4 4501.9 4754.6 5059.6 5102.5 4752.7 5014.1 5081.6 5540.7 5717.9 1464.4 1602.2 1615.0 1625.7 1652.6 1042.2 1162.6 1190.9 1197.6 1226.0 5042.9 5488.6 5493.0 5498.5 5519.3 4894.6 5556.2 5614.2 5706.7 5714.7 4340.6 4562.5 5404.8 5468.6 5563.8 2616.0 2792.8 2913.6 2929.9 3084.5 5696.5 5835.3 6072.5 6144.7 6170.3 5056.8 5560.0 5652.1 5808.3 6032.3 5186.5 5610.7 5636.7 5650.7 5977.9 5700.4 5880.2 5954.5 5977.6 6007.5 4990.5 5831.9 5841.9 5846.5 5855.9 5500.6 5522.8 5943.1 5987.8 6010.3 4673.7 5182.7 5204.3 5245.0 5268.5 5474.8 5586.0 5741.9 6001.3 6059.4 5039.2 5054.9 5206.9 5494.9 5623.9 5722.6 5755.9 5759.3 5774.2 5780.0 4733.6 5296.8 5357.3 5683.4 5704.9 4829.4 4873.3 5171.8 5624.9 5727.2 4967.7 5326.0 5439.8 5662.2 5663.7 10:10:48 INFO - PROCESS | 1647 | 10:10:48 INFO - PROCESS | 1647 | [#5] yui.html Cycles:180 Average:20641.14 Median:23206.36 stddev:30222.53 (130.2%) stddev-sans-first:30270.47 10:10:48 INFO - PROCESS | 1647 | Values: 766.8 769.6 889.8 893.1 909.2 15996.5 16247.8 16660.6 17465.3 18394.7 14222.8 16389.6 16435.6 16642.9 17889.0 984.3 1000.9 1002.0 1005.3 1012.6 989.2 992.5 993.7 999.6 1021.1 1040.3 1041.0 1043.4 1044.1 1044.9 1039.9 1040.6 1040.8 1041.3 1042.3 769.3 769.9 772.1 772.4 773.0 14204.4 17458.3 17466.0 18406.4 18695.5 14625.8 14922.4 15040.1 15076.7 15281.0 10389.8 10783.8 11929.2 12260.3 12416.8 3247.8 3787.8 3875.3 3904.7 3995.2 113336.0 117750.8 120379.4 120448.0 121670.0 11435.0 11625.9 11634.8 11812.2 11874.4 22220.1 22537.3 23875.4 23893.6 23916.4 8159.9 8194.9 8350.0 8463.3 8517.6 3772.4 4457.3 4624.7 4711.2 4857.0 3577.6 3674.4 3676.2 3715.4 3732.1 658.7 663.1 671.3 675.8 676.0 674.8 693.8 702.6 724.8 764.1 8631.8 9409.4 10639.4 10859.5 11020.3 709.5 716.0 721.6 724.2 729.7 4850.6 5163.3 5228.6 5273.5 5305.3 87092.0 88992.1 106953.0 108078.5 108515.0 84745.6 95125.0 95128.5 98159.0 98789.5 37697.8 37884.8 59065.9 83513.7 86674.0 9827.1 10291.6 10319.3 10322.0 10334.5 35366.6 54372.0 56105.0 57309.4 57867.4 57023.7 69898.7 71474.0 71550.9 71896.6 11592.7 11644.8 11873.2 11954.5 12368.6 13420.4 13513.7 13740.8 13780.6 14342.4 12090.3 12524.4 12673.5 12760.0 13084.4 11985.0 12490.3 12679.7 12857.8 13106.8 11895.5 12356.3 12358.9 12546.7 12589.4 8899.3 9346.3 9500.7 9528.8 9583.2 9774.6 10420.0 10429.9 10458.1 10462.6 10:10:48 INFO - PROCESS | 1647 | -------- Summary: end -------- 10:10:48 INFO - PROCESS | 1647 | 10:10:49 INFO - TEST-INFO | 1647: exit 0 10:10:49 INFO - TEST-OK | dromaeo_css | took 1118112ms 10:10:49 INFO - TEST-START | kraken 10:10:49 INFO - operating with platform_type : mac_ 10:10:49 INFO - Initialising browser for kraken test... 10:10:49 INFO - TEST-INFO | started process 1657 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/tmpBT2_7q/profile http://localhost:49248/getInfo.html) 10:10:51 INFO - PROCESS | 1657 | __metrics Screen width/height:1600/1200 10:10:51 INFO - PROCESS | 1657 | colorDepth:24 10:10:51 INFO - PROCESS | 1657 | Browser inner width/height: 1024/689 10:10:51 INFO - PROCESS | 1657 | __metrics 10:10:51 INFO - PROCESS | 1657 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 10:10:51 INFO - PROCESS | 1657 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:10:52 INFO - TEST-INFO | 1657: exit 0 10:10:52 INFO - Browser initialized. 10:10:52 INFO - Running cycle 1/1 for kraken test... 10:10:52 INFO - TEST-INFO | started process 1659 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/tmpBT2_7q/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:11:04 INFO - PROCESS | 1659 | RSS: Main: 165134336 10:11:04 INFO - PROCESS | 1659 | 10:11:07 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49248/tests/kraken/driver.html?testName=audio-beat-detection) 10:11:08 INFO - PROCESS | 1659 | RSS: Main: 215822336 10:11:08 INFO - PROCESS | 1659 | 10:11:10 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49248/tests/kraken/driver.html?testName=audio-dft) 10:11:11 INFO - PROCESS | 1659 | RSS: Main: 231100416 10:11:11 INFO - PROCESS | 1659 | 10:11:14 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49248/tests/kraken/driver.html?testName=audio-fft) 10:11:15 INFO - PROCESS | 1659 | RSS: Main: 327901184 10:11:15 INFO - PROCESS | 1659 | 10:11:17 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49248/tests/kraken/driver.html?testName=audio-oscillator) 10:11:17 INFO - PROCESS | 1659 | RSS: Main: 230027264 10:11:17 INFO - PROCESS | 1659 | 10:11:19 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49248/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:11:20 INFO - PROCESS | 1659 | RSS: Main: 231628800 10:11:20 INFO - PROCESS | 1659 | 10:11:23 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49248/tests/kraken/driver.html?testName=imaging-darkroom) 10:11:24 INFO - PROCESS | 1659 | RSS: Main: 271736832 10:11:24 INFO - PROCESS | 1659 | 10:11:26 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49248/tests/kraken/driver.html?testName=imaging-desaturate) 10:11:27 INFO - PROCESS | 1659 | RSS: Main: 272859136 10:11:27 INFO - PROCESS | 1659 | 10:11:30 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49248/tests/kraken/driver.html?testName=json-parse-financial) 10:11:31 INFO - PROCESS | 1659 | RSS: Main: 268546048 10:11:31 INFO - PROCESS | 1659 | 10:11:32 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49248/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:11:33 INFO - PROCESS | 1659 | RSS: Main: 246755328 10:11:33 INFO - PROCESS | 1659 | 10:11:35 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:11:35 INFO - PROCESS | 1659 | RSS: Main: 252141568 10:11:35 INFO - PROCESS | 1659 | 10:11:37 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:11:38 INFO - PROCESS | 1659 | RSS: Main: 255799296 10:11:38 INFO - PROCESS | 1659 | 10:11:41 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:11:42 INFO - PROCESS | 1659 | RSS: Main: 262381568 10:11:42 INFO - PROCESS | 1659 | 10:11:45 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:11:45 INFO - PROCESS | 1659 | RSS: Main: 263516160 10:11:45 INFO - PROCESS | 1659 | 10:11:47 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49248/tests/kraken/driver.html?testName=ai-astar) 10:11:47 INFO - PROCESS | 1659 | RSS: Main: 308310016 10:11:47 INFO - PROCESS | 1659 | 10:11:47 INFO - PROCESS | 1659 | __start_tp_report 10:11:47 INFO - PROCESS | 1659 | _x_x_mozilla_page_load 10:11:47 INFO - PROCESS | 1659 | _x_x_mozilla_page_load_details 10:11:47 INFO - PROCESS | 1659 | |i|pagename|runs| 10:11:47 INFO - PROCESS | 1659 | |0;ai-astar;105;114;115;114;114;116;114;114;112;115 10:11:47 INFO - PROCESS | 1659 | |1;audio-beat-detection;143;110;104;145;125;95;126;134;157;117 10:11:47 INFO - PROCESS | 1659 | |2;audio-dft;185;184;187;184;186;184;185;185;185;186 10:11:47 INFO - PROCESS | 1659 | |3;audio-fft;83;61;60;92;62;58;56;60;74;59 10:11:47 INFO - PROCESS | 1659 | |4;audio-oscillator;90;69;87;69;70;69;82;69;69;83 10:11:47 INFO - PROCESS | 1659 | |5;imaging-gaussian-blur;87;88;88;87;134;125;87;87;86;92 10:11:47 INFO - PROCESS | 1659 | |6;imaging-darkroom;93;92;93;93;94;93;94;93;96;94 10:11:47 INFO - PROCESS | 1659 | |7;imaging-desaturate;84;84;83;87;87;83;85;86;84;83 10:11:47 INFO - PROCESS | 1659 | |8;json-parse-financial;60;59;59;61;64;63;62;62;64;64 10:11:47 INFO - PROCESS | 1659 | |9;json-stringify-tinderbox;61;57;64;60;60;57;57;58;57;57 10:11:47 INFO - PROCESS | 1659 | |10;stanford-crypto-aes;85;84;84;85;83;83;84;87;106;84 10:11:47 INFO - PROCESS | 1659 | |11;stanford-crypto-ccm;135;127;130;119;135;140;143;149;160;149 10:11:47 INFO - PROCESS | 1659 | |12;stanford-crypto-pbkdf2;159;155;167;162;199;221;222;176;165;159 10:11:47 INFO - PROCESS | 1659 | |13;stanford-crypto-sha256-iterative;65;63;65;64;63;64;63;62;74;66 10:11:47 INFO - PROCESS | 1659 | __end_tp_report 10:11:47 INFO - PROCESS | 1659 | __start_cc_report 10:11:47 INFO - PROCESS | 1659 | _x_x_mozilla_cycle_collect,1999 10:11:47 INFO - PROCESS | 1659 | __end_cc_report 10:11:47 INFO - PROCESS | 1659 | __startTimestamp1494436307776__endTimestamp 10:11:47 INFO - PROCESS | 1659 | 10:11:47 INFO - PROCESS | 1659 | ------- Summary: start ------- 10:11:47 INFO - PROCESS | 1659 | Number of tests: 14 10:11:47 INFO - PROCESS | 1659 | 10:11:47 INFO - PROCESS | 1659 | [#0] ai-astar Cycles:10 Average:113.30 Median:114.00 stddev:3.09 (2.7%) stddev-sans-first:1.09 10:11:47 INFO - PROCESS | 1659 | Values: 105.0 114.0 115.0 114.0 114.0 116.0 114.0 114.0 112.0 115.0 10:11:47 INFO - PROCESS | 1659 | 10:11:47 INFO - PROCESS | 1659 | [#1] audio-beat-detection Cycles:10 Average:125.60 Median:138.50 stddev:19.60 (14.1%) stddev-sans-first:19.75 10:11:47 INFO - PROCESS | 1659 | Values: 143.0 110.0 104.0 145.0 125.0 95.0 126.0 134.0 157.0 117.0 10:11:47 INFO - PROCESS | 1659 | 10:11:47 INFO - PROCESS | 1659 | [#2] audio-dft Cycles:10 Average:185.10 Median:185.00 stddev:0.99 (0.5%) stddev-sans-first:1.05 10:11:47 INFO - PROCESS | 1659 | Values: 185.0 184.0 187.0 184.0 186.0 184.0 185.0 185.0 185.0 186.0 10:11:47 INFO - PROCESS | 1659 | 10:11:47 INFO - PROCESS | 1659 | [#3] audio-fft Cycles:10 Average:66.50 Median:61.50 stddev:12.26 (19.9%) stddev-sans-first:11.46 10:11:47 INFO - PROCESS | 1659 | Values: 83.0 61.0 60.0 92.0 62.0 58.0 56.0 60.0 74.0 59.0 10:11:47 INFO - PROCESS | 1659 | 10:11:47 INFO - PROCESS | 1659 | [#4] audio-oscillator Cycles:10 Average:75.70 Median:76.00 stddev:8.71 (11.5%) stddev-sans-first:7.54 10:11:47 INFO - PROCESS | 1659 | Values: 90.0 69.0 87.0 69.0 70.0 69.0 82.0 69.0 69.0 83.0 10:11:47 INFO - PROCESS | 1659 | 10:11:47 INFO - PROCESS | 1659 | [#5] imaging-gaussian-blur Cycles:10 Average:96.10 Median:87.00 stddev:17.80 (20.5%) stddev-sans-first:18.58 10:11:47 INFO - PROCESS | 1659 | Values: 87.0 88.0 88.0 87.0 134.0 125.0 87.0 87.0 86.0 92.0 10:11:47 INFO - PROCESS | 1659 | 10:11:47 INFO - PROCESS | 1659 | [#6] imaging-darkroom Cycles:10 Average:93.50 Median:93.50 stddev:1.08 (1.2%) stddev-sans-first:1.13 10:11:47 INFO - PROCESS | 1659 | Values: 93.0 92.0 93.0 93.0 94.0 93.0 94.0 93.0 96.0 94.0 10:11:47 INFO - PROCESS | 1659 | 10:11:47 INFO - PROCESS | 1659 | [#7] imaging-desaturate Cycles:10 Average:84.60 Median:84.50 stddev:1.58 (1.9%) stddev-sans-first:1.66 10:11:47 INFO - PROCESS | 1659 | Values: 84.0 84.0 83.0 87.0 87.0 83.0 85.0 86.0 84.0 83.0 10:11:47 INFO - PROCESS | 1659 | 10:11:47 INFO - PROCESS | 1659 | [#8] json-parse-financial Cycles:10 Average:61.80 Median:62.50 stddev:1.99 (3.2%) stddev-sans-first:2.00 10:11:47 INFO - PROCESS | 1659 | Values: 60.0 59.0 59.0 61.0 64.0 63.0 62.0 62.0 64.0 64.0 10:11:47 INFO - PROCESS | 1659 | 10:11:47 INFO - PROCESS | 1659 | [#9] json-stringify-tinderbox Cycles:10 Average:58.80 Median:59.00 stddev:2.39 (4.1%) stddev-sans-first:2.40 10:11:47 INFO - PROCESS | 1659 | Values: 61.0 57.0 64.0 60.0 60.0 57.0 57.0 58.0 57.0 57.0 10:11:47 INFO - PROCESS | 1659 | 10:11:47 INFO - PROCESS | 1659 | [#10] stanford-crypto-aes Cycles:10 Average:86.50 Median:84.00 stddev:6.95 (8.3%) stddev-sans-first:7.35 10:11:47 INFO - PROCESS | 1659 | Values: 85.0 84.0 84.0 85.0 83.0 83.0 84.0 87.0 106.0 84.0 10:11:47 INFO - PROCESS | 1659 | 10:11:47 INFO - PROCESS | 1659 | [#11] stanford-crypto-ccm Cycles:10 Average:138.70 Median:141.50 stddev:12.08 (8.5%) stddev-sans-first:12.74 10:11:47 INFO - PROCESS | 1659 | Values: 135.0 127.0 130.0 119.0 135.0 140.0 143.0 149.0 160.0 149.0 10:11:47 INFO - PROCESS | 1659 | 10:11:47 INFO - PROCESS | 1659 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:178.50 Median:171.50 stddev:25.87 (15.1%) stddev-sans-first:26.46 10:11:47 INFO - PROCESS | 1659 | Values: 159.0 155.0 167.0 162.0 199.0 221.0 222.0 176.0 165.0 159.0 10:11:47 INFO - PROCESS | 1659 | 10:11:47 INFO - PROCESS | 1659 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.90 Median:64.50 stddev:3.41 (5.3%) stddev-sans-first:3.62 10:11:47 INFO - PROCESS | 1659 | Values: 65.0 63.0 65.0 64.0 63.0 64.0 63.0 62.0 74.0 66.0 10:11:47 INFO - PROCESS | 1659 | -------- Summary: end -------- 10:11:47 INFO - PROCESS | 1659 | 10:11:48 INFO - TEST-INFO | 1659: exit 0 10:11:48 INFO - TEST-OK | kraken | took 59137ms 10:11:48 INFO - SUITE-END | took 1177s 10:11:48 INFO - Completed test suite (00:19:37) 10:11:48 INFO - javascript benchmark 10:11:48 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7832.664117497472, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2849.5013372659787, 3224.9516257256137, 3595.6044835068155, 3625.3111908737355, 3637.727170462216, 6126.7855625053135, 6195.132681424593, 6203.782867599629, 6217.316095229521, 6244.875102497947, 6183.319834818167, 6216.937830621692, 6228.065790131483, 6228.750849966007, 6231.439170474657, 5524.4199359067225, 5541.501264886159, 5575.581831362644, 5601.80393686221, 5681.573881958849, 5400.162974738922, 5432.538234250093, 5435.0, 5656.0, 5664.688442135681, 5540.168974653794, 5544.695041772701, 5549.001179787637, 5554.833354999357, 5555.694386829481, 5501.229827824088, 5531.778728850841, 5537.861553461195, 5542.140968149944, 5546.112621980504, 5397.568194544427, 5499.230107784913, 5505.504504594605, 5520.834374968757, 5525.392206857243, 5092.0, 6194.690265486753, 6214.130021796952, 6215.2541694996435, 6222.5644204905675, 5396.892062158735, 6284.151639528696, 6393.328700486429, 6413.871722565569, 6441.3880681335195, 5751.338596061465, 6660.633665148415, 6667.0, 6688.197416310025, 6696.732130714766, 6151.753929842801, 6241.687915604201, 6285.340039295854, 6297.779577714758, 6311.621302721851, 6447.709853056624, 6485.0, 6596.835079122964, 6836.487263455261, 6840.281770414134, 6344.143540622049, 6381.617102973836, 6438.066480360415, 6474.482041436674, 6487.0, 6606.900896486556, 6613.272540020594, 6617.503687223478, 6627.237867645186, 6644.83387915306, 6316.0, 6395.648239346788, 6540.607563546202, 6543.280239173687, 6559.573627714183, 6376.29860715321, 6396.136521569621, 6413.807585772434, 6425.871482570323, 6562.80311590653, 5328.893422131613, 5332.626716129911, 5333.280007198979, 5336.813211537577, 5366.007288651534, 4725.3384526166365, 4727.267273572602, 4751.64362672801, 4755.95244047562, 4793.640476964172, 6106.225468276498, 6132.642724909311, 6208.72060757267, 6276.686165691697, 6324.462420694201, 6345.809625711236, 6350.333215012357, 6383.904241436382, 6498.577592456475, 6535.607863528204, 5229.686218826807, 6309.369063093745, 6334.904976425358, 6377.202849643794, 6402.583832050902, 5785.929603023455, 5863.032599621015, 5869.442402971711, 5870.618409803435, 5877.177195192677, 6508.837279068061, 6553.115329430657, 6738.528303018742, 6850.417714494224, 6913.1358580177475, 6570.671466426755, 6611.438027767694, 6639.767608133692, 6646.501512386493, 6651.700673469609, 6821.658917054227, 6870.931290687029, 6872.45020398357, 6881.380675739208, 6904.27505111956, 6314.873702526015, 6356.396142366468, 6459.289478157305, 6501.902471463027, 6560.704768285344, 6462.741490340334, 6492.740290388331, 6527.0, 6635.6350400728425, 6655.633940133339, 6145.692715364304, 6444.709988050456, 6451.903221451588, 6459.192600924885, 6462.321456247214, 6274.341194174546, 6321.936780632135, 6450.322716114928, 6473.935260647521, 6477.740890364333, 6281.59169653971, 6288.056791481315, 6373.044043393528, 6379.744810207725, 6395.360463953567, 6425.453836423956, 6454.741810327534, 6460.709268082854, 6464.997925321582, 6465.870682586416, 6230.50155987529, 6310.11658367838, 6370.331115232834, 6374.0, 6383.0], "value": 6040.406375655881, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [780.16911988732, 812.6261919517021, 829.6100832608673, 907.6369452219111, 913.7989642278696, 28653.71346286539, 28928.0, 30059.84970075152, 30113.0, 41302.0, 42528.78735606318, 42697.57302426975, 42800.0, 42811.57188428115, 42854.57145428545, 9598.088181622734, 9772.07165319297, 9781.315307928448, 9786.3638863474, 9798.510074496282, 7779.222077792232, 7917.445778795487, 8321.916780832174, 9616.663416780415, 9760.90239097607, 11472.71318217043, 11557.075433965263, 11642.068634509218, 11732.824007639892, 11901.0, 11699.18105732599, 11745.236559623598, 11745.765084698343, 11767.41162941858, 11768.705782355424, 9617.374870633457, 11431.14266430021, 11474.48364823585, 11487.138464615187, 11512.481938312796, 39860.00349991273, 40132.19735605272, 40181.99545011369, 40212.195756085006, 40295.79852100721, 4043.777592232426, 4123.628873401408, 4124.381342798604, 4125.938110928339, 4160.043190066272, 27332.0, 27429.45141097167, 28205.717942820513, 28805.279868003257, 29381.70618293811, 3134.905952821419, 3264.918377040593, 3270.345930813823, 3290.1610089427045, 3342.1477523231665, 344846.0, 351108.0, 351293.0, 351407.0, 351743.0, 50188.49811501838, 50227.748861256194, 50289.74855125701, 50307.7423064419, 50363.74090647763, 52089.21866172011, 52091.739541302806, 52127.47872521226, 52222.0, 52246.0, 14319.78520322196, 14650.633734156518, 14652.487162949246, 14664.193469359288, 14666.413343466354, 12748.681282967815, 12749.745005099847, 12750.48998040068, 12771.61685149447, 12778.23330600167, 10437.217208709377, 10631.989960953697, 10644.361338319726, 11502.597409090642, 11624.476898539586, 5337.172738225581, 5464.398916119224, 5501.697406642673, 5504.889902201933, 5524.779008839601, 756.2966441209618, 911.9635214591342, 986.5215370545279, 994.1152374386802, 1029.0738335497963, 27558.86220568884, 28275.858620706764, 28408.147755567366, 28944.276393090342, 28957.56563651547, 1063.8138325792954, 1064.7284942339654, 1103.2773533335678, 1103.61925135828, 1106.3859557945257, 13649.727005460034, 14770.039947403384, 14969.850301496846, 14991.925040374947, 15063.171525566198, 423279.0, 423436.0, 423603.0, 423760.0, 425523.0, 48702.26946595804, 49151.0, 55225.72387138039, 55253.0, 57169.428305716414, 1476.8892333074848, 1521.8706409955278, 1522.9695406092037, 1527.0990115831712, 1530.7091652586196, 29346.706532934397, 30037.54943675803, 30146.24634384158, 30460.181211254243, 30637.387252254382, 46089.308660369454, 46295.0, 46320.7683961578, 46354.536454635025, 46422.53577464182, 398569.0, 398711.0, 450768.0, 538097.0, 550686.2465687646, 33827.66172338245, 33969.830150849084, 34085.0, 34174.0, 34760.78337258184, 42919.356209657504, 43110.78444607757, 43174.35238471488, 43254.0, 43488.69533913988, 29467.41065178727, 30090.0, 30135.0, 30280.697193028667, 30907.381852363276, 29748.553771693874, 30007.399852003273, 30838.92063777757, 30883.69116308898, 30980.53529197109, 34223.31553368869, 35744.0, 36314.63685363218, 36427.27145457129, 36666.8166659165, 29964.70035299619, 30053.398932021675, 30067.849660751555, 30399.696003039688, 30859.382812343178, 23805.523889522457, 23858.761412385655, 23983.52032959296, 24319.878400607882, 24429.38926526851], "value": 18826.80095980782, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [411.9629233368996, 419.3437270671401, 438.9319655453406, 439.91642546339773, 444.09626410255095, 20223.696644550324, 21468.0, 22449.87750612467, 22655.433614159654, 22828.771712282873, 18863.811361886375, 22583.435414114654, 22730.977106030226, 23135.652965205492, 23481.708506032162, 6576.769813056544, 6692.431143352821, 6929.7574584889535, 6940.895886561706, 6944.305569443066, 6705.597664140168, 6828.0, 6846.863062738742, 6865.725370985155, 6882.242953275136, 6529.0, 6748.426383757386, 6826.795196144099, 6867.07294515239, 6895.862082758342, 6713.93286067138, 6755.121834161577, 6814.080099186596, 6821.317868213188, 6824.965875170592, 6619.205695316593, 6660.966695166493, 6672.232693240291, 6690.19717633887, 6706.497012724065, 26795.732042679712, 26941.461170776474, 27022.919083236648, 27058.729412706016, 27314.45371092567, 2392.712874455059, 2915.1395825170835, 2976.479116154686, 2991.4615369233748, 3009.759219262454, 10985.725356866062, 14950.40198392063, 14975.0, 15029.849701502955, 15574.831887608474, 1776.3782676063404, 2053.37372101509, 2078.9480262993393, 2113.3871177358546, 2118.7775283595156, 136016.6398336014, 137967.0, 138144.0, 140962.29518852444, 142464.0, 15786.526404207892, 20650.380488585368, 20693.0, 20853.976173455067, 20932.79067209339, 33391.33217335688, 33982.49026264608, 34150.0, 34213.0, 34247.0, 8672.046074931752, 10821.9458902705, 11223.887761122285, 11286.322820630789, 11370.0, 9095.81808363829, 9117.77205569866, 9136.314776391664, 9293.303002274857, 9296.535173241311, 9586.424814511152, 9599.616015359308, 9661.101669499121, 9782.0, 9826.164775993977, 3070.8925187618775, 3937.1928754605237, 3992.1017771001875, 3992.401139828991, 4150.190712810973, 1068.732816795801, 1110.7056629993058, 1119.9664010079712, 1130.6438471881331, 1169.502961241469, 20416.693749593767, 22083.779162208495, 22520.887395562917, 22591.548169036527, 22627.20804771825, 1065.4406436620836, 1067.546292825546, 1110.7389763405592, 1110.7722916802036, 1115.358668765447, 11229.438528073564, 11937.88062119385, 11960.0, 12011.579594714143, 12019.158658893793, 749391.0, 757861.4748483776, 762719.0, 770719.0, 785769.0, 107077.92922070835, 119377.8062219384, 119444.40277798555, 121704.0, 125488.37255813663, 1279.181323952671, 1284.8072789081525, 1324.0136098606408, 1324.0202250334683, 1328.9867101329057, 17916.731249031534, 19178.712319314942, 19205.615887681888, 19291.4212573623, 19294.324698636043, 50948.726281841766, 51379.74310128575, 51646.48353516567, 51804.74097629639, 52547.73726131345, 67366.0, 69159.65420172867, 69317.65341173262, 69483.65258173677, 71031.0, 9341.532923353941, 11281.943590281997, 11575.88424115748, 11795.11536634773, 11979.34113623759, 12412.937935310265, 12416.0, 12638.684032899251, 12794.936025320187, 12809.487620495076, 10855.67432977012, 10997.505112269808, 11148.386838723947, 11228.606998755004, 11379.886201138213, 10177.134943529883, 10244.48777561104, 10287.84568231492, 10509.527071281658, 10567.418791966209, 11151.996320331209, 11224.438778060901, 11516.251443656136, 11609.825852612386, 11655.88344116548, 11576.305421674726, 11859.05127589808, 11938.0, 11941.582044628396, 11951.984081353183, 10819.729506762395, 10955.945220273848, 11017.504212310625, 11018.669439916815, 11221.943890280496], "value": 11478.434445748273, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1535.286091967235, 1580.1941010084856, 1590.9363625454982, 1619.813721422037, 1659.2450435052053, 9006.504642244674, 11574.884251157486, 11595.072394208464, 11599.420028998547, 11622.825657615122, 10812.891871081287, 11092.057175140102, 11196.776064478727, 11206.66380008599, 11253.718657033558, 2479.1323036937065, 2516.7609077137645, 2518.5214809186286, 2520.936976575591, 2522.369407648088, 2450.5834008218644, 2475.900963961439, 2524.1039431002005, 2525.734797846218, 2526.090607381341, 2477.2196758021164, 2477.665515155458, 2494.114589320792, 2516.006177559863, 2517.3203235126507, 2143.0, 2411.8182090775567, 2418.2745176446997, 2467.0748469324003, 2481.7146028206807, 2448.0574978633354, 2483.453640199153, 2485.1302044284357, 2491.539065272912, 2495.0768215760286, 11132.888671113265, 11369.260998035184, 11385.715357116056, 11394.088472922229, 11408.828867566994, 5929.73316200772, 6114.449699527064, 6125.479334256594, 6127.448529632355, 6130.2030736004035, 3088.258817883714, 3733.21602463483, 3808.257389808988, 3813.466114743938, 3821.2357528494413, 1136.1081550982522, 1255.2782150263636, 1269.4668239339408, 1297.3383574377042, 1311.4229738914942, 14331.06848054873, 14630.0, 14957.551273461813, 15811.288492017888, 15989.840101598951, 4708.623310135181, 4884.95115048852, 4887.36464259644, 4899.926501102486, 4928.28539861718, 11975.041996640248, 11975.88024119765, 11986.460609272604, 11995.460204290828, 12009.919107280386, 5136.409312929061, 5283.233931080049, 5881.911771323434, 5972.790952316648, 6013.579049466495, 5317.707526086102, 5486.1770734389365, 5563.721813909369, 5566.638168519034, 5570.526505247019, 3683.6132206117973, 3974.7615143091507, 3986.5216174059296, 4072.0023594219606, 4072.979635101865, 1000.2847963705985, 1075.44077079918, 1078.5254488025244, 1090.0734375780683, 1090.7763908398758, 913.1918252346721, 923.1414784250711, 942.2226663002913, 968.6851773173747, 1001.6744558018673, 6489.221293444817, 6509.2839787623325, 6611.768588099393, 6780.355866192704, 6803.0135630333325, 824.575343697996, 947.3557980573277, 960.4285450157146, 968.9563969621383, 1036.6060896859144, 3426.777259478126, 4112.814923328458, 4273.786310684453, 4291.270484017725, 4352.955290730202, 13638.386272617756, 14251.073680210753, 14269.429222831179, 14274.000819942712, 14297.428102875976, 13676.179429234278, 13843.930780346236, 14135.717285654435, 14165.93755468344, 14214.715705686036, 10053.296269261082, 10274.640387586398, 10424.0, 10441.947790261, 10546.525406356732, 6830.146231721035, 6874.587524748531, 6895.5173137881875, 6951.582905025714, 6997.37023667852, 11576.94211528937, 12411.255324680547, 12532.0, 12539.498420063095, 12670.429830657458, 12728.363581821057, 12850.742985140057, 12924.353782310658, 12933.870661293644, 12976.221426714428, 9250.306227033134, 9493.335466517277, 9512.191463725661, 9517.52412379392, 9519.952805191286, 8093.433459657767, 10415.739606509898, 10446.843297350393, 10551.41967191781, 10571.101456376295, 8756.868646970428, 8830.514321712368, 8924.732258032269, 8952.462852228888, 8962.641578824408, 8580.914190858011, 8581.485110893116, 8646.394752367525, 8646.567671616269, 8661.480311181349, 7788.0, 7882.369410447265, 7917.0, 7936.84126317482, 7943.920560794318, 5824.854378640398, 5830.854228644318, 5863.618864773776, 6018.277806663228, 6057.818265452043, 5500.394956554695, 5589.021921163699, 5940.3168635605725, 6086.02623580225, 6219.782307619212], "value": 5230.114565683247, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [350.80530305680355, 390.8749200255918, 393.4354201720531, 395.29242655646397, 396.16607042176236, 4478.888027799307, 5097.770600322985, 5448.15114548052, 5539.086050801618, 5606.971965140168, 4694.671373003891, 5170.482951704827, 5250.396204436491, 5260.922360419159, 5408.972955135218, 4237.8769626049125, 4383.3424986252, 4427.77861106945, 4439.533848945863, 4478.843240486575, 3723.460098285747, 3961.9603803962023, 4484.708493947899, 4492.742761497921, 4502.8874278142985, 3736.7384283100196, 4060.7157498975084, 4240.427542281799, 4284.764337961411, 4439.2675208590545, 3601.477785721069, 4063.3092374296143, 4388.319810429389, 4392.626626736731, 4398.406215160944, 3371.3257348530146, 4089.4683691120263, 4109.958900410988, 4116.176764647053, 4140.503139623264, 4360.585744354281, 4951.078863470534, 5064.924026139611, 5307.389650190239, 5384.811531596414, 4887.608991280689, 5031.496850314976, 5081.678763521474, 5118.795248190068, 5145.0, 5753.626014309057, 5761.423857614247, 5810.622309549908, 5836.416358364129, 5840.4451577100535, 4510.571495707903, 4564.383808185886, 4628.282616194495, 4632.050429661911, 4674.252119660872, 4766.76166191689, 5740.68426236561, 5867.266591675998, 5912.398544640345, 6011.939880601226, 3858.479105320802, 4139.379093136054, 4385.736855788663, 4390.846320378835, 4660.277656963176, 4206.747595144301, 4488.0, 4511.684182107221, 4813.95186048142, 4820.638452116105, 3967.3652215645357, 4501.919539310542, 4754.619630429557, 5059.595232381401, 5102.540771330598, 4752.667313288037, 5014.066770939042, 5081.59347252219, 5540.667559946335, 5717.942820571741, 1464.3630020940925, 1602.1748799368336, 1614.9757753633705, 1625.7154997875325, 1652.570331713739, 1042.2391654092403, 1162.6222925832747, 1190.9285442873456, 1197.6407077876602, 1225.96935076622, 5042.873928151826, 5488.615796894259, 5493.0, 5498.532624726863, 5519.282493275929, 4894.559489645949, 5556.166465066518, 5614.175392997292, 5706.657600543981, 5714.657120572779, 4340.631046361032, 4562.452505699271, 5404.8108316208745, 5468.56648791292, 5563.7774489019985, 2616.0118310084094, 2792.7765778737653, 2913.6357955255594, 2929.8866430756175, 3084.506478963355, 5696.515796157373, 5835.306601688064, 6072.453479186806, 6144.692765361714, 6170.315912578043, 5056.84829455117, 5559.972200138974, 5652.0674088774895, 5808.332041815161, 6032.306284777219, 5186.510474972035, 5610.671571297948, 5636.689982051026, 5650.745716442852, 5977.940220597825, 5700.372958974426, 5880.235929221302, 5954.4938680210935, 5977.6114552553945, 6007.48936340416, 4990.451050384382, 5831.912521312099, 5841.912371314519, 5846.473817356458, 5855.916655418761, 5500.642458240201, 5522.7573795895605, 5943.108533719977, 5987.820365389045, 6010.338862725184, 4673.719576825401, 5182.714950677749, 5204.2714020036465, 5244.9737751310995, 5268.525832675077, 5474.839122267185, 5586.022446072003, 5741.856453588526, 6001.309849367379, 6059.394060593905, 5039.244113383022, 5054.924176137288, 5206.921896171636, 5494.851387202796, 5623.8594035149445, 5722.599418040697, 5755.942440575541, 5759.337676167294, 5774.162746401832, 5780.0, 4733.644976626836, 5296.814611488579, 5357.330333708286, 5683.374828768915, 5704.942950570441, 4829.4204695435365, 4873.29434697853, 5171.844844654666, 5624.85937851557, 5727.226824378656, 4967.652264341606, 5326.0, 5439.836804895859, 5662.188099808021, 5663.725661726078], "value": 4351.0684839044825, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [766.750805988054, 769.5998080997881, 889.7864512516998, 893.0979710492402, 909.2498688581921, 15996.520104396872, 16247.846136990664, 16660.58348541287, 17465.301387944466, 18394.724079138825, 14222.786658200135, 16389.5902602435, 16435.58911027222, 16642.916785416055, 17889.0, 984.3454103021483, 1000.929934904557, 1002.013017178079, 1005.3013155856682, 1012.5848402155118, 989.2333441582795, 992.4541502173812, 993.6869885985927, 999.6001599360242, 1021.101430740947, 1040.3133931605141, 1041.0006393861902, 1043.4209013997267, 1044.1020722178957, 1044.879838818538, 1039.8648175737105, 1040.5525623981684, 1040.7762331098813, 1041.312733595827, 1042.280826229899, 769.2807225244414, 769.8537277917178, 772.1390649425906, 772.4361216312068, 772.9652165652559, 14204.431822727078, 17458.30166793327, 17466.039367834765, 18406.35577754772, 18695.532611684815, 14625.78061329081, 14922.403103875831, 15040.097594144278, 15076.698466030728, 15281.0, 10389.753229612495, 10783.83824242637, 11929.224600401032, 12260.325682087481, 12416.81374779379, 3247.8376081195847, 3787.7537960032787, 3875.302445559798, 3904.6876249899938, 3995.200959808021, 113336.0, 117750.82249177484, 120379.39810300981, 120448.0, 121670.0, 11435.0, 11625.88374116248, 11634.825477617842, 11812.232204906653, 11874.406279685982, 22220.111195551995, 22537.323880283617, 23875.403114922265, 23893.641595375735, 23916.402089947544, 8159.918400816035, 8194.918050819535, 8349.95825020871, 8463.322934165251, 8517.57412129391, 3772.39641657339, 4457.286834106592, 4624.699394539344, 4711.1519926413575, 4856.955754512796, 3577.624349443323, 3674.356987527172, 3676.2279921216846, 3715.3869611514338, 3732.1042949692423, 658.7101675262869, 663.1147418196762, 671.3152584363921, 675.7567275780715, 675.9729610815513, 674.7874419557921, 693.774523279936, 702.5714314268292, 724.7825652304288, 764.1212605503715, 8631.827363452696, 9409.435433873989, 10639.41483218415, 10859.511321990529, 11020.338779673246, 709.5033476566424, 715.9606221657755, 721.6355740351089, 724.1635910523248, 729.7482368582937, 4850.611951043908, 5163.302954101224, 5228.64091217163, 5273.472652734696, 5305.336832895888, 87092.0, 88992.11007889967, 106953.0, 108078.45960770146, 108515.0, 84745.57627211824, 95125.0, 95128.52435737777, 98159.0, 98789.50605246928, 37697.81151094282, 37884.81057594749, 59065.86538942319, 83513.74557655041, 86674.0, 9827.11555959967, 10291.639792607222, 10319.277650564389, 10322.0, 10334.534945927602, 35366.64633353634, 54372.0, 56105.0, 57309.42690573041, 57867.42132578789, 57023.71488142699, 69898.65050674714, 71474.0, 71550.92673609796, 71896.56206875938, 11592.710182245512, 11644.76710465769, 11873.228240164362, 11954.521819127138, 12368.567100151451, 13420.39608217613, 13513.662158446117, 13740.793888091886, 13780.635191092379, 14342.426302947766, 12090.274583524664, 12524.37378131108, 12673.493060277855, 12760.0, 13084.411201495765, 11985.0, 12490.250584964931, 12679.683007924506, 12857.778511041435, 13106.803397949228, 11895.464704088165, 12356.320402377956, 12358.876411236131, 12546.749065018832, 12589.43347549344, 8899.288056955558, 9346.345755797029, 9500.714978550655, 9528.809423811346, 9583.185429238592, 9774.589045513894, 10420.0, 10429.904859989896, 10458.058774710313, 10462.581496740046], "value": 7772.947189777397, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1429.6000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 114.0, 115.0, 114.0, 114.0, 116.0, 114.0, 114.0, 112.0, 115.0], "value": 113.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 110.0, 104.0, 145.0, 125.0, 95.0, 126.0, 134.0, 157.0, 117.0], "value": 125.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 184.0, 187.0, 184.0, 186.0, 184.0, 185.0, 185.0, 185.0, 186.0], "value": 185.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 61.0, 60.0, 92.0, 62.0, 58.0, 56.0, 60.0, 74.0, 59.0], "value": 66.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 69.0, 87.0, 69.0, 70.0, 69.0, 82.0, 69.0, 69.0, 83.0], "value": 75.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 88.0, 88.0, 87.0, 134.0, 125.0, 87.0, 87.0, 86.0, 92.0], "value": 96.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 92.0, 93.0, 93.0, 94.0, 93.0, 94.0, 93.0, 96.0, 94.0], "value": 93.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 83.0, 87.0, 87.0, 83.0, 85.0, 86.0, 84.0, 83.0], "value": 84.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 59.0, 59.0, 61.0, 64.0, 63.0, 62.0, 62.0, 64.0, 64.0], "value": 61.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 57.0, 64.0, 60.0, 60.0, 57.0, 57.0, 58.0, 57.0, 57.0], "value": 58.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 84.0, 85.0, 83.0, 83.0, 84.0, 87.0, 106.0, 84.0], "value": 86.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 127.0, 130.0, 119.0, 135.0, 140.0, 143.0, 149.0, 160.0, 149.0], "value": 138.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 155.0, 167.0, 162.0, 199.0, 221.0, 222.0, 176.0, 165.0, 159.0], "value": 178.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 63.0, 65.0, 64.0, 63.0, 64.0, 63.0, 62.0, 74.0, 66.0], "value": 64.9, "unit": "score"}]}]} 10:11:49 INFO - Return code: 0 10:11:49 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:11:49 INFO - # TBPL SUCCESS # 10:11:49 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:11:49 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:11:49 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:11:49 INFO - 2017-05-10 10:11:49.108 screenresolution[1663:10005] starting screenresolution argv=screenresolution get 10:11:49 INFO - 2017-05-10 10:11:49.110 screenresolution[1663:10005] Display 0: 1600x1200x32@60 10:11:49 INFO - 2017-05-10 10:11:49.117 screenresolution[1664:10008] starting screenresolution argv=screenresolution list 10:11:49 INFO - Available Modes on Display 0 10:11:49 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:11:49 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:11:49 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:11:49 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:11:49 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:11:49 INFO - Intel Iris: 10:11:49 INFO - Chipset Model: Intel Iris 10:11:49 INFO - Type: GPU 10:11:49 INFO - Bus: Built-In 10:11:49 INFO - VRAM (Dynamic, Max): 1536 MB 10:11:49 INFO - Vendor: Intel (0x8086) 10:11:49 INFO - Device ID: 0x0a2e 10:11:49 INFO - Revision ID: 0x0009 10:11:49 INFO - Displays: 10:11:49 INFO - Display: 10:11:49 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:11:49 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:11:49 INFO - Display Serial Number: 1600x1200 60 10:11:49 INFO - Main Display: Yes 10:11:49 INFO - Mirror: Off 10:11:49 INFO - Online: Yes 10:11:49 INFO - Rotation: Supported 10:11:49 INFO - Return code: 0 10:11:49 INFO - Running post-action listener: _resource_record_post_action 10:11:49 INFO - [mozharness: 2017-05-10 17:11:49.354046Z] Finished run-tests step (success) 10:11:49 INFO - Running post-run listener: _resource_record_post_run 10:11:49 INFO - Total resource usage - Wall time: 1193s; CPU: 54.0%; Read bytes: 44184576; Write bytes: 422711296; Read time: 520; Write time: 1486 10:11:49 INFO - TinderboxPrint: CPU usage
53.9% 10:11:49 INFO - TinderboxPrint: I/O read bytes / time
44,184,576 / 520 10:11:49 INFO - TinderboxPrint: I/O write bytes / time
422,711,296 / 1,486 10:11:49 INFO - TinderboxPrint: CPU idle
2,199.5 (46.1%) 10:11:49 INFO - TinderboxPrint: CPU system
954.8 (20.0%) 10:11:49 INFO - TinderboxPrint: CPU user
1,619.4 (33.9%) 10:11:49 INFO - TinderboxPrint: Swap in / out
165,519,360 / 0 10:11:49 INFO - install - Wall time: 15s; CPU: 54.0%; Read bytes: 117547520; Write bytes: 114362368; Read time: 10652; Write time: 247 10:11:49 INFO - run-tests - Wall time: 1179s; CPU: 54.0%; Read bytes: 42042368; Write bytes: 297375744; Read time: 496; Write time: 1204 10:11:49 INFO - Running post-run listener: _upload_blobber_files 10:11:49 INFO - Blob upload gear active. 10:11:49 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:11:49 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 10:11:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:11:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:11:50 INFO - (blobuploader) - INFO - Open directory for files ... 10:11:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:11:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:11:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:11:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:11:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:11:51 INFO - (blobuploader) - INFO - Done attempting. 10:11:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:11:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:11:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:11:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:11:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:11:52 INFO - (blobuploader) - INFO - Done attempting. 10:11:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 10:11:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:11:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:11:53 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 10:11:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:11:53 INFO - (blobuploader) - INFO - Done attempting. 10:11:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:11:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:11:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:11:55 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:11:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:11:55 INFO - (blobuploader) - INFO - Done attempting. 10:11:55 INFO - (blobuploader) - INFO - Iteration through files over. 10:11:55 INFO - Return code: 0 10:11:55 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:11:55 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:11:55 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6e9591fdfdaf569f1b60a15ea7dd659f8a969bdb6dc2dc2a7a78df007c90a879847cdfc16dfa4bd00e07de00c3b622ddaa59abccd66009e2308b2a9b2bc2c715", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8071955604fe0ac08b9805caef172a62e7f9dd60bf52f55e23b9917acee3bac8c9516983990628c038a23059865b199f4afa77bbc562c2b9ec816cede338218a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/68abe3963c4c6d6a4a1be7444e32f8235045877feb203b52aea2e8e724b452ec51eae27ff255fa351c8b55eed4bcd9d484e4ac19b1f448fe42da208b14a8eba0", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2b814be302ba9c4e99962f31d76428ac74fac5da91109a1ddfbf0886c72aa24d6a1164568eea7a88c881e21ec0e9b61d843f2fef33ddb53f48064a59dda51aa0"} 10:11:55 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:11:55 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:11:55 INFO - Contents: 10:11:55 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6e9591fdfdaf569f1b60a15ea7dd659f8a969bdb6dc2dc2a7a78df007c90a879847cdfc16dfa4bd00e07de00c3b622ddaa59abccd66009e2308b2a9b2bc2c715", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8071955604fe0ac08b9805caef172a62e7f9dd60bf52f55e23b9917acee3bac8c9516983990628c038a23059865b199f4afa77bbc562c2b9ec816cede338218a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/68abe3963c4c6d6a4a1be7444e32f8235045877feb203b52aea2e8e724b452ec51eae27ff255fa351c8b55eed4bcd9d484e4ac19b1f448fe42da208b14a8eba0", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2b814be302ba9c4e99962f31d76428ac74fac5da91109a1ddfbf0886c72aa24d6a1164568eea7a88c881e21ec0e9b61d843f2fef33ddb53f48064a59dda51aa0"} 10:11:55 INFO - Running post-run listener: copy_logs_to_upload_dir 10:11:55 INFO - Copying logs to upload dir... 10:11:55 INFO - mkdir: /builds/slave/test/build/upload/logs 10:11:55 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1270.028480 ========= master_lag: -0.08 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2017-05-10 10:11:55.912238) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-10 10:11:55.919322) ========= 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.w1oewBjS4H/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.b5TpYj8dlu/Listeners TMPDIR=/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6e9591fdfdaf569f1b60a15ea7dd659f8a969bdb6dc2dc2a7a78df007c90a879847cdfc16dfa4bd00e07de00c3b622ddaa59abccd66009e2308b2a9b2bc2c715", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8071955604fe0ac08b9805caef172a62e7f9dd60bf52f55e23b9917acee3bac8c9516983990628c038a23059865b199f4afa77bbc562c2b9ec816cede338218a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/68abe3963c4c6d6a4a1be7444e32f8235045877feb203b52aea2e8e724b452ec51eae27ff255fa351c8b55eed4bcd9d484e4ac19b1f448fe42da208b14a8eba0", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2b814be302ba9c4e99962f31d76428ac74fac5da91109a1ddfbf0886c72aa24d6a1164568eea7a88c881e21ec0e9b61d843f2fef33ddb53f48064a59dda51aa0"} build_url:https://queue.taskcluster.net/v1/task/diq9pxQVRB6jX2zUUFIpTw/artifacts/public/build/firefox-54.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011119 build_url: 'https://queue.taskcluster.net/v1/task/diq9pxQVRB6jX2zUUFIpTw/artifacts/public/build/firefox-54.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6e9591fdfdaf569f1b60a15ea7dd659f8a969bdb6dc2dc2a7a78df007c90a879847cdfc16dfa4bd00e07de00c3b622ddaa59abccd66009e2308b2a9b2bc2c715", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8071955604fe0ac08b9805caef172a62e7f9dd60bf52f55e23b9917acee3bac8c9516983990628c038a23059865b199f4afa77bbc562c2b9ec816cede338218a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/68abe3963c4c6d6a4a1be7444e32f8235045877feb203b52aea2e8e724b452ec51eae27ff255fa351c8b55eed4bcd9d484e4ac19b1f448fe42da208b14a8eba0", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2b814be302ba9c4e99962f31d76428ac74fac5da91109a1ddfbf0886c72aa24d6a1164568eea7a88c881e21ec0e9b61d843f2fef33ddb53f48064a59dda51aa0"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-10 10:11:55.954372) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-10 10:11:55.954733) ========= 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.w1oewBjS4H/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.b5TpYj8dlu/Listeners TMPDIR=/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/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.004985 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-10 10:11:56.006976) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-10 10:11:56.007324) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-10 10:11:56.007699) ========= ========= Total master_lag: 0.32 =========