builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0150 starttime: 1492528500.04 results: success (0) buildid: 20170418062021 builduid: 7d29f20b708e49dca9f10b0c28e653dd revision: 7adf8ca53590c43e755d10a4847d6e8a1171ff83 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-18 08:15:00.041292) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-18 08:15:00.041768) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-18 08:15:00.042057) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-18 08:15:00.068297) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-18 08:15:00.068583) ========= 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.Xv12q0hg1o/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.aOtK51zseo/Listeners TMPDIR=/var/folders/f4/zwr2n_y50tg1y44pl818tgt800000w/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-04-18 08:15:00-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 67.5M=0s 2017-04-18 08:15:00 (67.5 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.081774 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-18 08:15:00.174197) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-18 08:15:00.174506) ========= 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.Xv12q0hg1o/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.aOtK51zseo/Listeners TMPDIR=/var/folders/f4/zwr2n_y50tg1y44pl818tgt800000w/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.031359 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-18 08:15:00.228091) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-18 08:15:00.228443) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 7adf8ca53590c43e755d10a4847d6e8a1171ff83 --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 7adf8ca53590c43e755d10a4847d6e8a1171ff83 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Xv12q0hg1o/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.aOtK51zseo/Listeners TMPDIR=/var/folders/f4/zwr2n_y50tg1y44pl818tgt800000w/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-04-18 08:15:00,337 truncating revision to first 12 chars 2017-04-18 08:15:00,337 Setting DEBUG logging. 2017-04-18 08:15:00,337 attempt 1/10 2017-04-18 08:15:00,337 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/7adf8ca53590?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-18 08:15:01,435 unpacking tar archive at: mozilla-beta-7adf8ca53590/testing/mozharness/ program finished with exit code 0 elapsedTime=1.368668 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-18 08:15:01.620467) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-18 08:15:01.620830) ========= script_repo_revision: 7adf8ca53590c43e755d10a4847d6e8a1171ff83 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-18 08:15:01.621248) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-18 08:15:01.621522) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-18 08:15:01.641327) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2017-04-18 08:15:01.641651) ========= /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.Xv12q0hg1o/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.aOtK51zseo/Listeners TMPDIR=/var/folders/f4/zwr2n_y50tg1y44pl818tgt800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 08:15:01 INFO - MultiFileLogger online at 20170418 08:15:01 in /builds/slave/test 08:15:01 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 08:15:01 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:15:01 INFO - {'append_to_log': False, 08:15:01 INFO - 'base_work_dir': '/builds/slave/test', 08:15:01 INFO - 'blob_upload_branch': 'Mozilla-Beta', 08:15:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:15:01 INFO - 'branch': 'Mozilla-Beta', 08:15:01 INFO - 'buildbot_json_path': 'buildprops.json', 08:15:01 INFO - 'config_files': ('talos/mac_config.py',), 08:15:01 INFO - 'default_actions': ('clobber', 08:15:01 INFO - 'read-buildbot-config', 08:15:01 INFO - 'download-and-extract', 08:15:01 INFO - 'populate-webroot', 08:15:01 INFO - 'create-virtualenv', 08:15:01 INFO - 'install', 08:15:01 INFO - 'run-tests'), 08:15:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:15:01 INFO - 'download_minidump_stackwalk': True, 08:15:01 INFO - 'download_symbols': 'ondemand', 08:15:01 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:15:01 INFO - 'tooltool.py': '/tools/tooltool.py', 08:15:01 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:15:01 INFO - '/tools/misc-python/virtualenv.py')}, 08:15:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:15:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:15:01 INFO - 'gecko_profile': False, 08:15:01 INFO - 'gecko_profile_interval': 0, 08:15:01 INFO - 'installer_path': 'installer.exe', 08:15:01 INFO - 'log_level': 'info', 08:15:01 INFO - 'log_name': 'talos', 08:15:01 INFO - 'log_to_console': True, 08:15:01 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:15:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:15:01 INFO - 'opt_config_files': (), 08:15:01 INFO - 'pip_index': False, 08:15:01 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:15:01 INFO - 'cmd': ('bash', 08:15:01 INFO - '-c', 08:15:01 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:15:01 INFO - 'enabled': True, 08:15:01 INFO - 'halt_on_failure': False, 08:15:01 INFO - 'name': 'check_screen_resolution'},), 08:15:01 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:15:01 INFO - 'cmd': ('bash', 08:15:01 INFO - '-c', 08:15:01 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:15:01 INFO - 'enabled': True, 08:15:01 INFO - 'halt_on_failure': False, 08:15:01 INFO - 'name': 'check_screen_resolution'},), 08:15:01 INFO - 'run_cmd_checks_enabled': True, 08:15:01 INFO - 'suite': 'dromaeojs', 08:15:01 INFO - 'system_bits': '32', 08:15:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:15:01 INFO - 'title': 't-yosemite-r7-0150', 08:15:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:15:01 INFO - 'use_talos_json': True, 08:15:01 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:15:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:15:01 INFO - 'work_dir': 'build'} 08:15:01 INFO - [mozharness: 2017-04-18 15:15:01.856903Z] Running clobber step. 08:15:01 INFO - Running pre-action listener: _resource_record_pre_action 08:15:01 INFO - Running main action method: clobber 08:15:01 INFO - rmtree: /builds/slave/test/build 08:15:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:15:04 INFO - Running post-action listener: _resource_record_post_action 08:15:04 INFO - [mozharness: 2017-04-18 15:15:04.459757Z] Finished clobber step (success) 08:15:04 INFO - [mozharness: 2017-04-18 15:15:04.459887Z] Running read-buildbot-config step. 08:15:04 INFO - Running pre-action listener: _resource_record_pre_action 08:15:04 INFO - Running main action method: read_buildbot_config 08:15:04 INFO - Using buildbot properties: 08:15:04 INFO - { 08:15:04 INFO - "project": "", 08:15:04 INFO - "product": "firefox", 08:15:04 INFO - "script_repo_revision": "production", 08:15:04 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 08:15:04 INFO - "repository": "", 08:15:04 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 08:15:04 INFO - "buildid": "20170418062021", 08:15:04 INFO - "pgo_build": "False", 08:15:04 INFO - "basedir": "/builds/slave/test", 08:15:04 INFO - "buildnumber": 78, 08:15:04 INFO - "slavename": "t-yosemite-r7-0150", 08:15:04 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 08:15:04 INFO - "platform": "yosemite_r7", 08:15:04 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 08:15:04 INFO - "branch": "mozilla-beta", 08:15:04 INFO - "repo_path": "releases/mozilla-beta", 08:15:04 INFO - "revision": "7adf8ca53590c43e755d10a4847d6e8a1171ff83", 08:15:04 INFO - "stage_platform": "macosx64", 08:15:04 INFO - "builduid": "7d29f20b708e49dca9f10b0c28e653dd", 08:15:04 INFO - "slavebuilddir": "test" 08:15:04 INFO - } 08:15:04 INFO - Found installer url https://queue.taskcluster.net/v1/task/W2UXu7FJQVGWxUsH9J-RJA/artifacts/public/build/firefox-54.0.en-US.mac.dmg. 08:15:04 INFO - Running post-action listener: _resource_record_post_action 08:15:04 INFO - [mozharness: 2017-04-18 15:15:04.463112Z] Finished read-buildbot-config step (success) 08:15:04 INFO - [mozharness: 2017-04-18 15:15:04.463246Z] Running download-and-extract step. 08:15:04 INFO - Running pre-action listener: _resource_record_pre_action 08:15:04 INFO - Running main action method: download_and_extract 08:15:04 INFO - mkdir: /builds/slave/test/build/tests 08:15:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:15:04 INFO - trying https://queue.taskcluster.net/v1/task/W2UXu7FJQVGWxUsH9J-RJA/artifacts/public/build/firefox-54.0.en-US.mac.test_packages.json 08:15:04 INFO - Downloading https://queue.taskcluster.net/v1/task/W2UXu7FJQVGWxUsH9J-RJA/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 08:15:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/W2UXu7FJQVGWxUsH9J-RJA/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 08:15:05 INFO - Downloaded 1165 bytes. 08:15:05 INFO - Reading from file /builds/slave/test/build/firefox-54.0.en-US.mac.test_packages.json 08:15:05 INFO - Using the following test package requirements: 08:15:05 INFO - {u'common': [u'firefox-54.0.en-US.mac.common.tests.zip'], 08:15:05 INFO - u'cppunittest': [u'firefox-54.0.en-US.mac.common.tests.zip', 08:15:05 INFO - u'firefox-54.0.en-US.mac.cppunittest.tests.zip'], 08:15:05 INFO - u'gtest': [u'firefox-54.0.en-US.mac.common.tests.zip', 08:15:05 INFO - u'firefox-54.0.en-US.mac.gtest.tests.zip'], 08:15:05 INFO - u'jittest': [u'firefox-54.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 08:15:05 INFO - u'mochitest': [u'firefox-54.0.en-US.mac.common.tests.zip', 08:15:05 INFO - u'firefox-54.0.en-US.mac.mochitest.tests.zip'], 08:15:05 INFO - u'mozbase': [u'firefox-54.0.en-US.mac.common.tests.zip'], 08:15:05 INFO - u'reftest': [u'firefox-54.0.en-US.mac.common.tests.zip', 08:15:05 INFO - u'firefox-54.0.en-US.mac.reftest.tests.zip'], 08:15:05 INFO - u'talos': [u'firefox-54.0.en-US.mac.common.tests.zip', 08:15:05 INFO - u'firefox-54.0.en-US.mac.talos.tests.zip'], 08:15:05 INFO - u'web-platform': [u'firefox-54.0.en-US.mac.common.tests.zip', 08:15:05 INFO - u'firefox-54.0.en-US.mac.web-platform.tests.zip'], 08:15:05 INFO - u'xpcshell': [u'firefox-54.0.en-US.mac.common.tests.zip', 08:15:05 INFO - u'firefox-54.0.en-US.mac.xpcshell.tests.zip']} 08:15:05 INFO - Downloading packages: [u'firefox-54.0.en-US.mac.common.tests.zip'] for test suite category: common 08:15:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/W2UXu7FJQVGWxUsH9J-RJA/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip 08:15:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/W2UXu7FJQVGWxUsH9J-RJA/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip'}, attempt #1 08:15:05 INFO - Fetch https://queue.taskcluster.net/v1/task/W2UXu7FJQVGWxUsH9J-RJA/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip into memory 08:15:07 INFO - Expected file size: 51222829 08:15:07 INFO - Obtained file size: 51222829 08:15:23 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 08:15:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/W2UXu7FJQVGWxUsH9J-RJA/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip 08:15:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/W2UXu7FJQVGWxUsH9J-RJA/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip'}, attempt #1 08:15:23 INFO - Fetch https://queue.taskcluster.net/v1/task/W2UXu7FJQVGWxUsH9J-RJA/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip into memory 08:15:25 INFO - Expected file size: 51222829 08:15:25 INFO - Obtained file size: 51222829 08:15:40 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/W2UXu7FJQVGWxUsH9J-RJA/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip 08:15:40 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/W2UXu7FJQVGWxUsH9J-RJA/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip'}, attempt #1 08:15:40 INFO - Fetch https://queue.taskcluster.net/v1/task/W2UXu7FJQVGWxUsH9J-RJA/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip into memory 08:15:42 INFO - Expected file size: 14404424 08:15:42 INFO - Obtained file size: 14404424 08:15:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:15:42 INFO - trying https://queue.taskcluster.net/v1/task/W2UXu7FJQVGWxUsH9J-RJA/artifacts/public/build/firefox-54.0.en-US.mac.dmg 08:15:42 INFO - Downloading https://queue.taskcluster.net/v1/task/W2UXu7FJQVGWxUsH9J-RJA/artifacts/public/build/firefox-54.0.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0.en-US.mac.dmg 08:15:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/W2UXu7FJQVGWxUsH9J-RJA/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 08:15:44 INFO - Downloaded 59194010 bytes. 08:15:44 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/W2UXu7FJQVGWxUsH9J-RJA/artifacts/public/build/firefox-54.0.en-US.mac.dmg 08:15:44 INFO - mkdir: /builds/slave/test/properties 08:15:44 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:15:44 INFO - Writing to file /builds/slave/test/properties/build_url 08:15:44 INFO - Contents: 08:15:44 INFO - build_url:https://queue.taskcluster.net/v1/task/W2UXu7FJQVGWxUsH9J-RJA/artifacts/public/build/firefox-54.0.en-US.mac.dmg 08:15:44 INFO - Running post-action listener: _resource_record_post_action 08:15:44 INFO - Running post-action listener: set_extra_try_arguments 08:15:44 INFO - [mozharness: 2017-04-18 15:15:44.949419Z] Finished download-and-extract step (success) 08:15:44 INFO - [mozharness: 2017-04-18 15:15:44.949543Z] Running populate-webroot step. 08:15:44 INFO - Running pre-action listener: _resource_record_pre_action 08:15:44 INFO - Running main action method: populate_webroot 08:15:44 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:15:44 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:15:44 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:15:44 INFO - '--tppagecycles', 08:15:44 INFO - '7'], 08:15:44 INFO - 'tests': ['tsvgm']}}, 08:15:44 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:15:44 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:15:44 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:15:44 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:15:44 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:15:44 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:15:44 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 08:15:44 INFO - 'talos_options': ['--disable-e10s'], 08:15:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:15:44 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 08:15:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:15:44 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 08:15:44 INFO - 'talos_options': ['--disable-e10s'], 08:15:44 INFO - 'tests': ['damp', 'tps']}, 08:15:44 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 08:15:44 INFO - 'tests': ['damp', 'tps']}, 08:15:44 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:15:44 INFO - 'tests': ['dromaeo_dom']}, 08:15:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:15:44 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:15:44 INFO - 'tests': ['basic_compositor_video']}, 08:15:44 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:15:44 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:15:44 INFO - 'tests': ['a11yr', 08:15:44 INFO - 'ts_paint', 08:15:44 INFO - 'tpaint', 08:15:44 INFO - 'sessionrestore', 08:15:44 INFO - 'sessionrestore_no_auto_restore', 08:15:44 INFO - 'tabpaint']}, 08:15:44 INFO - 'other-e10s': {'tests': ['a11yr', 08:15:44 INFO - 'ts_paint', 08:15:44 INFO - 'tpaint', 08:15:44 INFO - 'sessionrestore', 08:15:44 INFO - 'sessionrestore_no_auto_restore', 08:15:44 INFO - 'tabpaint']}, 08:15:44 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:15:44 INFO - 'ts_paint', 08:15:44 INFO - 'tpaint', 08:15:44 INFO - 'sessionrestore', 08:15:44 INFO - 'sessionrestore_no_auto_restore', 08:15:44 INFO - 'tabpaint']}, 08:15:44 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:15:44 INFO - 'ts_paint', 08:15:44 INFO - 'tpaint', 08:15:44 INFO - 'sessionrestore', 08:15:44 INFO - 'sessionrestore_no_auto_restore', 08:15:44 INFO - 'tabpaint']}, 08:15:44 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:15:44 INFO - 'tests': ['a11yr', 08:15:44 INFO - 'ts_paint', 08:15:44 INFO - 'tpaint', 08:15:44 INFO - 'sessionrestore', 08:15:44 INFO - 'sessionrestore_no_auto_restore', 08:15:44 INFO - 'tabpaint']}, 08:15:44 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:15:44 INFO - 'tests': ['a11yr', 08:15:44 INFO - 'ts_paint', 08:15:44 INFO - 'tpaint', 08:15:44 INFO - 'sessionrestore', 08:15:44 INFO - 'sessionrestore_no_auto_restore', 08:15:44 INFO - 'tabpaint']}, 08:15:44 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:15:44 INFO - 'tests': ['tsvgx', 08:15:44 INFO - 'tsvgr_opacity', 08:15:44 INFO - 'tart', 08:15:44 INFO - 'tscrollx', 08:15:44 INFO - 'cart', 08:15:44 INFO - 'tsvg_static']}, 08:15:44 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:15:44 INFO - 'tsvgr_opacity', 08:15:44 INFO - 'tart', 08:15:44 INFO - 'tscrollx', 08:15:44 INFO - 'cart', 08:15:44 INFO - 'tsvg_static']}, 08:15:44 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 08:15:44 INFO - 'talos_options': ['--disable-e10s'], 08:15:44 INFO - 'tests': ['tp5o']}, 08:15:44 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 08:15:44 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 08:15:44 INFO - 'talos_options': ['--disable-e10s', 08:15:44 INFO - '--xperf_path', 08:15:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:15:44 INFO - 'tests': ['tp5n']}, 08:15:44 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 08:15:44 INFO - 'talos_options': ['--xperf_path', 08:15:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:15:44 INFO - 'tests': ['tp5n']}}, 08:15:44 INFO - 'talos.zip': {'path': '', 08:15:44 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:15:44 INFO - Running post-action listener: _resource_record_post_action 08:15:44 INFO - [mozharness: 2017-04-18 15:15:44.968302Z] Finished populate-webroot step (success) 08:15:44 INFO - [mozharness: 2017-04-18 15:15:44.968435Z] Running create-virtualenv step. 08:15:44 INFO - Running pre-action listener: _resource_record_pre_action 08:15:44 INFO - Running main action method: create_virtualenv 08:15:44 INFO - Creating virtualenv /builds/slave/test/build/venv 08:15:44 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 08:15:44 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:15:45 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:15:45 INFO - Using real prefix '/tools/python27' 08:15:45 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:15:45 INFO - Installing distribute.............................................................................................................................................................................................done. 08:15:48 INFO - Installing pip.................done. 08:15:48 INFO - Return code: 0 08:15:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:15:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:15:48 INFO - Reading from file tmpfile_stdout 08:15:48 INFO - Output received: 08:15:48 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 08:15:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:15: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')]} 08:15:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:15:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:15:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:15:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:15:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:15:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b53cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b53f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbdaa568e50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b31ad30>, '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 0x10b241db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b30fbe8>, '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.Xv12q0hg1o/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.aOtK51zseo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f4/zwr2n_y50tg1y44pl818tgt800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:15:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:15:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:15:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Xv12q0hg1o/Render', 08:15:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:15:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:15:50 INFO - 'HOME': '/Users/cltbld', 08:15:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:15:50 INFO - 'LOGNAME': 'cltbld', 08:15:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:15:50 INFO - 'MOZ_NO_REMOTE': '1', 08:15:50 INFO - 'NO_EM_RESTART': '1', 08:15:50 INFO - 'PAGER': '/bin/cat', 08:15:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:15:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:15:50 INFO - 'PWD': '/builds/slave/test', 08:15:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:15:50 INFO - 'SHELL': '/bin/bash', 08:15:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aOtK51zseo/Listeners', 08:15:50 INFO - 'TMPDIR': '/var/folders/f4/zwr2n_y50tg1y44pl818tgt800000w/T/', 08:15:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:15:50 INFO - 'USER': 'cltbld', 08:15:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:15:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:15:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:15:50 INFO - 'XPC_FLAGS': '0x0', 08:15:50 INFO - 'XPC_SERVICE_NAME': '0', 08:15:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:15:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:15:50 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 08:15:50 INFO - Cleaning up... 08:15:50 INFO - Return code: 0 08:15:50 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:15:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:15:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:15:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:15:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:15:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:15:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:15:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10b53cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b53f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbdaa568e50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b31ad30>, '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 0x10b241db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b30fbe8>, '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.Xv12q0hg1o/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.aOtK51zseo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f4/zwr2n_y50tg1y44pl818tgt800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:15:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:15:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:15:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Xv12q0hg1o/Render', 08:15:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:15:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:15:50 INFO - 'HOME': '/Users/cltbld', 08:15:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:15:50 INFO - 'LOGNAME': 'cltbld', 08:15:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:15:50 INFO - 'MOZ_NO_REMOTE': '1', 08:15:50 INFO - 'NO_EM_RESTART': '1', 08:15:50 INFO - 'PAGER': '/bin/cat', 08:15:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:15:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:15:50 INFO - 'PWD': '/builds/slave/test', 08:15:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:15:50 INFO - 'SHELL': '/bin/bash', 08:15:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aOtK51zseo/Listeners', 08:15:50 INFO - 'TMPDIR': '/var/folders/f4/zwr2n_y50tg1y44pl818tgt800000w/T/', 08:15:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:15:50 INFO - 'USER': 'cltbld', 08:15:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:15:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:15:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:15:50 INFO - 'XPC_FLAGS': '0x0', 08:15:50 INFO - 'XPC_SERVICE_NAME': '0', 08:15:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:15:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:15:50 INFO - Downloading/unpacking psutil>=3.1.1 08:15:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:15:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:15:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:15:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:15:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:15:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:15:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:15:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:15:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:15:54 INFO - Installing collected packages: psutil 08:15:54 INFO - Running setup.py install for psutil 08:15:55 INFO - building 'psutil._psutil_osx' extension 08:15:55 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 08:15:55 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 08:15:55 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 08:15:55 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 08:15:55 INFO - building 'psutil._psutil_posix' extension 08:15:55 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 08:15:55 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 08:15:55 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 08:15:55 INFO - ^ 08:15:55 INFO - 1 warning generated. 08:15:55 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 08:15:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:15:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:15:56 INFO - Successfully installed psutil 08:15:56 INFO - Cleaning up... 08:15:56 INFO - Return code: 0 08:15:56 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:15:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:15:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:15:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:15:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:15:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:15:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:15:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b53cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b53f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbdaa568e50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b31ad30>, '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 0x10b241db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b30fbe8>, '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.Xv12q0hg1o/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.aOtK51zseo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f4/zwr2n_y50tg1y44pl818tgt800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:15:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:15:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 08:15:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Xv12q0hg1o/Render', 08:15:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:15:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:15:56 INFO - 'HOME': '/Users/cltbld', 08:15:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:15:56 INFO - 'LOGNAME': 'cltbld', 08:15:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:15:56 INFO - 'MOZ_NO_REMOTE': '1', 08:15:56 INFO - 'NO_EM_RESTART': '1', 08:15:56 INFO - 'PAGER': '/bin/cat', 08:15:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:15:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:15:56 INFO - 'PWD': '/builds/slave/test', 08:15:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:15:56 INFO - 'SHELL': '/bin/bash', 08:15:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aOtK51zseo/Listeners', 08:15:56 INFO - 'TMPDIR': '/var/folders/f4/zwr2n_y50tg1y44pl818tgt800000w/T/', 08:15:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:15:56 INFO - 'USER': 'cltbld', 08:15:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:15:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:15:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:15:56 INFO - 'XPC_FLAGS': '0x0', 08:15:56 INFO - 'XPC_SERVICE_NAME': '0', 08:15:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:15:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:15:56 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:15:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:15:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:15:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:15:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:15:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:15:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:15:59 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:15:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:15:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:15:59 INFO - Installing collected packages: mozsystemmonitor 08:15:59 INFO - Running setup.py install for mozsystemmonitor 08:15:59 INFO - Successfully installed mozsystemmonitor 08:15:59 INFO - Cleaning up... 08:15:59 INFO - Return code: 0 08:15:59 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:15:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:15:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:15:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:15:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:15:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:15:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:15:59 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 0x10b53cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b53f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbdaa568e50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b31ad30>, '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 0x10b241db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b30fbe8>, '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.Xv12q0hg1o/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.aOtK51zseo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f4/zwr2n_y50tg1y44pl818tgt800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:15:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:15:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 08:15:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Xv12q0hg1o/Render', 08:15:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:15:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:15:59 INFO - 'HOME': '/Users/cltbld', 08:15:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:15:59 INFO - 'LOGNAME': 'cltbld', 08:15:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:15:59 INFO - 'MOZ_NO_REMOTE': '1', 08:15:59 INFO - 'NO_EM_RESTART': '1', 08:15:59 INFO - 'PAGER': '/bin/cat', 08:15:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:15:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:15:59 INFO - 'PWD': '/builds/slave/test', 08:15:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:15:59 INFO - 'SHELL': '/bin/bash', 08:15:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aOtK51zseo/Listeners', 08:15:59 INFO - 'TMPDIR': '/var/folders/f4/zwr2n_y50tg1y44pl818tgt800000w/T/', 08:15:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:15:59 INFO - 'USER': 'cltbld', 08:15:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:15:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:15:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:15:59 INFO - 'XPC_FLAGS': '0x0', 08:15:59 INFO - 'XPC_SERVICE_NAME': '0', 08:15:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:15:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:15:59 INFO - Downloading/unpacking jsonschema==2.5.1 08:15:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:15:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:15:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:15:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:15:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:15:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:16:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:16:02 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:16:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:16:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:16:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:16:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:16:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:16:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:16:02 INFO - Downloading functools32-3.2.3-2.tar.gz 08:16:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:16:02 INFO - warning: no files found matching '*.txt' 08:16:02 INFO - no previously-included directories found matching 'build' 08:16:02 INFO - no previously-included directories found matching 'dist' 08:16:02 INFO - no previously-included directories found matching '.git*' 08:16:02 INFO - Installing collected packages: jsonschema, functools32 08:16:02 INFO - Running setup.py install for functools32 08:16:03 INFO - warning: no files found matching '*.txt' 08:16:03 INFO - no previously-included directories found matching 'build' 08:16:03 INFO - no previously-included directories found matching 'dist' 08:16:03 INFO - no previously-included directories found matching '.git*' 08:16:03 INFO - Successfully installed jsonschema functools32 08:16:03 INFO - Cleaning up... 08:16:03 INFO - Return code: 0 08:16:03 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:16:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:16:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:16:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:16:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:16:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:16:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:16:03 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 0x10b53cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b53f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbdaa568e50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b31ad30>, '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 0x10b241db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b30fbe8>, '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.Xv12q0hg1o/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.aOtK51zseo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f4/zwr2n_y50tg1y44pl818tgt800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:16:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 08:16:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 08:16:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Xv12q0hg1o/Render', 08:16:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:16:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:16:03 INFO - 'HOME': '/Users/cltbld', 08:16:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:16:03 INFO - 'LOGNAME': 'cltbld', 08:16:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:16:03 INFO - 'MOZ_NO_REMOTE': '1', 08:16:03 INFO - 'NO_EM_RESTART': '1', 08:16:03 INFO - 'PAGER': '/bin/cat', 08:16:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:16:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:16:03 INFO - 'PWD': '/builds/slave/test', 08:16:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:16:03 INFO - 'SHELL': '/bin/bash', 08:16:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aOtK51zseo/Listeners', 08:16:03 INFO - 'TMPDIR': '/var/folders/f4/zwr2n_y50tg1y44pl818tgt800000w/T/', 08:16:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:16:03 INFO - 'USER': 'cltbld', 08:16:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:16:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:16:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:16:03 INFO - 'XPC_FLAGS': '0x0', 08:16:03 INFO - 'XPC_SERVICE_NAME': '0', 08:16:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:16:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:16:03 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:16:03 INFO - Cleaning up... 08:16:03 INFO - Return code: 0 08:16:03 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:16:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:16:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:16:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:16:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:16:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:16:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:16:03 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 0x10b53cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b53f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbdaa568e50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b31ad30>, '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 0x10b241db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b30fbe8>, '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.Xv12q0hg1o/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.aOtK51zseo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f4/zwr2n_y50tg1y44pl818tgt800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:16:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:16:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:16:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Xv12q0hg1o/Render', 08:16:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:16:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:16:03 INFO - 'HOME': '/Users/cltbld', 08:16:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:16:03 INFO - 'LOGNAME': 'cltbld', 08:16:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:16:03 INFO - 'MOZ_NO_REMOTE': '1', 08:16:03 INFO - 'NO_EM_RESTART': '1', 08:16:03 INFO - 'PAGER': '/bin/cat', 08:16:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:16:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:16:03 INFO - 'PWD': '/builds/slave/test', 08:16:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:16:03 INFO - 'SHELL': '/bin/bash', 08:16:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aOtK51zseo/Listeners', 08:16:03 INFO - 'TMPDIR': '/var/folders/f4/zwr2n_y50tg1y44pl818tgt800000w/T/', 08:16:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:16:03 INFO - 'USER': 'cltbld', 08:16:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:16:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:16:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:16:03 INFO - 'XPC_FLAGS': '0x0', 08:16:03 INFO - 'XPC_SERVICE_NAME': '0', 08:16:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:16:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:16:03 INFO - Downloading/unpacking blobuploader==1.2.4 08:16:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:16:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:16:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:16:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:16:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:16:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:16:06 INFO - Downloading blobuploader-1.2.4.tar.gz 08:16:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:16:06 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:16:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:16:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:16:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:16:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:16:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:16:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:16:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:16:07 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:16:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:16:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:16:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:16:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:16:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:16:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:16:07 INFO - Downloading docopt-0.6.1.tar.gz 08:16:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:16:07 INFO - Installing collected packages: blobuploader, requests, docopt 08:16:07 INFO - Running setup.py install for blobuploader 08:16:07 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:16:07 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:16:07 INFO - Running setup.py install for requests 08:16:08 INFO - Running setup.py install for docopt 08:16:08 INFO - Successfully installed blobuploader requests docopt 08:16:08 INFO - Cleaning up... 08:16:08 INFO - Return code: 0 08:16:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:16:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:16:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:16:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:16:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:16:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:16:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:16:08 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 0x10b53cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b53f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbdaa568e50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b31ad30>, '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 0x10b241db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b30fbe8>, '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.Xv12q0hg1o/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.aOtK51zseo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f4/zwr2n_y50tg1y44pl818tgt800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:16:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:16:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:16:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Xv12q0hg1o/Render', 08:16:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:16:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:16:08 INFO - 'HOME': '/Users/cltbld', 08:16:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:16:08 INFO - 'LOGNAME': 'cltbld', 08:16:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:16:08 INFO - 'MOZ_NO_REMOTE': '1', 08:16:08 INFO - 'NO_EM_RESTART': '1', 08:16:08 INFO - 'PAGER': '/bin/cat', 08:16:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:16:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:16:08 INFO - 'PWD': '/builds/slave/test', 08:16:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:16:08 INFO - 'SHELL': '/bin/bash', 08:16:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aOtK51zseo/Listeners', 08:16:08 INFO - 'TMPDIR': '/var/folders/f4/zwr2n_y50tg1y44pl818tgt800000w/T/', 08:16:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:16:08 INFO - 'USER': 'cltbld', 08:16:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:16:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:16:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:16:08 INFO - 'XPC_FLAGS': '0x0', 08:16:08 INFO - 'XPC_SERVICE_NAME': '0', 08:16:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:16:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:16:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:16:08 INFO - Running setup.py (path:/var/folders/f4/zwr2n_y50tg1y44pl818tgt800000w/T/pip-oCr74F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:16:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:16:08 INFO - Running setup.py (path:/var/folders/f4/zwr2n_y50tg1y44pl818tgt800000w/T/pip-ns7sZI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:16:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:16:09 INFO - Running setup.py (path:/var/folders/f4/zwr2n_y50tg1y44pl818tgt800000w/T/pip-Uvc2ju-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:16:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:16:09 INFO - Running setup.py (path:/var/folders/f4/zwr2n_y50tg1y44pl818tgt800000w/T/pip-oEqlVi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:16:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:16:09 INFO - Running setup.py (path:/var/folders/f4/zwr2n_y50tg1y44pl818tgt800000w/T/pip-EJoAow-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:16:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:16:09 INFO - Running setup.py (path:/var/folders/f4/zwr2n_y50tg1y44pl818tgt800000w/T/pip-EHnKlP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:16:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:16:09 INFO - Running setup.py (path:/var/folders/f4/zwr2n_y50tg1y44pl818tgt800000w/T/pip-006Dmo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:16:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:16:09 INFO - Running setup.py (path:/var/folders/f4/zwr2n_y50tg1y44pl818tgt800000w/T/pip-lS9OmI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:16:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:16:09 INFO - Running setup.py (path:/var/folders/f4/zwr2n_y50tg1y44pl818tgt800000w/T/pip-lUowEb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:16:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:16:09 INFO - Running setup.py (path:/var/folders/f4/zwr2n_y50tg1y44pl818tgt800000w/T/pip-1PV0nt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:16:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:16:09 INFO - Running setup.py (path:/var/folders/f4/zwr2n_y50tg1y44pl818tgt800000w/T/pip-msPlvB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:16:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:16:10 INFO - Running setup.py (path:/var/folders/f4/zwr2n_y50tg1y44pl818tgt800000w/T/pip-K1LRVg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:16:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:16:10 INFO - Running setup.py (path:/var/folders/f4/zwr2n_y50tg1y44pl818tgt800000w/T/pip-e5JjWU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:16:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:16:10 INFO - Running setup.py (path:/var/folders/f4/zwr2n_y50tg1y44pl818tgt800000w/T/pip-pi0lZe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:16:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:16:10 INFO - Running setup.py (path:/var/folders/f4/zwr2n_y50tg1y44pl818tgt800000w/T/pip-YQegsC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:16:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:16:10 INFO - Running setup.py (path:/var/folders/f4/zwr2n_y50tg1y44pl818tgt800000w/T/pip-6WFvAj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:16:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:16:10 INFO - Running setup.py (path:/var/folders/f4/zwr2n_y50tg1y44pl818tgt800000w/T/pip-qfTYk1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:16:10 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:16:10 INFO - Running setup.py install for manifestparser 08:16:10 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:16:10 INFO - Running setup.py install for mozcrash 08:16:10 INFO - Running setup.py install for mozdebug 08:16:11 INFO - Running setup.py install for mozdevice 08:16:11 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:16:11 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:16:11 INFO - Running setup.py install for mozfile 08:16:11 INFO - Running setup.py install for mozhttpd 08:16:11 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:16:11 INFO - Running setup.py install for mozinfo 08:16:11 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:16:11 INFO - Running setup.py install for mozInstall 08:16:11 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:16:11 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:16:11 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:16:11 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:16:11 INFO - Running setup.py install for mozleak 08:16:11 INFO - Running setup.py install for mozlog 08:16:12 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:16:12 INFO - Running setup.py install for moznetwork 08:16:12 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:16:12 INFO - Running setup.py install for mozprocess 08:16:12 INFO - Running setup.py install for mozprofile 08:16:12 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:16:12 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:16:12 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:16:12 INFO - Running setup.py install for mozrunner 08:16:12 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:16:12 INFO - Running setup.py install for mozscreenshot 08:16:12 INFO - Running setup.py install for moztest 08:16:13 INFO - Running setup.py install for mozversion 08:16:13 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:16:13 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:16:13 INFO - Cleaning up... 08:16:13 INFO - Return code: 0 08:16:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:16:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:16:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:16:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:16:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:16:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:16:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:16:13 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 0x10b53cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b53f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbdaa568e50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b31ad30>, '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 0x10b241db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b30fbe8>, '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.Xv12q0hg1o/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.aOtK51zseo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f4/zwr2n_y50tg1y44pl818tgt800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:16:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:16:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:16:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Xv12q0hg1o/Render', 08:16:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:16:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:16:13 INFO - 'HOME': '/Users/cltbld', 08:16:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:16:13 INFO - 'LOGNAME': 'cltbld', 08:16:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:16:13 INFO - 'MOZ_NO_REMOTE': '1', 08:16:13 INFO - 'NO_EM_RESTART': '1', 08:16:13 INFO - 'PAGER': '/bin/cat', 08:16:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:16:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:16:13 INFO - 'PWD': '/builds/slave/test', 08:16:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:16:13 INFO - 'SHELL': '/bin/bash', 08:16:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aOtK51zseo/Listeners', 08:16:13 INFO - 'TMPDIR': '/var/folders/f4/zwr2n_y50tg1y44pl818tgt800000w/T/', 08:16:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:16:13 INFO - 'USER': 'cltbld', 08:16:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:16:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:16:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:16:13 INFO - 'XPC_FLAGS': '0x0', 08:16:13 INFO - 'XPC_SERVICE_NAME': '0', 08:16:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:16:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:16:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:16:13 INFO - Running setup.py (path:/var/folders/f4/zwr2n_y50tg1y44pl818tgt800000w/T/pip-Uz0sti-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:16:13 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 08:16:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:16:13 INFO - Running setup.py (path:/var/folders/f4/zwr2n_y50tg1y44pl818tgt800000w/T/pip-k9xQ2R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:16:13 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)) 08:16:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:16:13 INFO - Running setup.py (path:/var/folders/f4/zwr2n_y50tg1y44pl818tgt800000w/T/pip-GHXkrz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:16:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:16:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:16:13 INFO - Running setup.py (path:/var/folders/f4/zwr2n_y50tg1y44pl818tgt800000w/T/pip-5CPpAc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:16:13 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)) 08:16:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:16:13 INFO - Running setup.py (path:/var/folders/f4/zwr2n_y50tg1y44pl818tgt800000w/T/pip-tPFHHY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:16:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 08:16:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:16:14 INFO - Running setup.py (path:/var/folders/f4/zwr2n_y50tg1y44pl818tgt800000w/T/pip-qwFNkY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:16:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 08:16:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:16:14 INFO - Running setup.py (path:/var/folders/f4/zwr2n_y50tg1y44pl818tgt800000w/T/pip-ZIJyeT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:16:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 08:16:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:16:14 INFO - Running setup.py (path:/var/folders/f4/zwr2n_y50tg1y44pl818tgt800000w/T/pip-27B3Vl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:16:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 08:16:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:16:14 INFO - Running setup.py (path:/var/folders/f4/zwr2n_y50tg1y44pl818tgt800000w/T/pip-Btd7eH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:16:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 08:16:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:16:14 INFO - Running setup.py (path:/var/folders/f4/zwr2n_y50tg1y44pl818tgt800000w/T/pip-2MRLH7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:16:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:16:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:16:14 INFO - Running setup.py (path:/var/folders/f4/zwr2n_y50tg1y44pl818tgt800000w/T/pip-ZZKm6h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:16:14 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 08:16:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:16:14 INFO - Running setup.py (path:/var/folders/f4/zwr2n_y50tg1y44pl818tgt800000w/T/pip-RSjuUp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:16:14 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)) 08:16:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:16:14 INFO - Running setup.py (path:/var/folders/f4/zwr2n_y50tg1y44pl818tgt800000w/T/pip-pQ8DiE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:16:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 08:16:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:16:14 INFO - Running setup.py (path:/var/folders/f4/zwr2n_y50tg1y44pl818tgt800000w/T/pip-CmKeUO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:16:14 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)) 08:16:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:16:14 INFO - Running setup.py (path:/var/folders/f4/zwr2n_y50tg1y44pl818tgt800000w/T/pip-WDtl65-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:16:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 08:16:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:16:15 INFO - Running setup.py (path:/var/folders/f4/zwr2n_y50tg1y44pl818tgt800000w/T/pip-tOhuHD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:16:15 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)) 08:16:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:16:15 INFO - Running setup.py (path:/var/folders/f4/zwr2n_y50tg1y44pl818tgt800000w/T/pip-gzs3W5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:16:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 08:16:15 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)) 08:16:15 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)) 08:16:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:16:15 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)) 08:16:15 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)) 08:16:15 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:16:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:16:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:16:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:16:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:16:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:16:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:16:17 INFO - Downloading blessings-1.6.tar.gz 08:16:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:16:18 INFO - Installing collected packages: blessings 08:16:18 INFO - Running setup.py install for blessings 08:16:18 INFO - Successfully installed blessings 08:16:18 INFO - Cleaning up... 08:16:18 INFO - Return code: 0 08:16:18 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:16:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:16:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:16:18 INFO - Reading from file tmpfile_stdout 08:16:18 INFO - Current package versions: 08:16:18 INFO - blessings == 1.6 08:16:18 INFO - blobuploader == 1.2.4 08:16:18 INFO - docopt == 0.6.1 08:16:18 INFO - functools32 == 3.2.3-2 08:16:18 INFO - jsonschema == 2.5.1 08:16:18 INFO - manifestparser == 1.1 08:16:18 INFO - mozInstall == 1.12 08:16:18 INFO - mozcrash == 1.0 08:16:18 INFO - mozdebug == 0.1 08:16:18 INFO - mozdevice == 0.49 08:16:18 INFO - mozfile == 1.2 08:16:18 INFO - mozhttpd == 0.7 08:16:18 INFO - mozinfo == 0.9 08:16:18 INFO - mozleak == 0.1 08:16:18 INFO - mozlog == 3.4 08:16:18 INFO - moznetwork == 0.27 08:16:18 INFO - mozprocess == 0.25 08:16:18 INFO - mozprofile == 0.28 08:16:18 INFO - mozrunner == 6.13 08:16:18 INFO - mozscreenshot == 0.1 08:16:18 INFO - mozsystemmonitor == 0.3 08:16:18 INFO - moztest == 0.8 08:16:18 INFO - mozversion == 1.4 08:16:18 INFO - psutil == 3.1.1 08:16:18 INFO - requests == 1.2.3 08:16:18 INFO - wsgiref == 0.1.2 08:16:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:16:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:16:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:16:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:16:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:16:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:16:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:16:18 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 0x10b53cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b53f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbdaa568e50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b31ad30>, '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 0x10b241db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b30fbe8>, '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.Xv12q0hg1o/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.aOtK51zseo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f4/zwr2n_y50tg1y44pl818tgt800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:16:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 08:16:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:16:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Xv12q0hg1o/Render', 08:16:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:16:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:16:18 INFO - 'HOME': '/Users/cltbld', 08:16:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:16:18 INFO - 'LOGNAME': 'cltbld', 08:16:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:16:18 INFO - 'MOZ_NO_REMOTE': '1', 08:16:18 INFO - 'NO_EM_RESTART': '1', 08:16:18 INFO - 'PAGER': '/bin/cat', 08:16:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:16:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:16:18 INFO - 'PWD': '/builds/slave/test', 08:16:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:16:18 INFO - 'SHELL': '/bin/bash', 08:16:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aOtK51zseo/Listeners', 08:16:18 INFO - 'TMPDIR': '/var/folders/f4/zwr2n_y50tg1y44pl818tgt800000w/T/', 08:16:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:16:18 INFO - 'USER': 'cltbld', 08:16:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:16:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:16:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:16:18 INFO - 'XPC_FLAGS': '0x0', 08:16:18 INFO - 'XPC_SERVICE_NAME': '0', 08:16:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:16:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:16:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:16:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 08:16:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 08:16:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:16:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 08:16:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 08:16:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 08:16:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 08:16:18 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 08:16:18 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:16:18 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:16:18 INFO - Cleaning up... 08:16:18 INFO - Return code: 0 08:16:18 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:16:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:16:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:16:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:16:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:16:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:16:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:16:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b53cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b53f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbdaa568e50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b31ad30>, '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 0x10b241db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b30fbe8>, '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.Xv12q0hg1o/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.aOtK51zseo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f4/zwr2n_y50tg1y44pl818tgt800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:16:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:16:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:16:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Xv12q0hg1o/Render', 08:16:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:16:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:16:18 INFO - 'HOME': '/Users/cltbld', 08:16:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:16:18 INFO - 'LOGNAME': 'cltbld', 08:16:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:16:18 INFO - 'MOZ_NO_REMOTE': '1', 08:16:18 INFO - 'NO_EM_RESTART': '1', 08:16:18 INFO - 'PAGER': '/bin/cat', 08:16:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:16:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:16:18 INFO - 'PWD': '/builds/slave/test', 08:16:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:16:18 INFO - 'SHELL': '/bin/bash', 08:16:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aOtK51zseo/Listeners', 08:16:18 INFO - 'TMPDIR': '/var/folders/f4/zwr2n_y50tg1y44pl818tgt800000w/T/', 08:16:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:16:18 INFO - 'USER': 'cltbld', 08:16:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:16:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:16:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:16:18 INFO - 'XPC_FLAGS': '0x0', 08:16:18 INFO - 'XPC_SERVICE_NAME': '0', 08:16:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:16:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:16:19 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:16:19 INFO - Cleaning up... 08:16:19 INFO - Return code: 0 08:16:19 INFO - Running post-action listener: _resource_record_post_action 08:16:19 INFO - Running post-action listener: _start_resource_monitoring 08:16:19 INFO - Starting resource monitoring. 08:16:19 INFO - [mozharness: 2017-04-18 15:16:19.118282Z] Finished create-virtualenv step (success) 08:16:19 INFO - [mozharness: 2017-04-18 15:16:19.119305Z] Running install step. 08:16:19 INFO - Running pre-action listener: _resource_record_pre_action 08:16:19 INFO - Running main action method: install 08:16:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:16:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:16:19 INFO - Reading from file tmpfile_stdout 08:16:19 INFO - Detecting whether we're running mozinstall >=1.0... 08:16:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:16:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:16:19 INFO - Reading from file tmpfile_stdout 08:16:19 INFO - Output received: 08:16:19 INFO - Usage: mozinstall [options] installer 08:16:19 INFO - Options: 08:16:19 INFO - -h, --help show this help message and exit 08:16:19 INFO - -d DEST, --destination=DEST 08:16:19 INFO - Directory to install application into. [default: 08:16:19 INFO - "/builds/slave/test"] 08:16:19 INFO - --app=APP Application being installed. [default: firefox] 08:16:19 INFO - mkdir: /builds/slave/test/build/application 08:16:19 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'] 08:16:19 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 08:16:34 INFO - Reading from file tmpfile_stdout 08:16:34 INFO - Output received: 08:16:34 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 08:16:34 INFO - Running post-action listener: _resource_record_post_action 08:16:34 INFO - [mozharness: 2017-04-18 15:16:34.290441Z] Finished install step (success) 08:16:34 INFO - [mozharness: 2017-04-18 15:16:34.290602Z] Running run-tests step. 08:16:34 INFO - Running pre-action listener: _resource_record_pre_action 08:16:34 INFO - Running main action method: run_tests 08:16:34 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:16:34 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:16:34 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:16:34 INFO - 2017-04-18 08:16:34.305 screenresolution[1627:7454] starting screenresolution argv=screenresolution get 08:16:34 INFO - 2017-04-18 08:16:34.307 screenresolution[1627:7454] Display 0: 1600x1200x32@60 08:16:34 INFO - 2017-04-18 08:16:34.313 screenresolution[1628:7456] starting screenresolution argv=screenresolution list 08:16:34 INFO - Available Modes on Display 0 08:16:34 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:16:34 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:16:34 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:16:34 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:16:34 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:16:34 INFO - Intel Iris: 08:16:34 INFO - Chipset Model: Intel Iris 08:16:34 INFO - Type: GPU 08:16:34 INFO - Bus: Built-In 08:16:34 INFO - VRAM (Dynamic, Max): 1536 MB 08:16:34 INFO - Vendor: Intel (0x8086) 08:16:34 INFO - Device ID: 0x0a2e 08:16:34 INFO - Revision ID: 0x0009 08:16:34 INFO - Displays: 08:16:34 INFO - Display: 08:16:34 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:16:34 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:16:34 INFO - Display Serial Number: 1600x1200 60 08:16:34 INFO - Main Display: Yes 08:16:34 INFO - Mirror: Off 08:16:34 INFO - Online: Yes 08:16:34 INFO - Rotation: Supported 08:16:34 INFO - Return code: 0 08:16:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:16:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:16:34 INFO - Python 2.7.3 08:16:34 INFO - Return code: 0 08:16:34 INFO - grabbing minidump binary from tooltool 08:16:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:16:34 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 0x10b31ad30>, '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 0x10b241db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b30fbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:16:34 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 08:16:34 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 08:16:34 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 08:16:34 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:16:34 INFO - Return code: 0 08:16:34 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 08:16:34 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:16:34 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:16:34 INFO - ENV: RUST_BACKTRACE is now 1 08:16:34 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 08:16:34 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:16:34 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/W2UXu7FJQVGWxUsH9J-RJA/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0150', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 08:16:34 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/W2UXu7FJQVGWxUsH9J-RJA/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0150 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 08:16:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Xv12q0hg1o/Render', 08:16:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:16:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:16:34 INFO - 'HOME': '/Users/cltbld', 08:16:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:16:34 INFO - 'LOGNAME': 'cltbld', 08:16:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:16:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 08:16:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:16:34 INFO - 'MOZ_NO_REMOTE': '1', 08:16:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:16:34 INFO - 'NO_EM_RESTART': '1', 08:16:34 INFO - 'PAGER': '/bin/cat', 08:16:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:16:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:16:34 INFO - 'PWD': '/builds/slave/test', 08:16:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:16:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:16:34 INFO - 'RUST_BACKTRACE': '1', 08:16:34 INFO - 'SHELL': '/bin/bash', 08:16:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aOtK51zseo/Listeners', 08:16:34 INFO - 'TMPDIR': '/var/folders/f4/zwr2n_y50tg1y44pl818tgt800000w/T/', 08:16:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:16:34 INFO - 'USER': 'cltbld', 08:16:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:16:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:16:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:16:34 INFO - 'XPC_FLAGS': '0x0', 08:16:34 INFO - 'XPC_SERVICE_NAME': '0', 08:16:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:16:34 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/W2UXu7FJQVGWxUsH9J-RJA/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0150', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 08:16:34 INFO - mozversion application_buildid: 20170418062021 08:16:34 INFO - mozversion application_changeset: 7adf8ca53590c43e755d10a4847d6e8a1171ff83 08:16:34 INFO - mozversion application_display_name: Firefox 08:16:34 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:16:34 INFO - mozversion application_name: Firefox 08:16:34 INFO - mozversion application_remotingname: firefox 08:16:34 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 08:16:34 INFO - mozversion application_vendor: Mozilla 08:16:34 INFO - mozversion application_version: 54.0 08:16:34 INFO - mozversion platform_buildid: 20170418062021 08:16:34 INFO - mozversion platform_changeset: 7adf8ca53590c43e755d10a4847d6e8a1171ff83 08:16:34 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 08:16:34 INFO - mozversion platform_version: 54.0 08:16:34 INFO - using testdate: 1492528594 08:16:34 INFO - actual date: 1492528594 08:16:34 INFO - starting webserver on 'localhost:49241' 08:16:34 INFO - SUITE-START | Running 2 tests 08:16:34 INFO - TEST-START | dromaeo_css 08:16:34 INFO - operating with platform_type : mac_ 08:16:34 INFO - Initialising browser for dromaeo_css test... 08:16:35 INFO - TEST-INFO | started process 1638 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/f4/zwr2n_y50tg1y44pl818tgt800000w/T/tmph3kx8C/profile http://localhost:49241/getInfo.html) 08:16:37 INFO - PROCESS | 1638 | __metrics Screen width/height:1600/1200 08:16:37 INFO - PROCESS | 1638 | colorDepth:24 08:16:37 INFO - PROCESS | 1638 | Browser inner width/height: 1024/689 08:16:37 INFO - PROCESS | 1638 | __metrics 08:16:37 INFO - PROCESS | 1638 | 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" 08:16:37 INFO - PROCESS | 1638 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:16:38 INFO - TEST-INFO | 1638: exit 0 08:16:38 INFO - Browser initialized. 08:16:38 INFO - Running cycle 1/1 for dromaeo_css test... 08:16:38 INFO - TEST-INFO | started process 1642 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/f4/zwr2n_y50tg1y44pl818tgt800000w/T/tmph3kx8C/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:16:50 INFO - PROCESS | 1642 | RSS: Main: 164941824 08:16:50 INFO - PROCESS | 1642 | 08:19:54 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49241/tests/dromaeo/cssquery-ext.html) 08:19:55 INFO - PROCESS | 1642 | RSS: Main: 299110400 08:19:55 INFO - PROCESS | 1642 | 08:22:58 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-ext.html (next: http://localhost:49241/tests/dromaeo/cssquery-jquery.html) 08:22:59 INFO - PROCESS | 1642 | RSS: Main: 304537600 08:22:59 INFO - PROCESS | 1642 | 08:26:01 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49241/tests/dromaeo/cssquery-mootools.html) 08:26:02 INFO - PROCESS | 1642 | RSS: Main: 292208640 08:26:02 INFO - PROCESS | 1642 | 08:29:04 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49241/tests/dromaeo/cssquery-prototype.html) 08:29:05 INFO - PROCESS | 1642 | RSS: Main: 269369344 08:29:05 INFO - PROCESS | 1642 | 08:32:09 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49241/tests/dromaeo/cssquery-yui.html) 08:32:09 INFO - PROCESS | 1642 | RSS: Main: 267890688 08:32:09 INFO - PROCESS | 1642 | 08:35:13 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-yui.html (next: http://localhost:49241/tests/dromaeo/cssquery-dojo.html) 08:35:13 INFO - PROCESS | 1642 | RSS: Main: 394317824 08:35:13 INFO - PROCESS | 1642 | 08:35:13 INFO - PROCESS | 1642 | __start_tp_report 08:35:13 INFO - PROCESS | 1642 | _x_x_mozilla_page_load 08:35:13 INFO - PROCESS | 1642 | _x_x_mozilla_page_load_details 08:35:13 INFO - PROCESS | 1642 | |i|pagename|runs| 08:35:13 INFO - PROCESS | 1642 | |0;dojo.html;3575.1419659281773;3579.9284014319733;3607.6031636519992;3612.3317186320523;3658.7438879278443;6229.377062293774;6239.34486878878;6253.312135665079;6258.687065646711;6267.059941008851;6236.750529978806;6251.968425209846;6279.905801412982;6283.874322513559;6288.937110628893;5576.637518561281;5593.133064375018;5593.692346920918;5642.266505354298;5701.57238207134;5470.890582188354;5474.863128421782;5510.91733623996;5703.971480142614;5706.4864162225595;5614.9719251403685;5618.073017952053;5642.492175704186;5670.121131224667;5680.147977803321;5666;5689.231953686282;5695.971520142393;5697.943020569804;5700.543956483513;5397.568194544467;5487.6158668893195;5589.7205139743255;5608.242887210256;5674.262345895048;6168.383161683841;6171.352008039181;6175.413335733098;6240.219972503437;6290.056491526308;6636.435902948207;6644.368784965421;6647.169103862017;6649.667516624149;6661.4004739573675;6643.86712265752;6667.633280169589;6725.966370168167;6733.057371967929;6748.662566871686;6148.600340977822;6211.627302361872;6252.562320637603;6306.463950564162;6310.368963103653;6821.21556021054;6866.828329291708;6872.072270243553;6872.587644741231;6874.518783685094;6466.612003279818;6498.155239818888;6525.955847064447;6538.803835884931;6542.640154791532;6389.361063893573;6448.871022579522;6519.608823470607;6685.799426017227;6699.665016749143;6409.67951602418;6428.903566446414;6481.740730370732;6548.574342667712;6556.639384833785;6594.86810263792;6625.271220165778;6627.304133066055;6629.701663425158;6640.933590664128;4595.379623750818;5166.45752196014;5325.467453254643;5327.946720532823;5335.919961200585;4691.225947718656;4709.058188362341;4755.785989630475;4787.593054590329;4795.232762757942;6227.470664993436;6262.906056409158;6270.153529273581;6302.873942521124;6312.116303717483;6710.698018589175;6738.393544580913;6742.83142921421;6749.156355455568;6753.8649227015185;6313.116163737081;6318.462930650946;6324.557280990287;6325.652089135142;6338.809835704937;5207.1668533034535;5665.433456654301;5724.885502289931;5764.250647415809;5785.247917770663;6888.138982627172;6919.446444284546;6936.41040511542;6940.514164008572;6945.374916257359;6716.126903502513;6722.159730033746;6733.7920176963735;6756.527043107132;6760.898586521304;6538.901916471162;6546.639934803631;6668.799936001928;6914.0320355151325;6926.58440493572;6420.935790642034;6533.509986750918;6551.279359270381;6606.636634985122;6639.767608133692;6401.679916004088;6472.546921715435;6496.967515162394;6589.27517973013;6602.273749887412;6469.708863101266;6475.611463312216;6481.157449531531;6485.578437401554;6489;6286.27707813589;6467.191601049869;6469.676516174267;6478.1578394808375;6482;6213.099100630474;6257.217847769029;6264.248290205204;6279.623222606659;6369.777057802955;6482.254540727688;6496.577722448026;6507.219133703986;6508.349165083454;6521.6087034776165;5304.469553044664;6341.8731625368155;6348.269948955929;6351.396617321347;6356.2054743157105 08:35:13 INFO - PROCESS | 1642 | |1;ext.html;784.7371130671224;822.5475988206487;840.3319361107918;912.5756523216703;920.9033051529593;30099.097027089167;36222.8188859056;43309.91725206871;43519;43692.563074369245;45006;45112.548874511245;45164.09671806562;45180.3222951656;45200.54799452013;8082.838343233132;9681.56432960515;9920.107190352866;9926.305158638897;9937.10566049059;8039.35685145187;12034.977026952676;12163.999999999956;12195.93902030493;12197.573084942029;12179.025677945787;12263.69340766479;12288.078394120432;12296.93851530741;12312.81530777039;12182.086343524226;12243.959263462617;12254.019678425704;12264.570740024146;12276.508939642494;11620.302781833117;11711.355875426849;11715.472803723853;11715.7071073223;11716.9454749073;42541;42680;42718;42722.35916461256;42729.35905961413;3432.2449061206494;4027.1341661542615;4033.7781422021776;4039.111395492987;4122.56713045129;29957.400851983057;29971.850140749157;30621;30668.693313066808;30843.84578077118;3143.7327827134723;3178.6821317868257;3222.3716375306826;3231.1114443528218;3258.120307516957;356587;359011;359154;359165.20417398005;359603;44849.77575112169;45017.09965800666;45028.549714502435;45090.54909450929;45163.548364516595;38383.23233535314;46802.76598617053;46829.5317046832;46867.531324686315;46889.76555117202;12204.450799714034;14492.565223043326;14600.41598336076;14634.121952682874;14647.853521464649;11137.05335046514;11329.320240785579;12630.179038362478;12641.178323408949;12647.43086561107;10961.780764384668;10975.231733778559;11023.83464248037;11030.06244469229;12285.447154878051;4954.3311652926395;5872.677002764889;5876.794312199053;5880.294364676266;5883.911741323884;1164.039667274485;1166.550877911993;1193.3376975778353;1195.7010747313172;1204.7891618966646;27714.5842812358;28285;28307.71692283092;28319.150425487267;28340.149795506168;988.7626969527262;1082.7965091039696;1265.9810102848464;1282.6665067082627;1332.6335257803987;12088.41448264212;13752.174869507862;14447.133172009502;14549.394149687705;14687.632809179857;478659;493850;495696.5215173901;496032;498844;50432.24351634655;60216.698916505135;60666.99999999912;60667.39332606617;60812.087818682754;1494.491872763244;1515.9696806064037;1532.4789571545728;1534.8004759381208;1537.085434166669;30386.54420183743;31268;31354.372912541166;31997.200069997503;32075.83962080268;48063.75968120137;48711.025779484924;50775.746121269156;50899.491005089476;50966.74516627542;506670;509432;509607;510297;510402;33846.492302614985;33864.15339616529;33868.3226335467;33884;33911;40331.59668403396;40529.797351013054;40918;41164.794176030126;41812.3728144072;28457.37691098509;28621.830866933615;28901.855490723254;29296.121116366543;29943.951961681236;23682.88158559196;29346.706532934397;29807.55288670715;29888;30009.249768755082;35496.82251588725;36121.277574447835;36249.637503624625;36324;36339.818300909385;28925.421491570472;29376.7062329374;29908.551371729878;30078.69921300759;30134.69865301319;23365;23427.297181084596;23588.646170307115;23882.133629198324;24114.87942560276 08:35:13 INFO - PROCESS | 1642 | |2;jquery.html;408.6097776623325;423.70141979759813;430.3243907065906;437.8008006357108;446.7833100946042;20384.694229586567;20921.267755628538;22113.557728845415;22442.102315907363;22495.55008899821;22090.77909220907;23055.769442305573;23290.951907164177;23647.17234896779;24013.519729605396;7025.437964962791;7313.12242530897;7342.816429589249;7345;7538.321551060403;7693.9615301923695;7778.416618753616;7812.765617031499;7813.179616140309;7835.725749598765;7541.170471248186;7633.427492938052;7725.806854828618;7730.729424470144;7732.574708391036;7538.547687138762;7761.611919404064;7769.300762931335;7815.882761758578;7854.136045035041;7038.3313585209835;7356.337929586363;7580.241975802431;7604.733834315773;7626.885596716053;26712.332191695168;27139;27261.318467038283;27467.587986180224;27501.449971000668;3074.2015920686204;3076.230942264434;3080.476319025771;3097.396007778484;3248.204189973472;17791.46625601234;17904.462866114038;17963.73054404185;18286.634267314712;19291.51771205731;2184.983982448169;2207.9558408831736;2208.2271205078255;2221.300290408516;2222.9333120006427;126682.73317266801;139392;146586;151739;153052;23113.53772924532;24432.267031989068;25047;25064.874675626506;25366.365840853756;43340.78329608395;43348.13303733971;44376.3343549847;44465.77767111208;44493.22027118879;10520.631777887736;10761.677149685522;10955.561777528968;11010.39442830652;11110.777784444266;9059.094090590888;9095.545222738836;9107.316951228684;9120.589573469077;9269.814603707888;9723;9833.4099954003;9903.108720215216;9919.65281215154;9934.453605051647;3528.6471352865024;3572.035041104372;4160.438340824011;4222;4253.914921701548;1056.7041228456044;1075.4138994247996;1081.983770243447;1083.913286937059;1137.147139645266;17182.828171718375;22182.00180991859;22550.872456377114;22738.09047638076;22783.658245126335;1084.7559299157783;1095.2442814457997;1114.492905727908;1134.7049767060623;1137.0102320938358;10935.945320273508;11781;11781.76436471283;11795.41022948849;11815.940920295343;791063;794608;806164;807177;819853;135836.84490041118;146746.06507869784;153880;167529;169006;1203.6990752311922;1214.7691938531475;1219.896308813743;1235.8949489293332;1240.3054289597674;19012;19742.802571974098;19948.102335395233;19975;19983.900080500087;61710.69144654248;62481;62936.37063629305;63232.683836582364;63501;64376.67811660912;86672.56663716641;86690.56654716686;89125.66311505462;89789.55105224693;10375.325603835727;11538.423078845855;11640.322725773289;11662.53349865996;11862;12860.935695321463;12967;13227.801582976455;13347.199168049949;13380.598582042554;9551.713448596276;9931.404115753077;11098.61154859576;11155.05182059534;11482.311061336013;8339.624716887876;10490.475476226005;10698.518566664363;10836.024757771838;10840.403777791982;11384.829227561759;11725.179237453296;11760.176787624785;11813.586524471602;11914.16600837933;11488.310701357945;11497.482613282255;11778.352190629597;11794;11910.464029118884;11333.603323883624;11473.885261147281;11614.6515604532;11665.88334116648;11721.179517434039 08:35:13 INFO - PROCESS | 1642 | |3;mootools.html;1422.964425889352;1553.8213105492869;1640.3028712797066;1662.2021429713734;1664.4756901576002;9632.373895696775;10030.498475076245;10031.398116113029;10220.948895255513;10265.435401052939;10017.849732254022;11034.117270618352;11354.602588909369;11554;11591;2375;2424.5635785558593;2425.163318655061;2429.283361408389;2435.866027368494;2265.8753768542724;2383;2440.6095024796036;2486.3038349262147;2493.463905260369;2079.542500649862;2152.827773778102;2157.11558261113;2158.1583182558816;2159.3306075116684;2137.6152292587326;2159.017646970625;2382.654515095319;2464.864432456214;2471.715752688428;2438.317271164077;2459.2990997565607;2461.5446142463525;2464.938376540601;2468.9259322220364;11349.20555561111;11585;11596.478158482803;11605.477753501029;11610.825837612443;5916.822495325104;6124.755009799603;6130.2030736004035;6135.9693201534155;6137.9079313810325;3610.584782749991;3690.833912473945;3750.8124593770203;3751.6623503884507;3814.275287695329;1283.3519072868235;1902.7431296774896;1928.9131989060527;1950.3368854589507;2000.249906285143;15976;16096.59758506035;16112.75830862538;16115.758263626056;16118.194090295437;4719.339292499053;4852.126617208936;4852.587530059914;4925.088858561177;4944.1100601892;12345.506179752889;12352.25886446816;12358.320292384005;12369.257844529357;12373.876261237272;5097.8215762448135;6069.757209711562;6076.483498902643;6079.726412311456;6080.48315893154;5274.92087618686;5422.593305502103;5512.448755124456;5540.9168862467095;5571.359293681197;3417.5386322846593;3877.379619260961;4014.9397759033636;4033.7781422021485;4084.4281800547947;1044.2116202267391;1048.5386429970788;1063.160103518212;1063.8457423673524;1066.4507778494083;956.9521523923776;982.3025651787311;995.4525011243787;997.4962643864802;1010.1312870930993;6788.864222715518;6796.014577886179;6913.688884000232;6993.755218567326;7074.327938845801;981.6024510073431;987.3236832769433;990.2375171118199;1026.0765311219961;1048.234788604323;3923.6272554107313;4003.399490076512;4033.6773058155277;4440.378347031418;4522.547745225517;13493.66265843342;14335.426582936774;14335.713285734228;14344;14355.282235888373;13457.192568445924;14043.78934315986;14253.50112746049;14300.927430442758;14324.57026289213;10313.587456501657;10587.89412105869;10601.84097238542;10623.946880265703;10652.786944261226;5525.613207075467;6864.176298844171;6886.655667216719;6943.548669336477;7282.198958114497;12379.319137447526;12594.11904573176;12712.491500339884;12831.807522887351;12940.741185176055;12864.807027894776;12883.969282457569;12944.41750121228;12976.286304253357;12996;9394.342396032212;9425.670101546413;9591.376560523544;9602.759931001781;9635.518224088908;10421.166306695295;10550;10626.628068017582;10645.467726613793;10658.200634952254;8936.972248191541;9167.49578773174;9184.58669359867;9204.493752843659;9247.907520924973;8469.364797640079;8521.147885211429;8648.870266946127;8673.609687564202;8992.775180620536;8102.716404925799;8129.7154599591095;8158.265756081981;8206.876896846432;8231.794205144919;6024.668643224665;6103.389661033861;6137.263528376623;6167.568270221221;6316.084167795736;5983.880322393441;6111.84720381994;6133.785317513865;6294.590851594632;6318.589291696025 08:35:13 INFO - PROCESS | 1642 | |4;prototype.html;356.81715114395774;375.6262518793799;393.0703885311239;396.6846357146069;403.435190732974;4992.600591952644;5115.360579927509;5177.715225662587;5267.736613169336;5268.578513718903;4030.919381612366;4902.80388784449;5138.743062846861;5154.896902061956;5205.27126202332;3689.8192578374933;4010.8569057818527;4151.937720934181;4263.5523270056665;4276.914461710764;3814.1608846053823;4002.4396584478195;4363.956360436387;4368.301071828492;4403.845865394712;3901.3367727486398;3948.605139486043;4360.28055370865;4360.912781744363;4398.868033958986;3459.8582467785573;3681.2821499807546;3985.0435895385044;4093.2018256440006;4151.647109995654;3571.3750093733493;3586.6370779103772;3991.6806655467494;4022.336314508132;4034.0838101901363;5012.396033269355;5027.974860125712;5030.515997780663;5066.518680725325;5088.643794934356;4242.957570424287;4587.311903214511;4679.976600116977;4778.880527986794;5108;4841.2012018016985;4910.607151427877;5381.569474442035;5566.666000040011;5576.163575463673;3885.844566217348;4355.891102722426;4559.475660299042;4626.745528995903;4627.8148874045;5734.655920644775;5821.476067153976;5838.175994723463;5911.733971971272;5922.822315330547;3973.443717879499;4058.246122336827;4434.733915964988;4603.838865639686;4621.861344159681;4264.189803937242;4364.258076127066;4398.912021759611;4716.457607375196;4755.072760811678;4614.561616646481;4894.535019173173;4950.331705219749;5005.89988200234;5043.092243396224;4526.434195725535;5049.6212784041345;5422.8373148805595;5607.831765047055;5627.296587926509;1440.6902515959118;1459.1245252848419;1548.984510154884;1592.9406944381856;1619.8542131208249;1040.6097713357492;1107.7452185997104;1121.8036843552345;1188.3582865252667;1221.2855479544567;4880.682755620874;4913.926291105637;5220.034293655686;5231.555317797954;5250.6085887239915;5264;5314.403041369188;5392.433794451605;5667.234923285304;5677.17680936262;4069.104796944727;4748.525147485293;5100.413452453015;5101.413337466239;5167.509086636764;2373.326804602751;2575.072973729456;2647.510210611043;2791.6370871786944;2951.922548269866;5036.143855544567;5351.518363347317;5511.503964643121;5966.761329546856;6038.456538911519;4960.379952505937;5096.578311327754;5477.972610136924;5672.602917795797;5676.760451438576;4865.9026819463415;5421.864453388618;5825.446582574648;5826.300843898759;5830.7959221427045;5013.8886113388135;5337.786488540571;5753.741081651252;5765.69372251103;5784.132380143013;4960.950390496193;5285.920711189258;5294.100002999577;5647.322321321468;5680.2615659965595;5525.530329922001;5567.24842146305;5757.884842303214;6109.372969622927;6143.56995010345;4262.339337402707;4524.049949510508;4602.456108796141;4627.449804315592;4643;5363.544098751494;5681.920435117315;5887.322957859901;5893.086571581412;5928.436798504135;4915.434725006527;5571.4428557143965;5690.886182276414;5714.685692286964;5723.227364305765;4750.358701575243;5063.822766203165;5475.72621368938;5698.629589076697;5708.771649133988;4620.834728211186;4863.929935414203;5491.36849262324;5509.815389691235;5531.115021596525;4705.976470117765;4713.599344055794;4728.976355118202;4930.186519224288;5730.742116604846;5259.763310651107;5560.805371811967;5563.443655634404;5582.692951887685;5593.776248949996 08:35:13 INFO - PROCESS | 1642 | |5;yui.html;799.9280064794167;816.4570560577215;826.2811354121915;831.526030162807;875.9299256059514;16920.661586768256;17793.110344482757;17826.64346713065;17836;17850.553736156602;15581.454649087284;15814;16106.75839862403;16117.435889743861;16742.49772506824;976.8876579193377;981.1316984468725;983.4738414948005;983.8376667849797;983.8917719050899;975.6438899801592;979.1823827104377;980.3529670417525;981.3179840011195;1012.3773879064396;1049.7847941172042;1051.742323130834;1053.4100903494068;1053.5417093564324;1054.8839627640953;1049.9737506562321;1050.4275170032352;1052.1582733812957;1052.8368102944055;1053.8788039375493;772.0426670928065;772.1737740617541;772.6136931534232;773.6093272897207;774.2721841469057;17469.03920284384;17864.46406607804;17870.731939020927;18113.275468981225;18272.63454730898;14304.141751494944;14763.557093287218;14823.925880370636;14922.552323430315;15196.924015379964;11406.828897566544;12170.878291217063;12268.683673520249;13338.599842004756;13517.526886558922;4538.8865278367975;4551.180787458256;4686.507916668735;4818.68678535894;4819.469858315582;90186;115637;117600.23599646012;118249;120330.79669203283;11001.834972475419;11379.601713939972;11402;11566.768664626661;11776.293422394512;22687.659685104736;23045.423864403525;23073.769262307163;23180.420489487897;23212.88393558055;6492.318306577836;7543.509671871311;7984.361251099898;7994.320482758914;8056.879146812803;4465.419495465569;4489.977550112294;4533.116042371706;4560.977195114069;4762.476127625959;3590.7127429805555;3623.3115708015393;3663.303972245265;3697.8705745298785;3849.672777813861;726.7892311229684;726.8800647893038;735.2941176470648;745.262190431469;747.4506237915128;686.2177118085386;699.2064007351693;720.6684924934589;746.4737360161073;771.7530390275058;10394;10852.294600851077;10882.401467919182;11733;11836.644900652995;572.6192082265247;627.9654618995908;628.1425853709653;666.7266420767462;730.9305615966475;5052.722100284446;5225.913986007043;5259.36887573486;5275.762590683352;5303.609552653852;80524.59737701275;83881;102211.4889425563;102681;106781.39827902587;53964.730176348865;64534.354656453776;81084;89989;95964;79178.6041069791;82711.3457730854;85051.57474212837;85868;88549.55725221203;10678.62624808128;11259.211855170059;11549.82675259855;11608.6517404478;11663.358515281741;48656;53753.92492150057;55136;56094;57562;68643;69571;69965;70663.64668176626;72342.91485627825;14001.80668473358;14089.365978531196;14362.928185359006;14629.634259143606;14773.704525909206;15286.923565382547;15690.529284121494;15700.371985120468;15739;16258.024518528926;14052.718945621235;14779.261036947895;14785.856050872779;14796.816254699814;15102.961189641264;14355.712885742436;14686;14771.96596238253;14835.777463337843;14836;12079.75840483203;14234.572962811133;14339.928300358431;14762.63093422673;14801.407943682132;10632.734181645521;10777.46112694378;10805.757337906241;10899.29154604948;11201.095813711525;10597.62908298206;12211.938940305597;12311.908296141124;12312.630621081382;12426.502939882303 08:35:13 INFO - PROCESS | 1642 | __end_tp_report 08:35:13 INFO - PROCESS | 1642 | __start_cc_report 08:35:13 INFO - PROCESS | 1642 | _x_x_mozilla_cycle_collect,1404 08:35:13 INFO - PROCESS | 1642 | __end_cc_report 08:35:13 INFO - PROCESS | 1642 | __startTimestamp1492529713312__endTimestamp 08:35:13 INFO - PROCESS | 1642 | 08:35:13 INFO - PROCESS | 1642 | ------- Summary: start ------- 08:35:13 INFO - PROCESS | 1642 | Number of tests: 6 08:35:13 INFO - PROCESS | 1642 | 08:35:13 INFO - PROCESS | 1642 | [#0] dojo.html Cycles:165 Average:6157.42 Median:6348.27 stddev:688.81 (10.9%) stddev-sans-first:660.46 08:35:13 INFO - PROCESS | 1642 | Values: 3575.1 3579.9 3607.6 3612.3 3658.7 6229.4 6239.3 6253.3 6258.7 6267.1 6236.8 6252.0 6279.9 6283.9 6288.9 5576.6 5593.1 5593.7 5642.3 5701.6 5470.9 5474.9 5510.9 5704.0 5706.5 5615.0 5618.1 5642.5 5670.1 5680.1 5666.0 5689.2 5696.0 5697.9 5700.5 5397.6 5487.6 5589.7 5608.2 5674.3 6168.4 6171.4 6175.4 6240.2 6290.1 6636.4 6644.4 6647.2 6649.7 6661.4 6643.9 6667.6 6726.0 6733.1 6748.7 6148.6 6211.6 6252.6 6306.5 6310.4 6821.2 6866.8 6872.1 6872.6 6874.5 6466.6 6498.2 6526.0 6538.8 6542.6 6389.4 6448.9 6519.6 6685.8 6699.7 6409.7 6428.9 6481.7 6548.6 6556.6 6594.9 6625.3 6627.3 6629.7 6640.9 4595.4 5166.5 5325.5 5327.9 5335.9 4691.2 4709.1 4755.8 4787.6 4795.2 6227.5 6262.9 6270.2 6302.9 6312.1 6710.7 6738.4 6742.8 6749.2 6753.9 6313.1 6318.5 6324.6 6325.7 6338.8 5207.2 5665.4 5724.9 5764.3 5785.2 6888.1 6919.4 6936.4 6940.5 6945.4 6716.1 6722.2 6733.8 6756.5 6760.9 6538.9 6546.6 6668.8 6914.0 6926.6 6420.9 6533.5 6551.3 6606.6 6639.8 6401.7 6472.5 6497.0 6589.3 6602.3 6469.7 6475.6 6481.2 6485.6 6489.0 6286.3 6467.2 6469.7 6478.2 6482.0 6213.1 6257.2 6264.2 6279.6 6369.8 6482.3 6496.6 6507.2 6508.3 6521.6 5304.5 6341.9 6348.3 6351.4 6356.2 08:35:13 INFO - PROCESS | 1642 | 08:35:13 INFO - PROCESS | 1642 | [#1] ext.html Cycles:180 Average:59008.28 Median:17649.11 stddev:121925.37 (690.8%) stddev-sans-first:122189.04 08:35:13 INFO - PROCESS | 1642 | Values: 784.7 822.5 840.3 912.6 920.9 30099.1 36222.8 43309.9 43519.0 43692.6 45006.0 45112.5 45164.1 45180.3 45200.5 8082.8 9681.6 9920.1 9926.3 9937.1 8039.4 12035.0 12164.0 12195.9 12197.6 12179.0 12263.7 12288.1 12296.9 12312.8 12182.1 12244.0 12254.0 12264.6 12276.5 11620.3 11711.4 11715.5 11715.7 11716.9 42541.0 42680.0 42718.0 42722.4 42729.4 3432.2 4027.1 4033.8 4039.1 4122.6 29957.4 29971.9 30621.0 30668.7 30843.8 3143.7 3178.7 3222.4 3231.1 3258.1 356587.0 359011.0 359154.0 359165.2 359603.0 44849.8 45017.1 45028.5 45090.5 45163.5 38383.2 46802.8 46829.5 46867.5 46889.8 12204.5 14492.6 14600.4 14634.1 14647.9 11137.1 11329.3 12630.2 12641.2 12647.4 10961.8 10975.2 11023.8 11030.1 12285.4 4954.3 5872.7 5876.8 5880.3 5883.9 1164.0 1166.6 1193.3 1195.7 1204.8 27714.6 28285.0 28307.7 28319.2 28340.1 988.8 1082.8 1266.0 1282.7 1332.6 12088.4 13752.2 14447.1 14549.4 14687.6 478659.0 493850.0 495696.5 496032.0 498844.0 50432.2 60216.7 60667.0 60667.4 60812.1 1494.5 1516.0 1532.5 1534.8 1537.1 30386.5 31268.0 31354.4 31997.2 32075.8 48063.8 48711.0 50775.7 50899.5 50966.7 506670.0 509432.0 509607.0 510297.0 510402.0 33846.5 33864.2 33868.3 33884.0 33911.0 40331.6 40529.8 40918.0 41164.8 41812.4 28457.4 28621.8 28901.9 29296.1 29944.0 23682.9 29346.7 29807.6 29888.0 30009.2 35496.8 36121.3 36249.6 36324.0 36339.8 28925.4 29376.7 29908.6 30078.7 30134.7 23365.0 23427.3 23588.6 23882.1 24114.9 08:35:13 INFO - PROCESS | 1642 | 08:35:13 INFO - PROCESS | 1642 | [#2] jquery.html Cycles:180 Average:45032.12 Median:22644.48 stddev:133290.99 (588.6%) stddev-sans-first:133622.80 08:35:13 INFO - PROCESS | 1642 | Values: 408.6 423.7 430.3 437.8 446.8 20384.7 20921.3 22113.6 22442.1 22495.6 22090.8 23055.8 23291.0 23647.2 24013.5 7025.4 7313.1 7342.8 7345.0 7538.3 7694.0 7778.4 7812.8 7813.2 7835.7 7541.2 7633.4 7725.8 7730.7 7732.6 7538.5 7761.6 7769.3 7815.9 7854.1 7038.3 7356.3 7580.2 7604.7 7626.9 26712.3 27139.0 27261.3 27467.6 27501.4 3074.2 3076.2 3080.5 3097.4 3248.2 17791.5 17904.5 17963.7 18286.6 19291.5 2185.0 2208.0 2208.2 2221.3 2222.9 126682.7 139392.0 146586.0 151739.0 153052.0 23113.5 24432.3 25047.0 25064.9 25366.4 43340.8 43348.1 44376.3 44465.8 44493.2 10520.6 10761.7 10955.6 11010.4 11110.8 9059.1 9095.5 9107.3 9120.6 9269.8 9723.0 9833.4 9903.1 9919.7 9934.5 3528.6 3572.0 4160.4 4222.0 4253.9 1056.7 1075.4 1082.0 1083.9 1137.1 17182.8 22182.0 22550.9 22738.1 22783.7 1084.8 1095.2 1114.5 1134.7 1137.0 10935.9 11781.0 11781.8 11795.4 11815.9 791063.0 794608.0 806164.0 807177.0 819853.0 135836.8 146746.1 153880.0 167529.0 169006.0 1203.7 1214.8 1219.9 1235.9 1240.3 19012.0 19742.8 19948.1 19975.0 19983.9 61710.7 62481.0 62936.4 63232.7 63501.0 64376.7 86672.6 86690.6 89125.7 89789.6 10375.3 11538.4 11640.3 11662.5 11862.0 12860.9 12967.0 13227.8 13347.2 13380.6 9551.7 9931.4 11098.6 11155.1 11482.3 8339.6 10490.5 10698.5 10836.0 10840.4 11384.8 11725.2 11760.2 11813.6 11914.2 11488.3 11497.5 11778.4 11794.0 11910.5 11333.6 11473.9 11614.7 11665.9 11721.2 08:35:13 INFO - PROCESS | 1642 | 08:35:13 INFO - PROCESS | 1642 | [#3] mootools.html Cycles:180 Average:6941.20 Median:2463.20 stddev:4357.59 (176.9%) stddev-sans-first:4350.09 08:35:13 INFO - PROCESS | 1642 | Values: 1423.0 1553.8 1640.3 1662.2 1664.5 9632.4 10030.5 10031.4 10220.9 10265.4 10017.8 11034.1 11354.6 11554.0 11591.0 2375.0 2424.6 2425.2 2429.3 2435.9 2265.9 2383.0 2440.6 2486.3 2493.5 2079.5 2152.8 2157.1 2158.2 2159.3 2137.6 2159.0 2382.7 2464.9 2471.7 2438.3 2459.3 2461.5 2464.9 2468.9 11349.2 11585.0 11596.5 11605.5 11610.8 5916.8 6124.8 6130.2 6136.0 6137.9 3610.6 3690.8 3750.8 3751.7 3814.3 1283.4 1902.7 1928.9 1950.3 2000.2 15976.0 16096.6 16112.8 16115.8 16118.2 4719.3 4852.1 4852.6 4925.1 4944.1 12345.5 12352.3 12358.3 12369.3 12373.9 5097.8 6069.8 6076.5 6079.7 6080.5 5274.9 5422.6 5512.4 5540.9 5571.4 3417.5 3877.4 4014.9 4033.8 4084.4 1044.2 1048.5 1063.2 1063.8 1066.5 957.0 982.3 995.5 997.5 1010.1 6788.9 6796.0 6913.7 6993.8 7074.3 981.6 987.3 990.2 1026.1 1048.2 3923.6 4003.4 4033.7 4440.4 4522.5 13493.7 14335.4 14335.7 14344.0 14355.3 13457.2 14043.8 14253.5 14300.9 14324.6 10313.6 10587.9 10601.8 10623.9 10652.8 5525.6 6864.2 6886.7 6943.5 7282.2 12379.3 12594.1 12712.5 12831.8 12940.7 12864.8 12884.0 12944.4 12976.3 12996.0 9394.3 9425.7 9591.4 9602.8 9635.5 10421.2 10550.0 10626.6 10645.5 10658.2 8937.0 9167.5 9184.6 9204.5 9247.9 8469.4 8521.1 8648.9 8673.6 8992.8 8102.7 8129.7 8158.3 8206.9 8231.8 6024.7 6103.4 6137.3 6167.6 6316.1 5983.9 6111.8 6133.8 6294.6 6318.6 08:35:13 INFO - PROCESS | 1642 | 08:35:13 INFO - PROCESS | 1642 | [#4] prototype.html Cycles:180 Average:4600.95 Median:4960.67 stddev:1304.39 (26.3%) stddev-sans-first:1268.55 08:35:13 INFO - PROCESS | 1642 | Values: 356.8 375.6 393.1 396.7 403.4 4992.6 5115.4 5177.7 5267.7 5268.6 4030.9 4902.8 5138.7 5154.9 5205.3 3689.8 4010.9 4151.9 4263.6 4276.9 3814.2 4002.4 4364.0 4368.3 4403.8 3901.3 3948.6 4360.3 4360.9 4398.9 3459.9 3681.3 3985.0 4093.2 4151.6 3571.4 3586.6 3991.7 4022.3 4034.1 5012.4 5028.0 5030.5 5066.5 5088.6 4243.0 4587.3 4680.0 4778.9 5108.0 4841.2 4910.6 5381.6 5566.7 5576.2 3885.8 4355.9 4559.5 4626.7 4627.8 5734.7 5821.5 5838.2 5911.7 5922.8 3973.4 4058.2 4434.7 4603.8 4621.9 4264.2 4364.3 4398.9 4716.5 4755.1 4614.6 4894.5 4950.3 5005.9 5043.1 4526.4 5049.6 5422.8 5607.8 5627.3 1440.7 1459.1 1549.0 1592.9 1619.9 1040.6 1107.7 1121.8 1188.4 1221.3 4880.7 4913.9 5220.0 5231.6 5250.6 5264.0 5314.4 5392.4 5667.2 5677.2 4069.1 4748.5 5100.4 5101.4 5167.5 2373.3 2575.1 2647.5 2791.6 2951.9 5036.1 5351.5 5511.5 5966.8 6038.5 4960.4 5096.6 5478.0 5672.6 5676.8 4865.9 5421.9 5825.4 5826.3 5830.8 5013.9 5337.8 5753.7 5765.7 5784.1 4961.0 5285.9 5294.1 5647.3 5680.3 5525.5 5567.2 5757.9 6109.4 6143.6 4262.3 4524.0 4602.5 4627.4 4643.0 5363.5 5681.9 5887.3 5893.1 5928.4 4915.4 5571.4 5690.9 5714.7 5723.2 4750.4 5063.8 5475.7 5698.6 5708.8 4620.8 4863.9 5491.4 5509.8 5531.1 4706.0 4713.6 4729.0 4930.2 5730.7 5259.8 5560.8 5563.4 5582.7 5593.8 08:35:13 INFO - PROCESS | 1642 | 08:35:13 INFO - PROCESS | 1642 | [#5] yui.html Cycles:180 Average:21092.90 Median:17992.00 stddev:29328.44 (163.0%) stddev-sans-first:29371.13 08:35:13 INFO - PROCESS | 1642 | Values: 799.9 816.5 826.3 831.5 875.9 16920.7 17793.1 17826.6 17836.0 17850.6 15581.5 15814.0 16106.8 16117.4 16742.5 976.9 981.1 983.5 983.8 983.9 975.6 979.2 980.4 981.3 1012.4 1049.8 1051.7 1053.4 1053.5 1054.9 1050.0 1050.4 1052.2 1052.8 1053.9 772.0 772.2 772.6 773.6 774.3 17469.0 17864.5 17870.7 18113.3 18272.6 14304.1 14763.6 14823.9 14922.6 15196.9 11406.8 12170.9 12268.7 13338.6 13517.5 4538.9 4551.2 4686.5 4818.7 4819.5 90186.0 115637.0 117600.2 118249.0 120330.8 11001.8 11379.6 11402.0 11566.8 11776.3 22687.7 23045.4 23073.8 23180.4 23212.9 6492.3 7543.5 7984.4 7994.3 8056.9 4465.4 4490.0 4533.1 4561.0 4762.5 3590.7 3623.3 3663.3 3697.9 3849.7 726.8 726.9 735.3 745.3 747.5 686.2 699.2 720.7 746.5 771.8 10394.0 10852.3 10882.4 11733.0 11836.6 572.6 628.0 628.1 666.7 730.9 5052.7 5225.9 5259.4 5275.8 5303.6 80524.6 83881.0 102211.5 102681.0 106781.4 53964.7 64534.4 81084.0 89989.0 95964.0 79178.6 82711.3 85051.6 85868.0 88549.6 10678.6 11259.2 11549.8 11608.7 11663.4 48656.0 53753.9 55136.0 56094.0 57562.0 68643.0 69571.0 69965.0 70663.6 72342.9 14001.8 14089.4 14362.9 14629.6 14773.7 15286.9 15690.5 15700.4 15739.0 16258.0 14052.7 14779.3 14785.9 14796.8 15103.0 14355.7 14686.0 14772.0 14835.8 14836.0 12079.8 14234.6 14339.9 14762.6 14801.4 10632.7 10777.5 10805.8 10899.3 11201.1 10597.6 12211.9 12311.9 12312.6 12426.5 08:35:13 INFO - PROCESS | 1642 | -------- Summary: end -------- 08:35:13 INFO - PROCESS | 1642 | 08:35:13 INFO - TEST-INFO | 1642: exit 0 08:35:13 INFO - TEST-OK | dromaeo_css | took 1119006ms 08:35:13 INFO - TEST-START | kraken 08:35:13 INFO - operating with platform_type : mac_ 08:35:13 INFO - Initialising browser for kraken test... 08:35:13 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/f4/zwr2n_y50tg1y44pl818tgt800000w/T/tmpyafseD/profile http://localhost:49241/getInfo.html) 08:35:16 INFO - PROCESS | 1652 | __metrics Screen width/height:1600/1200 08:35:16 INFO - PROCESS | 1652 | colorDepth:24 08:35:16 INFO - PROCESS | 1652 | Browser inner width/height: 1024/689 08:35:16 INFO - PROCESS | 1652 | __metrics 08:35:16 INFO - PROCESS | 1652 | 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" 08:35:16 INFO - PROCESS | 1652 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:35:16 INFO - TEST-INFO | 1652: exit 0 08:35:16 INFO - Browser initialized. 08:35:16 INFO - Running cycle 1/1 for kraken test... 08:35:16 INFO - TEST-INFO | started process 1654 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/f4/zwr2n_y50tg1y44pl818tgt800000w/T/tmpyafseD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:35:28 INFO - PROCESS | 1654 | RSS: Main: 169144320 08:35:28 INFO - PROCESS | 1654 | 08:35:31 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection) 08:35:32 INFO - PROCESS | 1654 | RSS: Main: 219570176 08:35:32 INFO - PROCESS | 1654 | 08:35:35 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-dft) 08:35:35 INFO - PROCESS | 1654 | RSS: Main: 229732352 08:35:35 INFO - PROCESS | 1654 | 08:35:38 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-fft) 08:35:39 INFO - PROCESS | 1654 | RSS: Main: 325591040 08:35:39 INFO - PROCESS | 1654 | 08:35:41 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator) 08:35:42 INFO - PROCESS | 1654 | RSS: Main: 228311040 08:35:42 INFO - PROCESS | 1654 | 08:35:44 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:35:44 INFO - PROCESS | 1654 | RSS: Main: 231116800 08:35:44 INFO - PROCESS | 1654 | 08:35:47 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom) 08:35:48 INFO - PROCESS | 1654 | RSS: Main: 270471168 08:35:48 INFO - PROCESS | 1654 | 08:35:51 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate) 08:35:51 INFO - PROCESS | 1654 | RSS: Main: 272609280 08:35:51 INFO - PROCESS | 1654 | 08:35:54 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial) 08:35:55 INFO - PROCESS | 1654 | RSS: Main: 268054528 08:35:55 INFO - PROCESS | 1654 | 08:35:56 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:35:57 INFO - PROCESS | 1654 | RSS: Main: 249012224 08:35:57 INFO - PROCESS | 1654 | 08:35:59 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:36:00 INFO - PROCESS | 1654 | RSS: Main: 251068416 08:36:00 INFO - PROCESS | 1654 | 08:36:02 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:36:02 INFO - PROCESS | 1654 | RSS: Main: 261070848 08:36:02 INFO - PROCESS | 1654 | 08:36:05 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:36:06 INFO - PROCESS | 1654 | RSS: Main: 273305600 08:36:06 INFO - PROCESS | 1654 | 08:36:09 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:36:09 INFO - PROCESS | 1654 | RSS: Main: 266805248 08:36:09 INFO - PROCESS | 1654 | 08:36:11 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49241/tests/kraken/driver.html?testName=ai-astar) 08:36:11 INFO - PROCESS | 1654 | RSS: Main: 311615488 08:36:11 INFO - PROCESS | 1654 | 08:36:11 INFO - PROCESS | 1654 | __start_tp_report 08:36:11 INFO - PROCESS | 1654 | _x_x_mozilla_page_load 08:36:11 INFO - PROCESS | 1654 | _x_x_mozilla_page_load_details 08:36:11 INFO - PROCESS | 1654 | |i|pagename|runs| 08:36:11 INFO - PROCESS | 1654 | |0;ai-astar;118;118;116;117;117;117;115;116;116;117 08:36:11 INFO - PROCESS | 1654 | |1;audio-beat-detection;129;108;104;149;133;133;129;105;121;106 08:36:11 INFO - PROCESS | 1654 | |2;audio-dft;186;183;182;185;185;183;185;184;181;179 08:36:11 INFO - PROCESS | 1654 | |3;audio-fft;80;60;59;89;61;61;60;61;74;58 08:36:11 INFO - PROCESS | 1654 | |4;audio-oscillator;83;68;86;68;68;68;82;68;70;107 08:36:11 INFO - PROCESS | 1654 | |5;imaging-gaussian-blur;86;86;86;86;86;86;86;86;90;86 08:36:11 INFO - PROCESS | 1654 | |6;imaging-darkroom;93;94;93;93;93;93;93;93;94;94 08:36:11 INFO - PROCESS | 1654 | |7;imaging-desaturate;85;86;83;85;99;130;108;82;83;83 08:36:11 INFO - PROCESS | 1654 | |8;json-parse-financial;61;61;60;62;61;62;61;62;63;61 08:36:11 INFO - PROCESS | 1654 | |9;json-stringify-tinderbox;62;64;67;64;61;58;61;60;59;59 08:36:11 INFO - PROCESS | 1654 | |10;stanford-crypto-aes;81;84;84;83;84;83;81;82;82;86 08:36:11 INFO - PROCESS | 1654 | |11;stanford-crypto-ccm;136;132;134;135;139;142;126;142;182;142 08:36:11 INFO - PROCESS | 1654 | |12;stanford-crypto-pbkdf2;202;172;161;162;161;161;161;162;159;159 08:36:11 INFO - PROCESS | 1654 | |13;stanford-crypto-sha256-iterative;66;64;65;64;67;62;63;63;63;62 08:36:11 INFO - PROCESS | 1654 | __end_tp_report 08:36:11 INFO - PROCESS | 1654 | __start_cc_report 08:36:11 INFO - PROCESS | 1654 | _x_x_mozilla_cycle_collect,2077 08:36:11 INFO - PROCESS | 1654 | __end_cc_report 08:36:11 INFO - PROCESS | 1654 | __startTimestamp1492529771782__endTimestamp 08:36:11 INFO - PROCESS | 1654 | 08:36:11 INFO - PROCESS | 1654 | ------- Summary: start ------- 08:36:11 INFO - PROCESS | 1654 | Number of tests: 14 08:36:11 INFO - PROCESS | 1654 | 08:36:11 INFO - PROCESS | 1654 | [#0] ai-astar Cycles:10 Average:116.70 Median:117.00 stddev:0.95 (0.8%) stddev-sans-first:0.88 08:36:11 INFO - PROCESS | 1654 | Values: 118.0 118.0 116.0 117.0 117.0 117.0 115.0 116.0 116.0 117.0 08:36:11 INFO - PROCESS | 1654 | 08:36:11 INFO - PROCESS | 1654 | [#1] audio-beat-detection Cycles:10 Average:121.70 Median:129.00 stddev:15.40 (11.9%) stddev-sans-first:16.10 08:36:11 INFO - PROCESS | 1654 | Values: 129.0 108.0 104.0 149.0 133.0 133.0 129.0 105.0 121.0 106.0 08:36:11 INFO - PROCESS | 1654 | 08:36:11 INFO - PROCESS | 1654 | [#2] audio-dft Cycles:10 Average:183.30 Median:184.50 stddev:2.16 (1.2%) stddev-sans-first:2.06 08:36:11 INFO - PROCESS | 1654 | Values: 186.0 183.0 182.0 185.0 185.0 183.0 185.0 184.0 181.0 179.0 08:36:11 INFO - PROCESS | 1654 | 08:36:11 INFO - PROCESS | 1654 | [#3] audio-fft Cycles:10 Average:66.30 Median:61.00 stddev:10.79 (17.7%) stddev-sans-first:10.24 08:36:11 INFO - PROCESS | 1654 | Values: 80.0 60.0 59.0 89.0 61.0 61.0 60.0 61.0 74.0 58.0 08:36:11 INFO - PROCESS | 1654 | 08:36:11 INFO - PROCESS | 1654 | [#4] audio-oscillator Cycles:10 Average:76.80 Median:69.00 stddev:12.89 (18.7%) stddev-sans-first:13.48 08:36:11 INFO - PROCESS | 1654 | Values: 83.0 68.0 86.0 68.0 68.0 68.0 82.0 68.0 70.0 107.0 08:36:11 INFO - PROCESS | 1654 | 08:36:11 INFO - PROCESS | 1654 | [#5] imaging-gaussian-blur Cycles:10 Average:86.40 Median:86.00 stddev:1.26 (1.5%) stddev-sans-first:1.33 08:36:11 INFO - PROCESS | 1654 | Values: 86.0 86.0 86.0 86.0 86.0 86.0 86.0 86.0 90.0 86.0 08:36:11 INFO - PROCESS | 1654 | 08:36:11 INFO - PROCESS | 1654 | [#6] imaging-darkroom Cycles:10 Average:93.30 Median:93.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 08:36:11 INFO - PROCESS | 1654 | Values: 93.0 94.0 93.0 93.0 93.0 93.0 93.0 93.0 94.0 94.0 08:36:11 INFO - PROCESS | 1654 | 08:36:11 INFO - PROCESS | 1654 | [#7] imaging-desaturate Cycles:10 Average:92.40 Median:84.00 stddev:15.72 (18.7%) stddev-sans-first:16.45 08:36:11 INFO - PROCESS | 1654 | Values: 85.0 86.0 83.0 85.0 99.0 130.0 108.0 82.0 83.0 83.0 08:36:11 INFO - PROCESS | 1654 | 08:36:11 INFO - PROCESS | 1654 | [#8] json-parse-financial Cycles:10 Average:61.40 Median:61.50 stddev:0.84 (1.4%) stddev-sans-first:0.88 08:36:11 INFO - PROCESS | 1654 | Values: 61.0 61.0 60.0 62.0 61.0 62.0 61.0 62.0 63.0 61.0 08:36:11 INFO - PROCESS | 1654 | 08:36:11 INFO - PROCESS | 1654 | [#9] json-stringify-tinderbox Cycles:10 Average:61.50 Median:61.50 stddev:2.80 (4.6%) stddev-sans-first:2.96 08:36:11 INFO - PROCESS | 1654 | Values: 62.0 64.0 67.0 64.0 61.0 58.0 61.0 60.0 59.0 59.0 08:36:11 INFO - PROCESS | 1654 | 08:36:11 INFO - PROCESS | 1654 | [#10] stanford-crypto-aes Cycles:10 Average:83.00 Median:83.50 stddev:1.56 (1.9%) stddev-sans-first:1.48 08:36:11 INFO - PROCESS | 1654 | Values: 81.0 84.0 84.0 83.0 84.0 83.0 81.0 82.0 82.0 86.0 08:36:11 INFO - PROCESS | 1654 | 08:36:11 INFO - PROCESS | 1654 | [#11] stanford-crypto-ccm Cycles:10 Average:141.00 Median:140.50 stddev:15.29 (10.9%) stddev-sans-first:16.11 08:36:11 INFO - PROCESS | 1654 | Values: 136.0 132.0 134.0 135.0 139.0 142.0 126.0 142.0 182.0 142.0 08:36:11 INFO - PROCESS | 1654 | 08:36:11 INFO - PROCESS | 1654 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.00 Median:161.50 stddev:13.17 (8.2%) stddev-sans-first:3.91 08:36:11 INFO - PROCESS | 1654 | Values: 202.0 172.0 161.0 162.0 161.0 161.0 161.0 162.0 159.0 159.0 08:36:11 INFO - PROCESS | 1654 | 08:36:11 INFO - PROCESS | 1654 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.90 Median:64.00 stddev:1.66 (2.6%) stddev-sans-first:1.58 08:36:11 INFO - PROCESS | 1654 | Values: 66.0 64.0 65.0 64.0 67.0 62.0 63.0 63.0 63.0 62.0 08:36:11 INFO - PROCESS | 1654 | -------- Summary: end -------- 08:36:11 INFO - PROCESS | 1654 | 08:36:12 INFO - TEST-INFO | 1654: exit 0 08:36:12 INFO - TEST-OK | kraken | took 58755ms 08:36:12 INFO - SUITE-END | took 1177s 08:36:12 INFO - Completed test suite (00:19:38) 08:36:12 INFO - javascript benchmark 08:36:13 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8006.218243868055, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3575.1419659281773, 3579.9284014319733, 3607.6031636519992, 3612.3317186320523, 3658.7438879278443, 6229.377062293774, 6239.34486878878, 6253.312135665079, 6258.687065646711, 6267.059941008851, 6236.750529978806, 6251.968425209846, 6279.905801412982, 6283.874322513559, 6288.937110628893, 5576.637518561281, 5593.133064375018, 5593.692346920918, 5642.266505354298, 5701.57238207134, 5470.890582188354, 5474.863128421782, 5510.91733623996, 5703.971480142614, 5706.4864162225595, 5614.9719251403685, 5618.073017952053, 5642.492175704186, 5670.121131224667, 5680.147977803321, 5666.0, 5689.231953686282, 5695.971520142393, 5697.943020569804, 5700.543956483513, 5397.568194544467, 5487.6158668893195, 5589.7205139743255, 5608.242887210256, 5674.262345895048, 6168.383161683841, 6171.352008039181, 6175.413335733098, 6240.219972503437, 6290.056491526308, 6636.435902948207, 6644.368784965421, 6647.169103862017, 6649.667516624149, 6661.4004739573675, 6643.86712265752, 6667.633280169589, 6725.966370168167, 6733.057371967929, 6748.662566871686, 6148.600340977822, 6211.627302361872, 6252.562320637603, 6306.463950564162, 6310.368963103653, 6821.21556021054, 6866.828329291708, 6872.072270243553, 6872.587644741231, 6874.518783685094, 6466.612003279818, 6498.155239818888, 6525.955847064447, 6538.803835884931, 6542.640154791532, 6389.361063893573, 6448.871022579522, 6519.608823470607, 6685.799426017227, 6699.665016749143, 6409.67951602418, 6428.903566446414, 6481.740730370732, 6548.574342667712, 6556.639384833785, 6594.86810263792, 6625.271220165778, 6627.304133066055, 6629.701663425158, 6640.933590664128, 4595.379623750818, 5166.45752196014, 5325.467453254643, 5327.946720532823, 5335.919961200585, 4691.225947718656, 4709.058188362341, 4755.785989630475, 4787.593054590329, 4795.232762757942, 6227.470664993436, 6262.906056409158, 6270.153529273581, 6302.873942521124, 6312.116303717483, 6710.698018589175, 6738.393544580913, 6742.83142921421, 6749.156355455568, 6753.8649227015185, 6313.116163737081, 6318.462930650946, 6324.557280990287, 6325.652089135142, 6338.809835704937, 5207.1668533034535, 5665.433456654301, 5724.885502289931, 5764.250647415809, 5785.247917770663, 6888.138982627172, 6919.446444284546, 6936.41040511542, 6940.514164008572, 6945.374916257359, 6716.126903502513, 6722.159730033746, 6733.7920176963735, 6756.527043107132, 6760.898586521304, 6538.901916471162, 6546.639934803631, 6668.799936001928, 6914.0320355151325, 6926.58440493572, 6420.935790642034, 6533.509986750918, 6551.279359270381, 6606.636634985122, 6639.767608133692, 6401.679916004088, 6472.546921715435, 6496.967515162394, 6589.27517973013, 6602.273749887412, 6469.708863101266, 6475.611463312216, 6481.157449531531, 6485.578437401554, 6489.0, 6286.27707813589, 6467.191601049869, 6469.676516174267, 6478.1578394808375, 6482.0, 6213.099100630474, 6257.217847769029, 6264.248290205204, 6279.623222606659, 6369.777057802955, 6482.254540727688, 6496.577722448026, 6507.219133703986, 6508.349165083454, 6521.6087034776165, 5304.469553044664, 6341.8731625368155, 6348.269948955929, 6351.396617321347, 6356.2054743157105], "value": 6112.841093809439, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [784.7371130671224, 822.5475988206487, 840.3319361107918, 912.5756523216703, 920.9033051529593, 30099.097027089167, 36222.8188859056, 43309.91725206871, 43519.0, 43692.563074369245, 45006.0, 45112.548874511245, 45164.09671806562, 45180.3222951656, 45200.54799452013, 8082.838343233132, 9681.56432960515, 9920.107190352866, 9926.305158638897, 9937.10566049059, 8039.35685145187, 12034.977026952676, 12163.999999999956, 12195.93902030493, 12197.573084942029, 12179.025677945787, 12263.69340766479, 12288.078394120432, 12296.93851530741, 12312.81530777039, 12182.086343524226, 12243.959263462617, 12254.019678425704, 12264.570740024146, 12276.508939642494, 11620.302781833117, 11711.355875426849, 11715.472803723853, 11715.7071073223, 11716.9454749073, 42541.0, 42680.0, 42718.0, 42722.35916461256, 42729.35905961413, 3432.2449061206494, 4027.1341661542615, 4033.7781422021776, 4039.111395492987, 4122.56713045129, 29957.400851983057, 29971.850140749157, 30621.0, 30668.693313066808, 30843.84578077118, 3143.7327827134723, 3178.6821317868257, 3222.3716375306826, 3231.1114443528218, 3258.120307516957, 356587.0, 359011.0, 359154.0, 359165.20417398005, 359603.0, 44849.77575112169, 45017.09965800666, 45028.549714502435, 45090.54909450929, 45163.548364516595, 38383.23233535314, 46802.76598617053, 46829.5317046832, 46867.531324686315, 46889.76555117202, 12204.450799714034, 14492.565223043326, 14600.41598336076, 14634.121952682874, 14647.853521464649, 11137.05335046514, 11329.320240785579, 12630.179038362478, 12641.178323408949, 12647.43086561107, 10961.780764384668, 10975.231733778559, 11023.83464248037, 11030.06244469229, 12285.447154878051, 4954.3311652926395, 5872.677002764889, 5876.794312199053, 5880.294364676266, 5883.911741323884, 1164.039667274485, 1166.550877911993, 1193.3376975778353, 1195.7010747313172, 1204.7891618966646, 27714.5842812358, 28285.0, 28307.71692283092, 28319.150425487267, 28340.149795506168, 988.7626969527262, 1082.7965091039696, 1265.9810102848464, 1282.6665067082627, 1332.6335257803987, 12088.41448264212, 13752.174869507862, 14447.133172009502, 14549.394149687705, 14687.632809179857, 478659.0, 493850.0, 495696.5215173901, 496032.0, 498844.0, 50432.24351634655, 60216.698916505135, 60666.99999999912, 60667.39332606617, 60812.087818682754, 1494.491872763244, 1515.9696806064037, 1532.4789571545728, 1534.8004759381208, 1537.085434166669, 30386.54420183743, 31268.0, 31354.372912541166, 31997.200069997503, 32075.83962080268, 48063.75968120137, 48711.025779484924, 50775.746121269156, 50899.491005089476, 50966.74516627542, 506670.0, 509432.0, 509607.0, 510297.0, 510402.0, 33846.492302614985, 33864.15339616529, 33868.3226335467, 33884.0, 33911.0, 40331.59668403396, 40529.797351013054, 40918.0, 41164.794176030126, 41812.3728144072, 28457.37691098509, 28621.830866933615, 28901.855490723254, 29296.121116366543, 29943.951961681236, 23682.88158559196, 29346.706532934397, 29807.55288670715, 29888.0, 30009.249768755082, 35496.82251588725, 36121.277574447835, 36249.637503624625, 36324.0, 36339.818300909385, 28925.421491570472, 29376.7062329374, 29908.551371729878, 30078.69921300759, 30134.69865301319, 23365.0, 23427.297181084596, 23588.646170307115, 23882.133629198324, 24114.87942560276], "value": 19360.221969935734, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [408.6097776623325, 423.70141979759813, 430.3243907065906, 437.8008006357108, 446.7833100946042, 20384.694229586567, 20921.267755628538, 22113.557728845415, 22442.102315907363, 22495.55008899821, 22090.77909220907, 23055.769442305573, 23290.951907164177, 23647.17234896779, 24013.519729605396, 7025.437964962791, 7313.12242530897, 7342.816429589249, 7345.0, 7538.321551060403, 7693.9615301923695, 7778.416618753616, 7812.765617031499, 7813.179616140309, 7835.725749598765, 7541.170471248186, 7633.427492938052, 7725.806854828618, 7730.729424470144, 7732.574708391036, 7538.547687138762, 7761.611919404064, 7769.300762931335, 7815.882761758578, 7854.136045035041, 7038.3313585209835, 7356.337929586363, 7580.241975802431, 7604.733834315773, 7626.885596716053, 26712.332191695168, 27139.0, 27261.318467038283, 27467.587986180224, 27501.449971000668, 3074.2015920686204, 3076.230942264434, 3080.476319025771, 3097.396007778484, 3248.204189973472, 17791.46625601234, 17904.462866114038, 17963.73054404185, 18286.634267314712, 19291.51771205731, 2184.983982448169, 2207.9558408831736, 2208.2271205078255, 2221.300290408516, 2222.9333120006427, 126682.73317266801, 139392.0, 146586.0, 151739.0, 153052.0, 23113.53772924532, 24432.267031989068, 25047.0, 25064.874675626506, 25366.365840853756, 43340.78329608395, 43348.13303733971, 44376.3343549847, 44465.77767111208, 44493.22027118879, 10520.631777887736, 10761.677149685522, 10955.561777528968, 11010.39442830652, 11110.777784444266, 9059.094090590888, 9095.545222738836, 9107.316951228684, 9120.589573469077, 9269.814603707888, 9723.0, 9833.4099954003, 9903.108720215216, 9919.65281215154, 9934.453605051647, 3528.6471352865024, 3572.035041104372, 4160.438340824011, 4222.0, 4253.914921701548, 1056.7041228456044, 1075.4138994247996, 1081.983770243447, 1083.913286937059, 1137.147139645266, 17182.828171718375, 22182.00180991859, 22550.872456377114, 22738.09047638076, 22783.658245126335, 1084.7559299157783, 1095.2442814457997, 1114.492905727908, 1134.7049767060623, 1137.0102320938358, 10935.945320273508, 11781.0, 11781.76436471283, 11795.41022948849, 11815.940920295343, 791063.0, 794608.0, 806164.0, 807177.0, 819853.0, 135836.84490041118, 146746.06507869784, 153880.0, 167529.0, 169006.0, 1203.6990752311922, 1214.7691938531475, 1219.896308813743, 1235.8949489293332, 1240.3054289597674, 19012.0, 19742.802571974098, 19948.102335395233, 19975.0, 19983.900080500087, 61710.69144654248, 62481.0, 62936.37063629305, 63232.683836582364, 63501.0, 64376.67811660912, 86672.56663716641, 86690.56654716686, 89125.66311505462, 89789.55105224693, 10375.325603835727, 11538.423078845855, 11640.322725773289, 11662.53349865996, 11862.0, 12860.935695321463, 12967.0, 13227.801582976455, 13347.199168049949, 13380.598582042554, 9551.713448596276, 9931.404115753077, 11098.61154859576, 11155.05182059534, 11482.311061336013, 8339.624716887876, 10490.475476226005, 10698.518566664363, 10836.024757771838, 10840.403777791982, 11384.829227561759, 11725.179237453296, 11760.176787624785, 11813.586524471602, 11914.16600837933, 11488.310701357945, 11497.482613282255, 11778.352190629597, 11794.0, 11910.464029118884, 11333.603323883624, 11473.885261147281, 11614.6515604532, 11665.88334116648, 11721.179517434039], "value": 12224.297113894363, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1422.964425889352, 1553.8213105492869, 1640.3028712797066, 1662.2021429713734, 1664.4756901576002, 9632.373895696775, 10030.498475076245, 10031.398116113029, 10220.948895255513, 10265.435401052939, 10017.849732254022, 11034.117270618352, 11354.602588909369, 11554.0, 11591.0, 2375.0, 2424.5635785558593, 2425.163318655061, 2429.283361408389, 2435.866027368494, 2265.8753768542724, 2383.0, 2440.6095024796036, 2486.3038349262147, 2493.463905260369, 2079.542500649862, 2152.827773778102, 2157.11558261113, 2158.1583182558816, 2159.3306075116684, 2137.6152292587326, 2159.017646970625, 2382.654515095319, 2464.864432456214, 2471.715752688428, 2438.317271164077, 2459.2990997565607, 2461.5446142463525, 2464.938376540601, 2468.9259322220364, 11349.20555561111, 11585.0, 11596.478158482803, 11605.477753501029, 11610.825837612443, 5916.822495325104, 6124.755009799603, 6130.2030736004035, 6135.9693201534155, 6137.9079313810325, 3610.584782749991, 3690.833912473945, 3750.8124593770203, 3751.6623503884507, 3814.275287695329, 1283.3519072868235, 1902.7431296774896, 1928.9131989060527, 1950.3368854589507, 2000.249906285143, 15976.0, 16096.59758506035, 16112.75830862538, 16115.758263626056, 16118.194090295437, 4719.339292499053, 4852.126617208936, 4852.587530059914, 4925.088858561177, 4944.1100601892, 12345.506179752889, 12352.25886446816, 12358.320292384005, 12369.257844529357, 12373.876261237272, 5097.8215762448135, 6069.757209711562, 6076.483498902643, 6079.726412311456, 6080.48315893154, 5274.92087618686, 5422.593305502103, 5512.448755124456, 5540.9168862467095, 5571.359293681197, 3417.5386322846593, 3877.379619260961, 4014.9397759033636, 4033.7781422021485, 4084.4281800547947, 1044.2116202267391, 1048.5386429970788, 1063.160103518212, 1063.8457423673524, 1066.4507778494083, 956.9521523923776, 982.3025651787311, 995.4525011243787, 997.4962643864802, 1010.1312870930993, 6788.864222715518, 6796.014577886179, 6913.688884000232, 6993.755218567326, 7074.327938845801, 981.6024510073431, 987.3236832769433, 990.2375171118199, 1026.0765311219961, 1048.234788604323, 3923.6272554107313, 4003.399490076512, 4033.6773058155277, 4440.378347031418, 4522.547745225517, 13493.66265843342, 14335.426582936774, 14335.713285734228, 14344.0, 14355.282235888373, 13457.192568445924, 14043.78934315986, 14253.50112746049, 14300.927430442758, 14324.57026289213, 10313.587456501657, 10587.89412105869, 10601.84097238542, 10623.946880265703, 10652.786944261226, 5525.613207075467, 6864.176298844171, 6886.655667216719, 6943.548669336477, 7282.198958114497, 12379.319137447526, 12594.11904573176, 12712.491500339884, 12831.807522887351, 12940.741185176055, 12864.807027894776, 12883.969282457569, 12944.41750121228, 12976.286304253357, 12996.0, 9394.342396032212, 9425.670101546413, 9591.376560523544, 9602.759931001781, 9635.518224088908, 10421.166306695295, 10550.0, 10626.628068017582, 10645.467726613793, 10658.200634952254, 8936.972248191541, 9167.49578773174, 9184.58669359867, 9204.493752843659, 9247.907520924973, 8469.364797640079, 8521.147885211429, 8648.870266946127, 8673.609687564202, 8992.775180620536, 8102.716404925799, 8129.7154599591095, 8158.265756081981, 8206.876896846432, 8231.794205144919, 6024.668643224665, 6103.389661033861, 6137.263528376623, 6167.568270221221, 6316.084167795736, 5983.880322393441, 6111.84720381994, 6133.785317513865, 6294.590851594632, 6318.589291696025], "value": 5309.805311637329, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [356.81715114395774, 375.6262518793799, 393.0703885311239, 396.6846357146069, 403.435190732974, 4992.600591952644, 5115.360579927509, 5177.715225662587, 5267.736613169336, 5268.578513718903, 4030.919381612366, 4902.80388784449, 5138.743062846861, 5154.896902061956, 5205.27126202332, 3689.8192578374933, 4010.8569057818527, 4151.937720934181, 4263.5523270056665, 4276.914461710764, 3814.1608846053823, 4002.4396584478195, 4363.956360436387, 4368.301071828492, 4403.845865394712, 3901.3367727486398, 3948.605139486043, 4360.28055370865, 4360.912781744363, 4398.868033958986, 3459.8582467785573, 3681.2821499807546, 3985.0435895385044, 4093.2018256440006, 4151.647109995654, 3571.3750093733493, 3586.6370779103772, 3991.6806655467494, 4022.336314508132, 4034.0838101901363, 5012.396033269355, 5027.974860125712, 5030.515997780663, 5066.518680725325, 5088.643794934356, 4242.957570424287, 4587.311903214511, 4679.976600116977, 4778.880527986794, 5108.0, 4841.2012018016985, 4910.607151427877, 5381.569474442035, 5566.666000040011, 5576.163575463673, 3885.844566217348, 4355.891102722426, 4559.475660299042, 4626.745528995903, 4627.8148874045, 5734.655920644775, 5821.476067153976, 5838.175994723463, 5911.733971971272, 5922.822315330547, 3973.443717879499, 4058.246122336827, 4434.733915964988, 4603.838865639686, 4621.861344159681, 4264.189803937242, 4364.258076127066, 4398.912021759611, 4716.457607375196, 4755.072760811678, 4614.561616646481, 4894.535019173173, 4950.331705219749, 5005.89988200234, 5043.092243396224, 4526.434195725535, 5049.6212784041345, 5422.8373148805595, 5607.831765047055, 5627.296587926509, 1440.6902515959118, 1459.1245252848419, 1548.984510154884, 1592.9406944381856, 1619.8542131208249, 1040.6097713357492, 1107.7452185997104, 1121.8036843552345, 1188.3582865252667, 1221.2855479544567, 4880.682755620874, 4913.926291105637, 5220.034293655686, 5231.555317797954, 5250.6085887239915, 5264.0, 5314.403041369188, 5392.433794451605, 5667.234923285304, 5677.17680936262, 4069.104796944727, 4748.525147485293, 5100.413452453015, 5101.413337466239, 5167.509086636764, 2373.326804602751, 2575.072973729456, 2647.510210611043, 2791.6370871786944, 2951.922548269866, 5036.143855544567, 5351.518363347317, 5511.503964643121, 5966.761329546856, 6038.456538911519, 4960.379952505937, 5096.578311327754, 5477.972610136924, 5672.602917795797, 5676.760451438576, 4865.9026819463415, 5421.864453388618, 5825.446582574648, 5826.300843898759, 5830.7959221427045, 5013.8886113388135, 5337.786488540571, 5753.741081651252, 5765.69372251103, 5784.132380143013, 4960.950390496193, 5285.920711189258, 5294.100002999577, 5647.322321321468, 5680.2615659965595, 5525.530329922001, 5567.24842146305, 5757.884842303214, 6109.372969622927, 6143.56995010345, 4262.339337402707, 4524.049949510508, 4602.456108796141, 4627.449804315592, 4643.0, 5363.544098751494, 5681.920435117315, 5887.322957859901, 5893.086571581412, 5928.436798504135, 4915.434725006527, 5571.4428557143965, 5690.886182276414, 5714.685692286964, 5723.227364305765, 4750.358701575243, 5063.822766203165, 5475.72621368938, 5698.629589076697, 5708.771649133988, 4620.834728211186, 4863.929935414203, 5491.36849262324, 5509.815389691235, 5531.115021596525, 4705.976470117765, 4713.599344055794, 4728.976355118202, 4930.186519224288, 5730.742116604846, 5259.763310651107, 5560.805371811967, 5563.443655634404, 5582.692951887685, 5593.776248949996], "value": 4221.787636078459, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [799.9280064794167, 816.4570560577215, 826.2811354121915, 831.526030162807, 875.9299256059514, 16920.661586768256, 17793.110344482757, 17826.64346713065, 17836.0, 17850.553736156602, 15581.454649087284, 15814.0, 16106.75839862403, 16117.435889743861, 16742.49772506824, 976.8876579193377, 981.1316984468725, 983.4738414948005, 983.8376667849797, 983.8917719050899, 975.6438899801592, 979.1823827104377, 980.3529670417525, 981.3179840011195, 1012.3773879064396, 1049.7847941172042, 1051.742323130834, 1053.4100903494068, 1053.5417093564324, 1054.8839627640953, 1049.9737506562321, 1050.4275170032352, 1052.1582733812957, 1052.8368102944055, 1053.8788039375493, 772.0426670928065, 772.1737740617541, 772.6136931534232, 773.6093272897207, 774.2721841469057, 17469.03920284384, 17864.46406607804, 17870.731939020927, 18113.275468981225, 18272.63454730898, 14304.141751494944, 14763.557093287218, 14823.925880370636, 14922.552323430315, 15196.924015379964, 11406.828897566544, 12170.878291217063, 12268.683673520249, 13338.599842004756, 13517.526886558922, 4538.8865278367975, 4551.180787458256, 4686.507916668735, 4818.68678535894, 4819.469858315582, 90186.0, 115637.0, 117600.23599646012, 118249.0, 120330.79669203283, 11001.834972475419, 11379.601713939972, 11402.0, 11566.768664626661, 11776.293422394512, 22687.659685104736, 23045.423864403525, 23073.769262307163, 23180.420489487897, 23212.88393558055, 6492.318306577836, 7543.509671871311, 7984.361251099898, 7994.320482758914, 8056.879146812803, 4465.419495465569, 4489.977550112294, 4533.116042371706, 4560.977195114069, 4762.476127625959, 3590.7127429805555, 3623.3115708015393, 3663.303972245265, 3697.8705745298785, 3849.672777813861, 726.7892311229684, 726.8800647893038, 735.2941176470648, 745.262190431469, 747.4506237915128, 686.2177118085386, 699.2064007351693, 720.6684924934589, 746.4737360161073, 771.7530390275058, 10394.0, 10852.294600851077, 10882.401467919182, 11733.0, 11836.644900652995, 572.6192082265247, 627.9654618995908, 628.1425853709653, 666.7266420767462, 730.9305615966475, 5052.722100284446, 5225.913986007043, 5259.36887573486, 5275.762590683352, 5303.609552653852, 80524.59737701275, 83881.0, 102211.4889425563, 102681.0, 106781.39827902587, 53964.730176348865, 64534.354656453776, 81084.0, 89989.0, 95964.0, 79178.6041069791, 82711.3457730854, 85051.57474212837, 85868.0, 88549.55725221203, 10678.62624808128, 11259.211855170059, 11549.82675259855, 11608.6517404478, 11663.358515281741, 48656.0, 53753.92492150057, 55136.0, 56094.0, 57562.0, 68643.0, 69571.0, 69965.0, 70663.64668176626, 72342.91485627825, 14001.80668473358, 14089.365978531196, 14362.928185359006, 14629.634259143606, 14773.704525909206, 15286.923565382547, 15690.529284121494, 15700.371985120468, 15739.0, 16258.024518528926, 14052.718945621235, 14779.261036947895, 14785.856050872779, 14796.816254699814, 15102.961189641264, 14355.712885742436, 14686.0, 14771.96596238253, 14835.777463337843, 14836.0, 12079.75840483203, 14234.572962811133, 14339.928300358431, 14762.63093422673, 14801.407943682132, 10632.734181645521, 10777.46112694378, 10805.757337906241, 10899.29154604948, 11201.095813711525, 10597.62908298206, 12211.938940305597, 12311.908296141124, 12312.630621081382, 12426.502939882303], "value": 8120.271674758892, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1413.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 116.0, 117.0, 117.0, 117.0, 115.0, 116.0, 116.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 108.0, 104.0, 149.0, 133.0, 133.0, 129.0, 105.0, 121.0, 106.0], "value": 121.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 183.0, 182.0, 185.0, 185.0, 183.0, 185.0, 184.0, 181.0, 179.0], "value": 183.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 60.0, 59.0, 89.0, 61.0, 61.0, 60.0, 61.0, 74.0, 58.0], "value": 66.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 68.0, 86.0, 68.0, 68.0, 68.0, 82.0, 68.0, 70.0, 107.0], "value": 76.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 86.0, 86.0, 86.0, 86.0, 86.0, 86.0, 90.0, 86.0], "value": 86.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 93.0, 93.0, 93.0, 93.0, 93.0, 93.0, 94.0, 94.0], "value": 93.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 83.0, 85.0, 99.0, 130.0, 108.0, 82.0, 83.0, 83.0], "value": 92.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 60.0, 62.0, 61.0, 62.0, 61.0, 62.0, 63.0, 61.0], "value": 61.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 64.0, 67.0, 64.0, 61.0, 58.0, 61.0, 60.0, 59.0, 59.0], "value": 61.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 84.0, 84.0, 83.0, 84.0, 83.0, 81.0, 82.0, 82.0, 86.0], "value": 83.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 132.0, 134.0, 135.0, 139.0, 142.0, 126.0, 142.0, 182.0, 142.0], "value": 141.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [202.0, 172.0, 161.0, 162.0, 161.0, 161.0, 161.0, 162.0, 159.0, 159.0], "value": 166.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 64.0, 65.0, 64.0, 67.0, 62.0, 63.0, 63.0, 63.0, 62.0], "value": 63.9, "unit": "score"}]}]} 08:36:13 INFO - Return code: 0 08:36:13 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:36:13 INFO - # TBPL SUCCESS # 08:36:13 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:36:13 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:36:13 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:36:13 INFO - 2017-04-18 08:36:13.112 screenresolution[1658:9897] starting screenresolution argv=screenresolution get 08:36:13 INFO - 2017-04-18 08:36:13.115 screenresolution[1658:9897] Display 0: 1600x1200x32@60 08:36:13 INFO - 2017-04-18 08:36:13.121 screenresolution[1659:9901] starting screenresolution argv=screenresolution list 08:36:13 INFO - Available Modes on Display 0 08:36:13 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:36:13 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:36:13 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:36:13 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:36:13 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:36:13 INFO - Intel Iris: 08:36:13 INFO - Chipset Model: Intel Iris 08:36:13 INFO - Type: GPU 08:36:13 INFO - Bus: Built-In 08:36:13 INFO - VRAM (Dynamic, Max): 1536 MB 08:36:13 INFO - Vendor: Intel (0x8086) 08:36:13 INFO - Device ID: 0x0a2e 08:36:13 INFO - Revision ID: 0x0009 08:36:13 INFO - Displays: 08:36:13 INFO - Display: 08:36:13 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:36:13 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:36:13 INFO - Display Serial Number: 1600x1200 60 08:36:13 INFO - Main Display: Yes 08:36:13 INFO - Mirror: Off 08:36:13 INFO - Online: Yes 08:36:13 INFO - Rotation: Supported 08:36:13 INFO - Return code: 0 08:36:13 INFO - Running post-action listener: _resource_record_post_action 08:36:13 INFO - [mozharness: 2017-04-18 15:36:13.355738Z] Finished run-tests step (success) 08:36:13 INFO - Running post-run listener: _resource_record_post_run 08:36:13 INFO - Total resource usage - Wall time: 1193s; CPU: 54.0%; Read bytes: 37217280; Write bytes: 425609216; Read time: 386; Write time: 1686 08:36:13 INFO - TinderboxPrint: CPU usage
53.7% 08:36:13 INFO - TinderboxPrint: I/O read bytes / time
37,217,280 / 386 08:36:13 INFO - TinderboxPrint: I/O write bytes / time
425,609,216 / 1,686 08:36:13 INFO - TinderboxPrint: CPU idle
2,210.8 (46.3%) 08:36:13 INFO - TinderboxPrint: CPU system
948.0 (19.9%) 08:36:13 INFO - TinderboxPrint: CPU user
1,614.9 (33.8%) 08:36:13 INFO - TinderboxPrint: Swap in / out
158,842,880 / 0 08:36:13 INFO - install - Wall time: 15s; CPU: 54.0%; Read bytes: 121276928; Write bytes: 117409792; Read time: 11071; Write time: 299 08:36:13 INFO - run-tests - Wall time: 1179s; CPU: 54.0%; Read bytes: 35083264; Write bytes: 298106880; Read time: 362; Write time: 1351 08:36:13 INFO - Running post-run listener: _upload_blobber_files 08:36:13 INFO - Blob upload gear active. 08:36:13 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:36:13 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 08:36:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:36:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:36:14 INFO - (blobuploader) - INFO - Open directory for files ... 08:36:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:36:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:36:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:36:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:36:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:36:15 INFO - (blobuploader) - INFO - Done attempting. 08:36:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:36:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:36:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:36:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:36:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:36:16 INFO - (blobuploader) - INFO - Done attempting. 08:36:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 08:36:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:36:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:36:17 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 08:36:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:36:17 INFO - (blobuploader) - INFO - Done attempting. 08:36:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:36:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:36:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:36:19 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:36:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:36:19 INFO - (blobuploader) - INFO - Done attempting. 08:36:19 INFO - (blobuploader) - INFO - Iteration through files over. 08:36:19 INFO - Return code: 0 08:36:19 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:36:19 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:36:19 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b3d805125d164e7009b31623b296c701f2e879a1380353b772a8e904eef43d61cedf97a8517e664302455a69916cc21dd4acc6cdcba0ef80ad42b78d6aebed62", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b9d0e0a7ed35971ded8606f7c8af4b4280431c1cd97eb3fba69ab48614bf6aff8cedff8b1c20d4e9f6d72cfc2c6a3d4280fbec85dbb9f76ebdd5b7c9d80def5c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7e00898c0297f94fe7d06be871c113b3859584322031d77ea1045b8486df5e80e4e587d0304a2aacca9c9f6d2725cb2b76990adbf91e1e7dae9a9fc1290a6bce", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/45e332827e3e836475ce751ca18b2a32aee527662d9b2a7b54ffba9406ac48a6f735c5fb88772735e7b6cb0dd360a9d5494d1efc9cbbe4d0d3071a21f0f56447"} 08:36:19 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:36:19 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:36:19 INFO - Contents: 08:36:19 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b3d805125d164e7009b31623b296c701f2e879a1380353b772a8e904eef43d61cedf97a8517e664302455a69916cc21dd4acc6cdcba0ef80ad42b78d6aebed62", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b9d0e0a7ed35971ded8606f7c8af4b4280431c1cd97eb3fba69ab48614bf6aff8cedff8b1c20d4e9f6d72cfc2c6a3d4280fbec85dbb9f76ebdd5b7c9d80def5c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7e00898c0297f94fe7d06be871c113b3859584322031d77ea1045b8486df5e80e4e587d0304a2aacca9c9f6d2725cb2b76990adbf91e1e7dae9a9fc1290a6bce", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/45e332827e3e836475ce751ca18b2a32aee527662d9b2a7b54ffba9406ac48a6f735c5fb88772735e7b6cb0dd360a9d5494d1efc9cbbe4d0d3071a21f0f56447"} 08:36:19 INFO - Running post-run listener: copy_logs_to_upload_dir 08:36:19 INFO - Copying logs to upload dir... 08:36:19 INFO - mkdir: /builds/slave/test/build/upload/logs 08:36:19 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1277.778417 ========= master_lag: 0.22 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2017-04-18 08:36:19.642618) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-18 08:36:19.646668) ========= 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.Xv12q0hg1o/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.aOtK51zseo/Listeners TMPDIR=/var/folders/f4/zwr2n_y50tg1y44pl818tgt800000w/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/b3d805125d164e7009b31623b296c701f2e879a1380353b772a8e904eef43d61cedf97a8517e664302455a69916cc21dd4acc6cdcba0ef80ad42b78d6aebed62", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b9d0e0a7ed35971ded8606f7c8af4b4280431c1cd97eb3fba69ab48614bf6aff8cedff8b1c20d4e9f6d72cfc2c6a3d4280fbec85dbb9f76ebdd5b7c9d80def5c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7e00898c0297f94fe7d06be871c113b3859584322031d77ea1045b8486df5e80e4e587d0304a2aacca9c9f6d2725cb2b76990adbf91e1e7dae9a9fc1290a6bce", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/45e332827e3e836475ce751ca18b2a32aee527662d9b2a7b54ffba9406ac48a6f735c5fb88772735e7b6cb0dd360a9d5494d1efc9cbbe4d0d3071a21f0f56447"} build_url:https://queue.taskcluster.net/v1/task/W2UXu7FJQVGWxUsH9J-RJA/artifacts/public/build/firefox-54.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010948 build_url: 'https://queue.taskcluster.net/v1/task/W2UXu7FJQVGWxUsH9J-RJA/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/b3d805125d164e7009b31623b296c701f2e879a1380353b772a8e904eef43d61cedf97a8517e664302455a69916cc21dd4acc6cdcba0ef80ad42b78d6aebed62", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b9d0e0a7ed35971ded8606f7c8af4b4280431c1cd97eb3fba69ab48614bf6aff8cedff8b1c20d4e9f6d72cfc2c6a3d4280fbec85dbb9f76ebdd5b7c9d80def5c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7e00898c0297f94fe7d06be871c113b3859584322031d77ea1045b8486df5e80e4e587d0304a2aacca9c9f6d2725cb2b76990adbf91e1e7dae9a9fc1290a6bce", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/45e332827e3e836475ce751ca18b2a32aee527662d9b2a7b54ffba9406ac48a6f735c5fb88772735e7b6cb0dd360a9d5494d1efc9cbbe4d0d3071a21f0f56447"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-18 08:36:19.681447) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 2 secs) (at 2017-04-18 08:36:19.681787) ========= 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.Xv12q0hg1o/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.aOtK51zseo/Listeners TMPDIR=/var/folders/f4/zwr2n_y50tg1y44pl818tgt800000w/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.004976 ========= master_lag: 2.98 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 2 secs) (at 2017-04-18 08:36:22.670378) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-18 08:36:22.670719) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-18 08:36:22.676233) ========= ========= Total master_lag: 3.30 =========