builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0066 starttime: 1479154857.88 results: success (0) buildid: 20161114091743 builduid: 42ed84f7fcb64e2fb957c8f0e52037f0 revision: fd3c6c15ec64591b145ab1b6dd71c5a2e7b8d9b1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-14 12:20:57.876354) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-14 12:20:57.876834) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-14 12:20:57.877114) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-14 12:20:57.901149) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 12:20:57.901538) ========= 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.Y37dyXiUSe/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.rUdauvgPtK/Listeners TMPDIR=/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/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 --2016-11-14 12:20:57-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 7.81M=0.001s 2016-11-14 12:20:57 (7.81 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.082626 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 12:20:58.005762) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 12:20:58.009118) ========= 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.Y37dyXiUSe/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.rUdauvgPtK/Listeners TMPDIR=/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/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.020060 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 12:20:58.057357) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-14 12:20:58.057707) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev fd3c6c15ec64591b145ab1b6dd71c5a2e7b8d9b1 --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 fd3c6c15ec64591b145ab1b6dd71c5a2e7b8d9b1 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Y37dyXiUSe/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.rUdauvgPtK/Listeners TMPDIR=/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/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 2016-11-14 12:20:58,150 truncating revision to first 12 chars 2016-11-14 12:20:58,150 Setting DEBUG logging. 2016-11-14 12:20:58,150 attempt 1/10 2016-11-14 12:20:58,150 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/fd3c6c15ec64?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-14 12:20:59,307 unpacking tar archive at: mozilla-beta-fd3c6c15ec64/testing/mozharness/ program finished with exit code 0 elapsedTime=1.428698 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-14 12:20:59.512245) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-14 12:20:59.512604) ========= script_repo_revision: fd3c6c15ec64591b145ab1b6dd71c5a2e7b8d9b1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-14 12:20:59.513042) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-14 12:20:59.513417) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-14 12:20:59.532930) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2016-11-14 12:20:59.533337) ========= /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.Y37dyXiUSe/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.rUdauvgPtK/Listeners TMPDIR=/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/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 12:20:59 INFO - MultiFileLogger online at 20161114 12:20:59 in /builds/slave/test 12:20:59 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 12:20:59 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:20:59 INFO - {'append_to_log': False, 12:20:59 INFO - 'base_work_dir': '/builds/slave/test', 12:20:59 INFO - 'blob_upload_branch': 'Mozilla-Beta', 12:20:59 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:20:59 INFO - 'branch': 'Mozilla-Beta', 12:20:59 INFO - 'buildbot_json_path': 'buildprops.json', 12:20:59 INFO - 'config_files': ('talos/mac_config.py',), 12:20:59 INFO - 'default_actions': ('clobber', 12:20:59 INFO - 'read-buildbot-config', 12:20:59 INFO - 'download-and-extract', 12:20:59 INFO - 'populate-webroot', 12:20:59 INFO - 'create-virtualenv', 12:20:59 INFO - 'install', 12:20:59 INFO - 'run-tests'), 12:20:59 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:20:59 INFO - 'download_minidump_stackwalk': True, 12:20:59 INFO - 'download_symbols': 'ondemand', 12:20:59 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:20:59 INFO - 'tooltool.py': '/tools/tooltool.py', 12:20:59 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:20:59 INFO - '/tools/misc-python/virtualenv.py')}, 12:20:59 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:20:59 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:20:59 INFO - 'installer_path': 'installer.exe', 12:20:59 INFO - 'log_level': 'info', 12:20:59 INFO - 'log_name': 'talos', 12:20:59 INFO - 'log_to_console': True, 12:20:59 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 12:20:59 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 12:20:59 INFO - 'opt_config_files': (), 12:20:59 INFO - 'pip_index': False, 12:20:59 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 12:20:59 INFO - 'cmd': ('bash', 12:20:59 INFO - '-c', 12:20:59 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 12:20:59 INFO - 'enabled': True, 12:20:59 INFO - 'halt_on_failure': False, 12:20:59 INFO - 'name': 'check_screen_resolution'},), 12:20:59 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 12:20:59 INFO - 'cmd': ('bash', 12:20:59 INFO - '-c', 12:20:59 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 12:20:59 INFO - 'enabled': True, 12:20:59 INFO - 'halt_on_failure': False, 12:20:59 INFO - 'name': 'check_screen_resolution'},), 12:20:59 INFO - 'run_cmd_checks_enabled': True, 12:20:59 INFO - 'sps_profile': False, 12:20:59 INFO - 'sps_profile_interval': 0, 12:20:59 INFO - 'suite': 'dromaeojs', 12:20:59 INFO - 'system_bits': '32', 12:20:59 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:20:59 INFO - 'title': 't-yosemite-r7-0066', 12:20:59 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:20:59 INFO - 'use_talos_json': True, 12:20:59 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:20:59 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:20:59 INFO - 'work_dir': 'build'} 12:20:59 INFO - [mozharness: 2016-11-14 20:20:59.730628Z] Running clobber step. 12:20:59 INFO - Running pre-action listener: _resource_record_pre_action 12:20:59 INFO - Running main action method: clobber 12:20:59 INFO - rmtree: /builds/slave/test/build 12:20:59 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:21:00 INFO - Running post-action listener: _resource_record_post_action 12:21:00 INFO - [mozharness: 2016-11-14 20:21:00.072914Z] Finished clobber step (success) 12:21:00 INFO - [mozharness: 2016-11-14 20:21:00.073080Z] Running read-buildbot-config step. 12:21:00 INFO - Running pre-action listener: _resource_record_pre_action 12:21:00 INFO - Running main action method: read_buildbot_config 12:21:00 INFO - Using buildbot properties: 12:21:00 INFO - { 12:21:00 INFO - "project": "", 12:21:00 INFO - "product": "firefox", 12:21:00 INFO - "script_repo_revision": "production", 12:21:00 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 12:21:00 INFO - "repository": "", 12:21:00 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 12:21:00 INFO - "buildid": "20161114091743", 12:21:00 INFO - "pgo_build": "False", 12:21:00 INFO - "basedir": "/builds/slave/test", 12:21:00 INFO - "buildnumber": 1, 12:21:00 INFO - "slavename": "t-yosemite-r7-0066", 12:21:00 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 12:21:00 INFO - "platform": "yosemite_r7", 12:21:00 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 12:21:00 INFO - "branch": "mozilla-beta", 12:21:00 INFO - "repo_path": "releases/mozilla-beta", 12:21:00 INFO - "revision": "fd3c6c15ec64591b145ab1b6dd71c5a2e7b8d9b1", 12:21:00 INFO - "stage_platform": "macosx64", 12:21:00 INFO - "builduid": "42ed84f7fcb64e2fb957c8f0e52037f0", 12:21:00 INFO - "slavebuilddir": "test" 12:21:00 INFO - } 12:21:00 INFO - Found installer url https://queue.taskcluster.net/v1/task/IwhJdfYOTniFWpjGgcwpMQ/artifacts/public/build/firefox-51.0.en-US.mac.dmg. 12:21:00 INFO - Running post-action listener: _resource_record_post_action 12:21:00 INFO - [mozharness: 2016-11-14 20:21:00.076461Z] Finished read-buildbot-config step (success) 12:21:00 INFO - [mozharness: 2016-11-14 20:21:00.076611Z] Running download-and-extract step. 12:21:00 INFO - Running pre-action listener: _resource_record_pre_action 12:21:00 INFO - Running main action method: download_and_extract 12:21:00 INFO - mkdir: /builds/slave/test/build/tests 12:21:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:21:00 INFO - trying https://queue.taskcluster.net/v1/task/IwhJdfYOTniFWpjGgcwpMQ/artifacts/public/build/firefox-51.0.en-US.mac.test_packages.json 12:21:00 INFO - Downloading https://queue.taskcluster.net/v1/task/IwhJdfYOTniFWpjGgcwpMQ/artifacts/public/build/firefox-51.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0.en-US.mac.test_packages.json 12:21:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IwhJdfYOTniFWpjGgcwpMQ/artifacts/public/build/firefox-51.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0.en-US.mac.test_packages.json'}, attempt #1 12:21:01 INFO - Downloaded 1165 bytes. 12:21:01 INFO - Reading from file /builds/slave/test/build/firefox-51.0.en-US.mac.test_packages.json 12:21:01 INFO - Using the following test package requirements: 12:21:01 INFO - {u'common': [u'firefox-51.0.en-US.mac.common.tests.zip'], 12:21:01 INFO - u'cppunittest': [u'firefox-51.0.en-US.mac.common.tests.zip', 12:21:01 INFO - u'firefox-51.0.en-US.mac.cppunittest.tests.zip'], 12:21:01 INFO - u'gtest': [u'firefox-51.0.en-US.mac.common.tests.zip', 12:21:01 INFO - u'firefox-51.0.en-US.mac.gtest.tests.zip'], 12:21:01 INFO - u'jittest': [u'firefox-51.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 12:21:01 INFO - u'mochitest': [u'firefox-51.0.en-US.mac.common.tests.zip', 12:21:01 INFO - u'firefox-51.0.en-US.mac.mochitest.tests.zip'], 12:21:01 INFO - u'mozbase': [u'firefox-51.0.en-US.mac.common.tests.zip'], 12:21:01 INFO - u'reftest': [u'firefox-51.0.en-US.mac.common.tests.zip', 12:21:01 INFO - u'firefox-51.0.en-US.mac.reftest.tests.zip'], 12:21:01 INFO - u'talos': [u'firefox-51.0.en-US.mac.common.tests.zip', 12:21:01 INFO - u'firefox-51.0.en-US.mac.talos.tests.zip'], 12:21:01 INFO - u'web-platform': [u'firefox-51.0.en-US.mac.common.tests.zip', 12:21:01 INFO - u'firefox-51.0.en-US.mac.web-platform.tests.zip'], 12:21:01 INFO - u'xpcshell': [u'firefox-51.0.en-US.mac.common.tests.zip', 12:21:01 INFO - u'firefox-51.0.en-US.mac.xpcshell.tests.zip']} 12:21:01 INFO - Downloading packages: [u'firefox-51.0.en-US.mac.common.tests.zip'] for test suite category: common 12:21:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IwhJdfYOTniFWpjGgcwpMQ/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip 12:21:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IwhJdfYOTniFWpjGgcwpMQ/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip'}, attempt #1 12:21:01 INFO - Fetch https://queue.taskcluster.net/v1/task/IwhJdfYOTniFWpjGgcwpMQ/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip into memory 12:21:01 INFO - Expected file size: 16231342 12:21:08 INFO - Downloading packages: [u'firefox-51.0.en-US.mac.common.tests.zip', u'firefox-51.0.en-US.mac.talos.tests.zip'] for test suite category: talos 12:21:08 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IwhJdfYOTniFWpjGgcwpMQ/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip 12:21:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IwhJdfYOTniFWpjGgcwpMQ/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip'}, attempt #1 12:21:08 INFO - Fetch https://queue.taskcluster.net/v1/task/IwhJdfYOTniFWpjGgcwpMQ/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip into memory 12:21:09 INFO - Expected file size: 16231342 12:21:15 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IwhJdfYOTniFWpjGgcwpMQ/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip 12:21:15 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IwhJdfYOTniFWpjGgcwpMQ/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip'}, attempt #1 12:21:15 INFO - Fetch https://queue.taskcluster.net/v1/task/IwhJdfYOTniFWpjGgcwpMQ/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip into memory 12:21:16 INFO - Expected file size: 14414089 12:21:17 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')]} 12:21:17 INFO - trying https://queue.taskcluster.net/v1/task/IwhJdfYOTniFWpjGgcwpMQ/artifacts/public/build/firefox-51.0.en-US.mac.dmg 12:21:17 INFO - Downloading https://queue.taskcluster.net/v1/task/IwhJdfYOTniFWpjGgcwpMQ/artifacts/public/build/firefox-51.0.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0.en-US.mac.dmg 12:21:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IwhJdfYOTniFWpjGgcwpMQ/artifacts/public/build/firefox-51.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0.en-US.mac.dmg'}, attempt #1 12:21:19 INFO - Downloaded 86010818 bytes. 12:21:19 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/IwhJdfYOTniFWpjGgcwpMQ/artifacts/public/build/firefox-51.0.en-US.mac.dmg 12:21:19 INFO - mkdir: /builds/slave/test/properties 12:21:19 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:21:19 INFO - Writing to file /builds/slave/test/properties/build_url 12:21:19 INFO - Contents: 12:21:19 INFO - build_url:https://queue.taskcluster.net/v1/task/IwhJdfYOTniFWpjGgcwpMQ/artifacts/public/build/firefox-51.0.en-US.mac.dmg 12:21:20 INFO - Running post-action listener: _resource_record_post_action 12:21:20 INFO - Running post-action listener: set_extra_try_arguments 12:21:20 INFO - [mozharness: 2016-11-14 20:21:20.469570Z] Finished download-and-extract step (success) 12:21:20 INFO - [mozharness: 2016-11-14 20:21:20.469668Z] Running populate-webroot step. 12:21:20 INFO - Running pre-action listener: _resource_record_pre_action 12:21:20 INFO - Running main action method: populate_webroot 12:21:20 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:21:20 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:21:20 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:21:20 INFO - '--tppagecycles', 12:21:20 INFO - '7'], 12:21:20 INFO - 'tests': ['tsvgm']}}, 12:21:20 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:21:20 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:21:20 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:21:20 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:21:20 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:21:20 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:21:20 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:21:20 INFO - 'talos_options': ['--disable-e10s'], 12:21:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:21:20 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:21:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:21:20 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:21:20 INFO - 'talos_options': ['--disable-e10s'], 12:21:20 INFO - 'tests': ['damp', 'tps']}, 12:21:20 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:21:20 INFO - 'tests': ['damp', 'tps']}, 12:21:20 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:21:20 INFO - 'tests': ['dromaeo_dom']}, 12:21:20 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:21:20 INFO - 'g4': {'talos_options': ['--disable-e10s'], 12:21:20 INFO - 'tests': ['basic_compositor_video']}, 12:21:20 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 12:21:20 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:21:20 INFO - 'tests': ['a11yr', 12:21:20 INFO - 'ts_paint', 12:21:20 INFO - 'tpaint', 12:21:20 INFO - 'sessionrestore', 12:21:20 INFO - 'sessionrestore_no_auto_restore', 12:21:20 INFO - 'tabpaint']}, 12:21:20 INFO - 'other-e10s': {'tests': ['a11yr', 12:21:20 INFO - 'ts_paint', 12:21:20 INFO - 'tpaint', 12:21:20 INFO - 'sessionrestore', 12:21:20 INFO - 'sessionrestore_no_auto_restore', 12:21:20 INFO - 'tabpaint']}, 12:21:20 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:21:20 INFO - 'ts_paint', 12:21:20 INFO - 'tpaint', 12:21:20 INFO - 'sessionrestore', 12:21:20 INFO - 'sessionrestore_no_auto_restore', 12:21:20 INFO - 'tabpaint']}, 12:21:20 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:21:20 INFO - 'ts_paint', 12:21:20 INFO - 'tpaint', 12:21:20 INFO - 'sessionrestore', 12:21:20 INFO - 'sessionrestore_no_auto_restore', 12:21:20 INFO - 'tabpaint']}, 12:21:20 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:21:20 INFO - 'tests': ['a11yr', 12:21:20 INFO - 'ts_paint', 12:21:20 INFO - 'tpaint', 12:21:20 INFO - 'sessionrestore', 12:21:20 INFO - 'sessionrestore_no_auto_restore', 12:21:20 INFO - 'tabpaint']}, 12:21:20 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:21:20 INFO - 'tests': ['a11yr', 12:21:20 INFO - 'ts_paint', 12:21:20 INFO - 'tpaint', 12:21:20 INFO - 'sessionrestore', 12:21:20 INFO - 'sessionrestore_no_auto_restore', 12:21:20 INFO - 'tabpaint']}, 12:21:20 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:21:20 INFO - 'tests': ['tsvgx', 12:21:20 INFO - 'tsvgr_opacity', 12:21:20 INFO - 'tart', 12:21:20 INFO - 'tscrollx', 12:21:20 INFO - 'cart']}, 12:21:20 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:21:20 INFO - 'tsvgr_opacity', 12:21:20 INFO - 'tart', 12:21:20 INFO - 'tscrollx', 12:21:20 INFO - 'cart']}, 12:21:20 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:21:20 INFO - 'talos_options': ['--disable-e10s'], 12:21:20 INFO - 'tests': ['tp5o']}, 12:21:20 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:21:20 INFO - 'tests': ['tp5o']}, 12:21:20 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:21:20 INFO - 'talos_options': ['--disable-e10s', 12:21:20 INFO - '--xperf_path', 12:21:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:21:20 INFO - 'tests': ['tp5n']}, 12:21:20 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:21:20 INFO - 'talos_options': ['--xperf_path', 12:21:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:21:20 INFO - 'tests': ['tp5n']}}, 12:21:20 INFO - 'talos.zip': {'path': '', 12:21:20 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:21:20 INFO - Running post-action listener: _resource_record_post_action 12:21:20 INFO - [mozharness: 2016-11-14 20:21:20.488434Z] Finished populate-webroot step (success) 12:21:20 INFO - [mozharness: 2016-11-14 20:21:20.488543Z] Running create-virtualenv step. 12:21:20 INFO - Running pre-action listener: _resource_record_pre_action 12:21:20 INFO - Running main action method: create_virtualenv 12:21:20 INFO - Creating virtualenv /builds/slave/test/build/venv 12:21:20 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 12:21:20 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:21:20 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:21:20 INFO - Using real prefix '/tools/python27' 12:21:20 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:21:21 INFO - Installing distribute.............................................................................................................................................................................................done. 12:21:24 INFO - Installing pip.................done. 12:21:24 INFO - Return code: 0 12:21:24 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:21:24 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')]} 12:21:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:21:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:21:24 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')]} 12:21:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:21:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:21:24 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 0x1041f2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104168570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fabf1598c60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104006d30>, '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 0x103e6cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103ffeb20>, '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.Y37dyXiUSe/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.rUdauvgPtK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/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 12:21:24 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 12:21:24 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 12:21:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Y37dyXiUSe/Render', 12:21:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:21:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:21:24 INFO - 'HOME': '/Users/cltbld', 12:21:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:21:24 INFO - 'LOGNAME': 'cltbld', 12:21:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:21:24 INFO - 'MOZ_NO_REMOTE': '1', 12:21:24 INFO - 'NO_EM_RESTART': '1', 12:21:24 INFO - 'PAGER': '/bin/cat', 12:21:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:21:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:21:24 INFO - 'PWD': '/builds/slave/test', 12:21:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:21:24 INFO - 'SHELL': '/bin/bash', 12:21:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rUdauvgPtK/Listeners', 12:21:24 INFO - 'TMPDIR': '/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/', 12:21:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:21:24 INFO - 'USER': 'cltbld', 12:21:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:21:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:21:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:21:24 INFO - 'XPC_FLAGS': '0x0', 12:21:24 INFO - 'XPC_SERVICE_NAME': '0', 12:21:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:21:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:21:24 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 12:21:24 INFO - Cleaning up... 12:21:24 INFO - Return code: 0 12:21:24 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:21:24 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')]} 12:21:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:21:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:21:24 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')]} 12:21:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:21:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:21:24 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 0x1041f2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104168570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fabf1598c60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104006d30>, '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 0x103e6cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103ffeb20>, '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.Y37dyXiUSe/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.rUdauvgPtK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/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 12:21:24 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 12:21:24 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 12:21:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Y37dyXiUSe/Render', 12:21:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:21:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:21:24 INFO - 'HOME': '/Users/cltbld', 12:21:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:21:24 INFO - 'LOGNAME': 'cltbld', 12:21:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:21:24 INFO - 'MOZ_NO_REMOTE': '1', 12:21:24 INFO - 'NO_EM_RESTART': '1', 12:21:24 INFO - 'PAGER': '/bin/cat', 12:21:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:21:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:21:24 INFO - 'PWD': '/builds/slave/test', 12:21:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:21:24 INFO - 'SHELL': '/bin/bash', 12:21:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rUdauvgPtK/Listeners', 12:21:24 INFO - 'TMPDIR': '/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/', 12:21:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:21:24 INFO - 'USER': 'cltbld', 12:21:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:21:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:21:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:21:24 INFO - 'XPC_FLAGS': '0x0', 12:21:24 INFO - 'XPC_SERVICE_NAME': '0', 12:21:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:21:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:21:24 INFO - Downloading/unpacking psutil>=3.1.1 12:21:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:21:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:21:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:21:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:21:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:21:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:21:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:21:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:21:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:21:27 INFO - Installing collected packages: psutil 12:21:27 INFO - Running setup.py install for psutil 12:21:27 INFO - building 'psutil._psutil_osx' extension 12:21:27 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 12:21:28 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 12:21:28 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 12:21:28 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 12:21:28 INFO - building 'psutil._psutil_posix' extension 12:21:28 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 12:21:28 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 12:21:28 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 12:21:28 INFO - ^ 12:21:28 INFO - 1 warning generated. 12:21:28 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 12:21:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:21:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:21:28 INFO - Successfully installed psutil 12:21:28 INFO - Cleaning up... 12:21:28 INFO - Return code: 0 12:21:28 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:21:28 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')]} 12:21:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:21:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:21:28 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')]} 12:21:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:21:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:21:28 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 0x1041f2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104168570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fabf1598c60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104006d30>, '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 0x103e6cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103ffeb20>, '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.Y37dyXiUSe/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.rUdauvgPtK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/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 12:21:28 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 12:21:28 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 12:21:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Y37dyXiUSe/Render', 12:21:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:21:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:21:28 INFO - 'HOME': '/Users/cltbld', 12:21:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:21:28 INFO - 'LOGNAME': 'cltbld', 12:21:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:21:28 INFO - 'MOZ_NO_REMOTE': '1', 12:21:28 INFO - 'NO_EM_RESTART': '1', 12:21:28 INFO - 'PAGER': '/bin/cat', 12:21:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:21:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:21:28 INFO - 'PWD': '/builds/slave/test', 12:21:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:21:28 INFO - 'SHELL': '/bin/bash', 12:21:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rUdauvgPtK/Listeners', 12:21:28 INFO - 'TMPDIR': '/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/', 12:21:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:21:28 INFO - 'USER': 'cltbld', 12:21:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:21:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:21:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:21:28 INFO - 'XPC_FLAGS': '0x0', 12:21:28 INFO - 'XPC_SERVICE_NAME': '0', 12:21:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:21:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:21:28 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:21:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:21:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:21:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:21:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:21:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:21:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:21:31 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:21:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:21:31 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:21:31 INFO - Installing collected packages: mozsystemmonitor 12:21:31 INFO - Running setup.py install for mozsystemmonitor 12:21:31 INFO - Successfully installed mozsystemmonitor 12:21:31 INFO - Cleaning up... 12:21:31 INFO - Return code: 0 12:21:31 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:21:31 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')]} 12:21:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:21:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:21:31 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')]} 12:21:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:21:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:21:31 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 0x1041f2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104168570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fabf1598c60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104006d30>, '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 0x103e6cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103ffeb20>, '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.Y37dyXiUSe/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.rUdauvgPtK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/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 12:21:31 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 12:21:31 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 12:21:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Y37dyXiUSe/Render', 12:21:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:21:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:21:31 INFO - 'HOME': '/Users/cltbld', 12:21:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:21:31 INFO - 'LOGNAME': 'cltbld', 12:21:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:21:31 INFO - 'MOZ_NO_REMOTE': '1', 12:21:31 INFO - 'NO_EM_RESTART': '1', 12:21:31 INFO - 'PAGER': '/bin/cat', 12:21:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:21:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:21:31 INFO - 'PWD': '/builds/slave/test', 12:21:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:21:31 INFO - 'SHELL': '/bin/bash', 12:21:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rUdauvgPtK/Listeners', 12:21:31 INFO - 'TMPDIR': '/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/', 12:21:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:21:31 INFO - 'USER': 'cltbld', 12:21:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:21:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:21:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:21:31 INFO - 'XPC_FLAGS': '0x0', 12:21:31 INFO - 'XPC_SERVICE_NAME': '0', 12:21:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:21:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:21:31 INFO - Downloading/unpacking jsonschema==2.5.1 12:21:31 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 12:21:31 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 12:21:31 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 12:21:31 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 12:21:31 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 12:21:31 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 12:21:34 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:21:34 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:21:34 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 12:21:34 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 12:21:34 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 12:21:34 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 12:21:34 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 12:21:34 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 12:21:34 INFO - Downloading functools32-3.2.3-2.tar.gz 12:21:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:21:35 INFO - warning: no files found matching '*.txt' 12:21:35 INFO - no previously-included directories found matching 'build' 12:21:35 INFO - no previously-included directories found matching 'dist' 12:21:35 INFO - no previously-included directories found matching '.git*' 12:21:35 INFO - Installing collected packages: jsonschema, functools32 12:21:35 INFO - Running setup.py install for functools32 12:21:35 INFO - warning: no files found matching '*.txt' 12:21:35 INFO - no previously-included directories found matching 'build' 12:21:35 INFO - no previously-included directories found matching 'dist' 12:21:35 INFO - no previously-included directories found matching '.git*' 12:21:35 INFO - Successfully installed jsonschema functools32 12:21:35 INFO - Cleaning up... 12:21:35 INFO - Return code: 0 12:21:35 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 12:21:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:21:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:21:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:21:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:21:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:21:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:21:35 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 0x1041f2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104168570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fabf1598c60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104006d30>, '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 0x103e6cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103ffeb20>, '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.Y37dyXiUSe/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.rUdauvgPtK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/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 12:21:35 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 12:21:35 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 12:21:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Y37dyXiUSe/Render', 12:21:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:21:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:21:35 INFO - 'HOME': '/Users/cltbld', 12:21:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:21:35 INFO - 'LOGNAME': 'cltbld', 12:21:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:21:35 INFO - 'MOZ_NO_REMOTE': '1', 12:21:35 INFO - 'NO_EM_RESTART': '1', 12:21:35 INFO - 'PAGER': '/bin/cat', 12:21:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:21:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:21:35 INFO - 'PWD': '/builds/slave/test', 12:21:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:21:35 INFO - 'SHELL': '/bin/bash', 12:21:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rUdauvgPtK/Listeners', 12:21:35 INFO - 'TMPDIR': '/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/', 12:21:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:21:35 INFO - 'USER': 'cltbld', 12:21:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:21:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:21:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:21:35 INFO - 'XPC_FLAGS': '0x0', 12:21:35 INFO - 'XPC_SERVICE_NAME': '0', 12:21:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:21:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:21:35 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 12:21:35 INFO - Cleaning up... 12:21:35 INFO - Return code: 0 12:21:35 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:21:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:21:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:21:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:21:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:21:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:21:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:21:35 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 0x1041f2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104168570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fabf1598c60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104006d30>, '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 0x103e6cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103ffeb20>, '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.Y37dyXiUSe/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.rUdauvgPtK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/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 12:21:35 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 12:21:35 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 12:21:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Y37dyXiUSe/Render', 12:21:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:21:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:21:35 INFO - 'HOME': '/Users/cltbld', 12:21:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:21:35 INFO - 'LOGNAME': 'cltbld', 12:21:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:21:35 INFO - 'MOZ_NO_REMOTE': '1', 12:21:35 INFO - 'NO_EM_RESTART': '1', 12:21:35 INFO - 'PAGER': '/bin/cat', 12:21:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:21:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:21:35 INFO - 'PWD': '/builds/slave/test', 12:21:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:21:35 INFO - 'SHELL': '/bin/bash', 12:21:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rUdauvgPtK/Listeners', 12:21:35 INFO - 'TMPDIR': '/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/', 12:21:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:21:35 INFO - 'USER': 'cltbld', 12:21:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:21:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:21:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:21:35 INFO - 'XPC_FLAGS': '0x0', 12:21:35 INFO - 'XPC_SERVICE_NAME': '0', 12:21:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:21:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:21:35 INFO - Downloading/unpacking blobuploader==1.2.4 12:21:35 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 12:21:35 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 12:21:35 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 12:21:35 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 12:21:35 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 12:21:35 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 12:21:38 INFO - Downloading blobuploader-1.2.4.tar.gz 12:21:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:21:38 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:21:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:21:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:21:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:21:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:21:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:21:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:21:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:21:39 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:21:39 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 12:21:39 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 12:21:39 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 12:21:39 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 12:21:39 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 12:21:39 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 12:21:39 INFO - Downloading docopt-0.6.1.tar.gz 12:21:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:21:39 INFO - Installing collected packages: blobuploader, requests, docopt 12:21:39 INFO - Running setup.py install for blobuploader 12:21:39 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:21:39 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:21:39 INFO - Running setup.py install for requests 12:21:40 INFO - Running setup.py install for docopt 12:21:40 INFO - Successfully installed blobuploader requests docopt 12:21:40 INFO - Cleaning up... 12:21:40 INFO - Return code: 0 12:21:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:21:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:21:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:21:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:21:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:21:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:21:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:21:40 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 0x1041f2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104168570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fabf1598c60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104006d30>, '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 0x103e6cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103ffeb20>, '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.Y37dyXiUSe/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.rUdauvgPtK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/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 12:21:40 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 12:21:40 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 12:21:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Y37dyXiUSe/Render', 12:21:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:21:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:21:40 INFO - 'HOME': '/Users/cltbld', 12:21:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:21:40 INFO - 'LOGNAME': 'cltbld', 12:21:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:21:40 INFO - 'MOZ_NO_REMOTE': '1', 12:21:40 INFO - 'NO_EM_RESTART': '1', 12:21:40 INFO - 'PAGER': '/bin/cat', 12:21:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:21:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:21:40 INFO - 'PWD': '/builds/slave/test', 12:21:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:21:40 INFO - 'SHELL': '/bin/bash', 12:21:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rUdauvgPtK/Listeners', 12:21:40 INFO - 'TMPDIR': '/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/', 12:21:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:21:40 INFO - 'USER': 'cltbld', 12:21:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:21:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:21:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:21:40 INFO - 'XPC_FLAGS': '0x0', 12:21:40 INFO - 'XPC_SERVICE_NAME': '0', 12:21:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:21:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:21:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:21:40 INFO - Running setup.py (path:/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/pip-50ovPz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:21:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:21:41 INFO - Running setup.py (path:/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/pip-eWLzmv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:21:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:21:41 INFO - Running setup.py (path:/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/pip-laK3rk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:21:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:21:41 INFO - Running setup.py (path:/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/pip-OfIVLa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:21:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:21:41 INFO - Running setup.py (path:/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/pip-3F2F6A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:21:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:21:41 INFO - Running setup.py (path:/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/pip-BiRLl9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:21:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:21:41 INFO - Running setup.py (path:/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/pip-ADX8aM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:21:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:21:41 INFO - Running setup.py (path:/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/pip-CWviB5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:21:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:21:41 INFO - Running setup.py (path:/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/pip-j5e9wJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:21:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:21:41 INFO - Running setup.py (path:/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/pip-hvm2Jl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:21:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:21:41 INFO - Running setup.py (path:/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/pip-PdDBeq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:21:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:21:42 INFO - Running setup.py (path:/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/pip-6UYqg2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:21:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:21:42 INFO - Running setup.py (path:/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/pip-6GvGKF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:21:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:21:42 INFO - Running setup.py (path:/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/pip-9yyMbU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:21:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:21:42 INFO - Running setup.py (path:/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/pip-KhRMsC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:21:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:21:42 INFO - Running setup.py (path:/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/pip-LaoiGk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:21:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:21:42 INFO - Running setup.py (path:/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/pip-nhpwxP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:21:42 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:21:42 INFO - Running setup.py install for manifestparser 12:21:42 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:21:42 INFO - Running setup.py install for mozcrash 12:21:43 INFO - Running setup.py install for mozdebug 12:21:43 INFO - Running setup.py install for mozdevice 12:21:43 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:21:43 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:21:43 INFO - Running setup.py install for mozfile 12:21:43 INFO - Running setup.py install for mozhttpd 12:21:43 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:21:43 INFO - Running setup.py install for mozinfo 12:21:43 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:21:43 INFO - Running setup.py install for mozInstall 12:21:43 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:21:43 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:21:43 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:21:43 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:21:43 INFO - Running setup.py install for mozleak 12:21:44 INFO - Running setup.py install for mozlog 12:21:44 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:21:44 INFO - Running setup.py install for moznetwork 12:21:44 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:21:44 INFO - Running setup.py install for mozprocess 12:21:44 INFO - Running setup.py install for mozprofile 12:21:44 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:21:44 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:21:44 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:21:44 INFO - Running setup.py install for mozrunner 12:21:44 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:21:44 INFO - Running setup.py install for mozscreenshot 12:21:45 INFO - Running setup.py install for moztest 12:21:45 INFO - Running setup.py install for mozversion 12:21:45 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:21:45 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:21:45 INFO - Cleaning up... 12:21:45 INFO - Return code: 0 12:21:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:21:45 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')]} 12:21:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:21:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:21:45 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')]} 12:21:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:21:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:21:45 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 0x1041f2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104168570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fabf1598c60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104006d30>, '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 0x103e6cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103ffeb20>, '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.Y37dyXiUSe/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.rUdauvgPtK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/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 12:21:45 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 12:21:45 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 12:21:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Y37dyXiUSe/Render', 12:21:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:21:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:21:45 INFO - 'HOME': '/Users/cltbld', 12:21:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:21:45 INFO - 'LOGNAME': 'cltbld', 12:21:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:21:45 INFO - 'MOZ_NO_REMOTE': '1', 12:21:45 INFO - 'NO_EM_RESTART': '1', 12:21:45 INFO - 'PAGER': '/bin/cat', 12:21:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:21:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:21:45 INFO - 'PWD': '/builds/slave/test', 12:21:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:21:45 INFO - 'SHELL': '/bin/bash', 12:21:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rUdauvgPtK/Listeners', 12:21:45 INFO - 'TMPDIR': '/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/', 12:21:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:21:45 INFO - 'USER': 'cltbld', 12:21:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:21:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:21:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:21:45 INFO - 'XPC_FLAGS': '0x0', 12:21:45 INFO - 'XPC_SERVICE_NAME': '0', 12:21:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:21:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:21:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:21:45 INFO - Running setup.py (path:/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/pip-KP0HB5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:21:45 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)) 12:21:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:21:45 INFO - Running setup.py (path:/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/pip-zvlW7V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:21:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 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)) 12:21:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:21:45 INFO - Running setup.py (path:/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/pip-DAqLu4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:21:45 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)) 12:21:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:21:45 INFO - Running setup.py (path:/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/pip-DqFPZQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:21:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 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)) 12:21:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:21:46 INFO - Running setup.py (path:/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/pip-NpGoPb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:21:46 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)) 12:21:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:21:46 INFO - Running setup.py (path:/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/pip-KsMmVQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:21:46 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)) 12:21:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:21:46 INFO - Running setup.py (path:/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/pip-eFBVel-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:21:46 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)) 12:21:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:21:46 INFO - Running setup.py (path:/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/pip-kcEIZE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:21:46 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)) 12:21:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:21:46 INFO - Running setup.py (path:/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/pip-C35YVG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:21:46 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)) 12:21:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:21:46 INFO - Running setup.py (path:/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/pip-UejJqV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:21:46 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)) 12:21:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:21:46 INFO - Running setup.py (path:/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/pip-IG5_0K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:21:46 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)) 12:21:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:21:46 INFO - Running setup.py (path:/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/pip-NYcEhJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:21:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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)) 12:21:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:21:46 INFO - Running setup.py (path:/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/pip-TZekQS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:21:47 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)) 12:21:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:21:47 INFO - Running setup.py (path:/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/pip-97h19d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:21:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 12:21:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:21:47 INFO - Running setup.py (path:/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/pip-0yPOxe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:21:47 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)) 12:21:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:21:47 INFO - Running setup.py (path:/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/pip-r06gNi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:21:47 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 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)) 12:21:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:21:47 INFO - Running setup.py (path:/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/pip-bIzF4_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:21:47 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)) 12:21:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 12:21:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 12:21:47 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)) 12:21:47 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:21:47 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:21:47 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:21:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:21:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:21:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:21:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:21:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:21:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:21:49 INFO - Downloading blessings-1.6.tar.gz 12:21:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:21:50 INFO - Installing collected packages: blessings 12:21:50 INFO - Running setup.py install for blessings 12:21:50 INFO - Successfully installed blessings 12:21:50 INFO - Cleaning up... 12:21:50 INFO - Return code: 0 12:21:50 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:21:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:21:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:21:50 INFO - Reading from file tmpfile_stdout 12:21:50 INFO - Current package versions: 12:21:50 INFO - blessings == 1.6 12:21:50 INFO - blobuploader == 1.2.4 12:21:50 INFO - docopt == 0.6.1 12:21:50 INFO - functools32 == 3.2.3-2 12:21:50 INFO - jsonschema == 2.5.1 12:21:50 INFO - manifestparser == 1.1 12:21:50 INFO - mozInstall == 1.12 12:21:50 INFO - mozcrash == 0.17 12:21:50 INFO - mozdebug == 0.1 12:21:50 INFO - mozdevice == 0.48 12:21:50 INFO - mozfile == 1.2 12:21:50 INFO - mozhttpd == 0.7 12:21:50 INFO - mozinfo == 0.9 12:21:50 INFO - mozleak == 0.1 12:21:50 INFO - mozlog == 3.4 12:21:50 INFO - moznetwork == 0.27 12:21:50 INFO - mozprocess == 0.23 12:21:50 INFO - mozprofile == 0.28 12:21:50 INFO - mozrunner == 6.12 12:21:50 INFO - mozscreenshot == 0.1 12:21:50 INFO - mozsystemmonitor == 0.3 12:21:50 INFO - moztest == 0.7 12:21:50 INFO - mozversion == 1.4 12:21:50 INFO - psutil == 3.1.1 12:21:50 INFO - requests == 1.2.3 12:21:50 INFO - wsgiref == 0.1.2 12:21:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:21: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')]} 12:21:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:21:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:21: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')]} 12:21:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:21:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:21:50 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 0x1041f2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104168570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fabf1598c60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104006d30>, '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 0x103e6cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103ffeb20>, '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.Y37dyXiUSe/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.rUdauvgPtK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/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 12:21:50 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 12:21:50 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 12:21:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Y37dyXiUSe/Render', 12:21:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:21:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:21:50 INFO - 'HOME': '/Users/cltbld', 12:21:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:21:50 INFO - 'LOGNAME': 'cltbld', 12:21:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:21:50 INFO - 'MOZ_NO_REMOTE': '1', 12:21:50 INFO - 'NO_EM_RESTART': '1', 12:21:50 INFO - 'PAGER': '/bin/cat', 12:21:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:21:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:21:50 INFO - 'PWD': '/builds/slave/test', 12:21:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:21:50 INFO - 'SHELL': '/bin/bash', 12:21:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rUdauvgPtK/Listeners', 12:21:50 INFO - 'TMPDIR': '/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/', 12:21:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:21:50 INFO - 'USER': 'cltbld', 12:21:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:21:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:21:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:21:50 INFO - 'XPC_FLAGS': '0x0', 12:21:50 INFO - 'XPC_SERVICE_NAME': '0', 12:21:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:21:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:21:50 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)) 12:21:50 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)) 12:21:50 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)) 12:21:50 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)) 12:21:50 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)) 12:21:50 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)) 12:21:50 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)) 12:21:50 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)) 12:21:50 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)) 12:21:50 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)) 12:21:50 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)) 12:21:50 INFO - Cleaning up... 12:21:50 INFO - Return code: 0 12:21:50 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:21: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')]} 12:21:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:21:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:21: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')]} 12:21:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:21:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:21:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1041f2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104168570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fabf1598c60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104006d30>, '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 0x103e6cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103ffeb20>, '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.Y37dyXiUSe/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.rUdauvgPtK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/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 12:21:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 12:21:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 12:21:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Y37dyXiUSe/Render', 12:21:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:21:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:21:50 INFO - 'HOME': '/Users/cltbld', 12:21:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:21:50 INFO - 'LOGNAME': 'cltbld', 12:21:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:21:50 INFO - 'MOZ_NO_REMOTE': '1', 12:21:50 INFO - 'NO_EM_RESTART': '1', 12:21:50 INFO - 'PAGER': '/bin/cat', 12:21:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:21:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:21:50 INFO - 'PWD': '/builds/slave/test', 12:21:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:21:50 INFO - 'SHELL': '/bin/bash', 12:21:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rUdauvgPtK/Listeners', 12:21:50 INFO - 'TMPDIR': '/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/', 12:21:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:21:50 INFO - 'USER': 'cltbld', 12:21:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:21:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:21:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:21:50 INFO - 'XPC_FLAGS': '0x0', 12:21:50 INFO - 'XPC_SERVICE_NAME': '0', 12:21:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:21:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:21:51 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:21:51 INFO - Cleaning up... 12:21:51 INFO - Return code: 0 12:21:51 INFO - Running post-action listener: _resource_record_post_action 12:21:51 INFO - Running post-action listener: _start_resource_monitoring 12:21:51 INFO - Starting resource monitoring. 12:21:51 INFO - [mozharness: 2016-11-14 20:21:51.104225Z] Finished create-virtualenv step (success) 12:21:51 INFO - [mozharness: 2016-11-14 20:21:51.105222Z] Running install step. 12:21:51 INFO - Running pre-action listener: _resource_record_pre_action 12:21:51 INFO - Running main action method: install 12:21:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:21:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:21:51 INFO - Reading from file tmpfile_stdout 12:21:51 INFO - Detecting whether we're running mozinstall >=1.0... 12:21:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:21:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:21:51 INFO - Reading from file tmpfile_stdout 12:21:51 INFO - Output received: 12:21:51 INFO - Usage: mozinstall [options] installer 12:21:51 INFO - Options: 12:21:51 INFO - -h, --help show this help message and exit 12:21:51 INFO - -d DEST, --destination=DEST 12:21:51 INFO - Directory to install application into. [default: 12:21:51 INFO - "/builds/slave/test"] 12:21:51 INFO - --app=APP Application being installed. [default: firefox] 12:21:51 INFO - mkdir: /builds/slave/test/build/application 12:21:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 12:21:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0.en-US.mac.dmg --destination /builds/slave/test/build/application 12:22:13 INFO - Reading from file tmpfile_stdout 12:22:13 INFO - Output received: 12:22:13 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 12:22:13 INFO - Running post-action listener: _resource_record_post_action 12:22:13 INFO - [mozharness: 2016-11-14 20:22:13.179459Z] Finished install step (success) 12:22:13 INFO - [mozharness: 2016-11-14 20:22:13.179607Z] Running run-tests step. 12:22:13 INFO - Running pre-action listener: _resource_record_pre_action 12:22:13 INFO - Running main action method: run_tests 12:22:13 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:22:13 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:22:13 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:22:13 INFO - 2016-11-14 12:22:13.194 screenresolution[1995:277282] starting screenresolution argv=screenresolution get 12:22:13 INFO - 2016-11-14 12:22:13.197 screenresolution[1995:277282] Display 0: 1600x1200x32@60 12:22:13 INFO - 2016-11-14 12:22:13.203 screenresolution[1996:277285] starting screenresolution argv=screenresolution list 12:22:13 INFO - Available Modes on Display 0 12:22:13 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:22:13 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:22:13 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:22:13 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:22:13 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:22:13 INFO - Intel Iris: 12:22:13 INFO - Chipset Model: Intel Iris 12:22:13 INFO - Type: GPU 12:22:13 INFO - Bus: Built-In 12:22:13 INFO - VRAM (Dynamic, Max): 1536 MB 12:22:13 INFO - Vendor: Intel (0x8086) 12:22:13 INFO - Device ID: 0x0a2e 12:22:13 INFO - Revision ID: 0x0009 12:22:13 INFO - Displays: 12:22:13 INFO - Display: 12:22:13 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:22:13 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:22:13 INFO - Display Serial Number: 1600x1200 60 12:22:13 INFO - Main Display: Yes 12:22:13 INFO - Mirror: Off 12:22:13 INFO - Online: Yes 12:22:13 INFO - Rotation: Supported 12:22:13 INFO - Return code: 0 12:22:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:22:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:22:13 INFO - Python 2.7.3 12:22:13 INFO - Return code: 0 12:22:13 INFO - grabbing minidump binary from tooltool 12:22: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')]} 12:22:13 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 0x104006d30>, '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 0x103e6cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103ffeb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:22:13 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 12:22:13 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 12:22:13 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 12:22:13 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:22:13 INFO - Return code: 0 12:22:13 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 12:22:13 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:22:13 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:22:13 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 12:22:13 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:22:13 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/IwhJdfYOTniFWpjGgcwpMQ/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0066', '--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 12:22:13 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/IwhJdfYOTniFWpjGgcwpMQ/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0066 --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 12:22:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Y37dyXiUSe/Render', 12:22:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:22:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:22:13 INFO - 'HOME': '/Users/cltbld', 12:22:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:22:13 INFO - 'LOGNAME': 'cltbld', 12:22:13 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:22:13 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 12:22:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:22:13 INFO - 'MOZ_NO_REMOTE': '1', 12:22:13 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:22:13 INFO - 'NO_EM_RESTART': '1', 12:22:13 INFO - 'PAGER': '/bin/cat', 12:22:13 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:22:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:22:13 INFO - 'PWD': '/builds/slave/test', 12:22:13 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:22:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:22:13 INFO - 'SHELL': '/bin/bash', 12:22:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rUdauvgPtK/Listeners', 12:22:13 INFO - 'TMPDIR': '/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/', 12:22:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:22:13 INFO - 'USER': 'cltbld', 12:22:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:22:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:22:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:22:13 INFO - 'XPC_FLAGS': '0x0', 12:22:13 INFO - 'XPC_SERVICE_NAME': '0', 12:22:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:22:13 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/IwhJdfYOTniFWpjGgcwpMQ/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0066', '--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 12:22:13 INFO - mozversion application_buildid: 20161114091743 12:22:13 INFO - mozversion application_changeset: fd3c6c15ec64591b145ab1b6dd71c5a2e7b8d9b1 12:22:13 INFO - mozversion application_display_name: Firefox 12:22:13 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:22:13 INFO - mozversion application_name: Firefox 12:22:13 INFO - mozversion application_remotingname: firefox 12:22:13 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 12:22:13 INFO - mozversion application_vendor: Mozilla 12:22:13 INFO - mozversion application_version: 51.0 12:22:13 INFO - mozversion platform_buildid: 20161114091743 12:22:13 INFO - mozversion platform_changeset: fd3c6c15ec64591b145ab1b6dd71c5a2e7b8d9b1 12:22:13 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 12:22:13 INFO - mozversion platform_version: 51.0 12:22:13 INFO - using testdate: 1479154933 12:22:13 INFO - actual date: 1479154933 12:22:13 INFO - starting webserver on 'localhost:49376' 12:22:13 INFO - SUITE-START | Running 2 tests 12:22:13 INFO - TEST-START | dromaeo_css 12:22:13 INFO - operating with platform_type : mac_ 12:22:13 INFO - Initialising browser for dromaeo_css test... 12:22:13 INFO - TEST-INFO | started process 2006 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/tmpq8wcnl/profile http://localhost:49376/getInfo.html) 12:22:16 INFO - PROCESS | 2006 | __metrics Screen width/height:1600/1200 12:22:16 INFO - PROCESS | 2006 | colorDepth:24 12:22:16 INFO - PROCESS | 2006 | Browser inner width/height: 1024/689 12:22:16 INFO - PROCESS | 2006 | __metrics 12:22:16 INFO - PROCESS | 2006 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 12:22:16 INFO - PROCESS | 2006 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:22:17 INFO - TEST-INFO | 2006: exit 0 12:22:17 INFO - Browser initialized. 12:22:17 INFO - Running cycle 1/1 for dromaeo_css test... 12:22:17 INFO - TEST-INFO | started process 2011 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/tmpq8wcnl/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:22:29 INFO - PROCESS | 2011 | RSS: Main: 168591360 12:22:29 INFO - PROCESS | 2011 | 12:23:20 INFO - PROCESS | 2011 | 1479155000772 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 12:25:30 INFO - PROCESS | 2011 | Cycle 1(1): loaded http://localhost:49376/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49376/tests/dromaeo/cssquery-ext.html) 12:25:32 INFO - PROCESS | 2011 | RSS: Main: 308658176 12:25:32 INFO - PROCESS | 2011 | 12:28:35 INFO - PROCESS | 2011 | Cycle 1(1): loaded http://localhost:49376/tests/dromaeo/cssquery-ext.html (next: http://localhost:49376/tests/dromaeo/cssquery-jquery.html) 12:28:35 INFO - PROCESS | 2011 | RSS: Main: 301404160 12:28:35 INFO - PROCESS | 2011 | 12:31:38 INFO - PROCESS | 2011 | Cycle 1(1): loaded http://localhost:49376/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49376/tests/dromaeo/cssquery-mootools.html) 12:31:38 INFO - PROCESS | 2011 | RSS: Main: 302637056 12:31:38 INFO - PROCESS | 2011 | 12:34:41 INFO - PROCESS | 2011 | Cycle 1(1): loaded http://localhost:49376/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49376/tests/dromaeo/cssquery-prototype.html) 12:34:41 INFO - PROCESS | 2011 | RSS: Main: 274550784 12:34:41 INFO - PROCESS | 2011 | 12:37:44 INFO - PROCESS | 2011 | Cycle 1(1): loaded http://localhost:49376/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49376/tests/dromaeo/cssquery-yui.html) 12:37:45 INFO - PROCESS | 2011 | RSS: Main: 261951488 12:37:45 INFO - PROCESS | 2011 | 12:40:48 INFO - PROCESS | 2011 | Cycle 1(1): loaded http://localhost:49376/tests/dromaeo/cssquery-yui.html (next: http://localhost:49376/tests/dromaeo/cssquery-dojo.html) 12:40:48 INFO - PROCESS | 2011 | RSS: Main: 329691136 12:40:48 INFO - PROCESS | 2011 | 12:40:48 INFO - PROCESS | 2011 | __start_tp_report 12:40:48 INFO - PROCESS | 2011 | _x_x_mozilla_page_load 12:40:48 INFO - PROCESS | 2011 | _x_x_mozilla_page_load_details 12:40:48 INFO - PROCESS | 2011 | |i|pagename|runs| 12:40:48 INFO - PROCESS | 2011 | |0;dojo.html;3434.536337594425;3441.810700411478;3477.1828620274246;3492.6158122606525;3520;5743.081107022877;5816.883662326751;5855.297364316278;5866.325372582154;5880.9411905880925;4735.242361222206;5837.532997360212;5854.3267524234725;5858.589898707092;5867.8533036674;5268.9473105268935;5334.146536554152;5346.171343441753;5371.409144994048;5384.703841288728;5257.316548848645;5270.39390470097;5425.782968681248;5427.1316589345715;5455.754491047893;5226.24219488174;5285.365756109253;5380.300560927074;5403.027455058108;5417;5328.014317351302;5345.973270133624;5347.903679745643;5365.248865158861;5408.4591540845995;5293.994141113215;5369.382521010056;5375.973120134413;5376.946230537684;5414.35027796663;5682;5724.570657200685;5748.942510574882;5925.644461332291;5929.555283353766;6213.285472170713;6256.280527739277;6278.497720182374;6347.365263473615;6352.555321127523;6297.685115744194;6346.30190679025;6351.079093531458;6352.968235158841;6367.968160159169;5802.448767367094;5888.175655408247;5893.086571581412;5905.911411328833;5910.290765108214;6276.843078923063;6335.968320158369;6337.081123237105;6369.904451433232;6372.585781924253;6275.748970041239;6276.592021518587;6280.340564240781;6282.874342513124;6287.811365659038;6297.244330680256;6306.716197771111;6351.936480635134;6376.7130479128555;6382.361763823674;6102.206713127265;6129.943220939371;6134.13617322964;6201.875962480815;6253.062040693932;6343.619382837044;6344.714487848058;6364.045393191059;6365.4589359904;6368.77709280173;5008.524190201925;5057.291979122926;5059.544640982329;5062.341895553554;5086.364204474441;4478.350639157304;4481.0365771358665;4491.595756381876;4527.7736113194205;4586.266197408466;5829.154772557956;5877.9118313225335;5905.320888097838;6005.819825405245;6019.127226552126;6296.33888441707;6335.018072198816;6344.111824344595;6349.6507692077375;6378.649174295459;5851.970740146272;5883.94089063964;5886.8822623547285;5890.469857712741;5925.762969481172;5427.267318911975;5469.863253418696;5472.863178420572;5474.479924407175;5488.588355873326;6469.870602587922;6477.546571739933;6482.319356467503;6484.837879052967;6491.091247225298;6327.96836015817;6333.493320534439;6337.081123237197;6346.048092786119;6355.968220158869;6258.655773932477;6287.685615719287;6317.4630156437215;6380.649064301508;6462.063000864754;6236.126942228182;6292.905606415816;6339.492840572835;6352.428281454691;6358.745650173942;6068.059450785136;6312.337204593451;6337.04944258365;6353.745850166127;6363.14097596837;6116.602420842631;6257.9687101564205;6301;6304.085907543472;6306.65313407767;6106.7862624809695;6173.938260617337;6175.907361389673;6214.5960512566535;6291.056341548804;6176.907346389898;6180.042093475518;6191.040388739752;6199.659018754011;6204.5036397089025;6205.720742566686;6227.657478838707;6247.875042499034;6275.592086514362;6279.466245369194;5946.137810017437;5977.462028417463;6014;6049;6072.635641861502 12:40:48 INFO - PROCESS | 2011 | |1;ext.html;497.2764627467036;498.9646483546642;536.9328833895762;540.3569751995126;566.4562020460357;32544;42622.57377426225;43797.12405751883;44049.55950440495;45760.77119614406;44692;45116.87207819806;45135.4202602909;45151.548484515144;45315.320270195974;9360.578773955154;10149.238807089461;10316.948415257913;10334.121599664;10345.844812327821;9300.023497532764;9589.808203835919;9596.95201523995;9628;12222.144449888512;12474.688132796708;12628.68428289291;12633.810492842615;12635.936820315885;12648.49406023758;12501.874981250208;12572.1199516033;12587.811182832265;12596;12606.747865042693;12423.689407764788;12497.812532812015;12502.74994500105;12528.185667931646;12531.43608537618;41651.58348416507;41834.58165418337;41881.95295117616;41897.581024189676;41941.370879436836;3403.8638454461793;3519.8064106474135;3678.301122786662;3882.514685664292;3992.7005474589523;32205.24938813399;32287.515687264477;32477.675223247938;32985.17537061569;33160;3316.4527852904243;3392.830358482066;3394.2702319001532;3430.879919202816;3446;475646;510645;544471.2776436132;548675;549237;61523.38476615266;61828;61948.38051619426;61997;62012.6591138616;36164.638353616654;36717;36781.26437471236;37609.435858462144;37701.24597508035;17855.928644281386;18026.188821503063;18037.368692095715;18060.458186254433;18076.005819680046;13653;13746.450141994408;13754;13812.654683632789;13829.723405531833;17479.951202927612;17803;17895;17922.193501292473;17943.461696149137;7188.748393806296;7350.301721336465;7992.681207600681;8007.439479236397;8079.747639115946;787.6376866641294;890.2744263425287;937.9953100234455;977.6773664690635;1002.5187909803335;30447.877294984373;31072;31115;31706.89025884083;31900.44796416281;971.358903123949;1001.244060734141;1157.2304417562395;1208.5951206345796;1248.1076030638137;15655.84344156544;16470.588235294214;16494.845360824867;16501.33994640201;16856;749262;753819;754915;759793;759816;60942.390576094556;61655;61715.38284617186;61891;62122.9999999991;1255.598208573266;1374.4296117111487;1423.1532238318184;1443.6390902274431;1452.382737336649;25547.36131596725;29995.550066749453;31207.219819504695;31914;31974.52038219382;52303.95392092213;52624.473755261955;52629.7368513155;52717.736411317695;52727.73636131795;621394;623287;623851;624076;634090;19173.424797256106;24861.751382486666;24873;27564.448711026067;27970.300742480787;39529;41568.792156039024;48563.75718121387;49393.75303123461;53235;40116.59883401245;40478;41716.791416042724;42481.66350850609;42547;40979.97550061272;41268.174636507705;41711.957201069;41997.79001104975;42381.94045148896;39274.214515708954;40137.19725605413;40410.1917961645;40564.985875353355;40581.39127913143;34788.47817282692;35720.464193037646;35957.820210898775;36355;36377.81811090928;25652;27133.86433067901;27373;27548.586771198046;27579.103738549147 12:40:48 INFO - PROCESS | 2011 | |2;jquery.html;350.7842676753796;376.12738446803394;386.85492940147446;395.86540576204084;405.42024904386733;16250.674986500262;17163.656726865454;19336;22572.43568910776;22767.54464910703;18276;21322.57354852902;22048.559028819414;22268.66597001042;22434.214802481918;5296.417394086648;5317.521423071923;5964.403559644023;5983.401659834025;6155.661438620874;6123.510119190454;6225.782097626584;6244.406781355764;6244.968775156118;6252.406021427957;5658.943410565883;5959.761609535613;6186.721597528122;6257.9361508543425;6272.404121608462;6153.476954458876;6232.3144454110015;6317.210348706411;6356.173697419329;6359.427651511386;6078.270607527081;6141.6007959482495;6145.3547377525165;6149.723262453155;6153.169322141498;13490.730185396236;13590.864091359059;13650.522231721841;13694.657633559142;13893.4442622295;2012.6477866373473;2186.278528085728;2204.9889750551147;2824.4915915135266;2934.3691106412225;9738.805223895553;10213.948930255376;10488.213383996232;10535.315204511682;10632.202584806171;1925.3068895197719;2004.7393838801008;2024.544477492567;2031.654618714822;2060.7527096748336;84303.40187511154;108766.45616771944;121090.39454802757;128914.71085289215;132122;11525.827112593317;11582.131340149523;11710.76578468426;11764.94117529424;11950.402479875971;14972.925135374253;14980;14983.850161498463;14992;15017.324220410108;8818.29453643707;8911.50986695738;8928;8928.955355223312;9041.321900857462;9006.819863602823;9030.051844556227;9049.230815380766;9208.539573021322;9212.30907681913;4387.42963414754;4601.723896566216;4625.560571745679;4638.141943740419;4671.481768425276;1622.505135933528;1674.4976507047836;1923.4806602217602;1927.6433859735994;1945.8929758863399;894.1550235027967;937.1331518345503;958.2717134977468;995.1690338567378;996.3971797062818;16853.325866965184;19864.205431782855;21429.89285053565;21917.561648767256;21956.341309760413;915.190056799737;925.6204955968021;955.3121752338305;975.0152346130459;989.248171389749;9293.349465537347;10888.836667449836;11387.715307117389;11513.078953683686;11516.827247591125;570109;613189;620993;624405;644743;138116.30941845226;143073;146077;146449;147024.38390272463;927.8422668146432;949.1457688080783;1012.4380968562518;1019.0115587879596;1024.5952848624752;16684.749728753835;18867.90566047161;19566.510837229183;20204;20259.898700506405;55741.16388254098;56655.30034098984;58530.707346462994;60362.39637603568;61440.38559614347;77622.61188694247;79393;80439.19560804551;81188;81570.59214703889;6298.811035668938;7687.154413014452;7931.920680793349;8069.556174410463;8272.710455134042;10854;13240.867591323964;13261.204327740366;13725.725485490433;13734.793978090136;11330.943345283551;11511.366874821964;11839.289642621126;11852.881471185177;11992.580259690869;11243.887561124611;11486.942565287454;11527.250728702607;11567.305961642329;11846.229995050295;11448.656540303804;11765.941170294094;11853.407329633656;11887.346195959306;12168.330741809286;7893.565853878092;7967.04395472547;8040.557769322743;8228.83542329138;8430.6206220719;8357.456765310235;10979.83530247031;11643.76712465729;11711.063114950613;11898.524059037542 12:40:48 INFO - PROCESS | 2011 | |3;mootools.html;1431.3630434456663;1487.509121989743;1728.8876223045509;1741.4514427955194;1927.787943326234;7280;9378.765530861723;9382.155605995458;9384.483853388061;9430.245580353572;8183.877241841377;8380;8939.329550283723;9025.774355641111;9093.181613654786;2411.6503107049466;2436.683231179944;2439.780419762221;2440.5606990741658;2448.2288079254977;2410.048031027743;2422.563938491071;2460.2127319257843;2462.91379801707;2468.6543883856275;2436.8294219404647;2443.535728211643;2454.8216855909086;2461.704595448549;2468.123816045305;2418.3591348292716;2420.745821688724;2427.927162185137;2428.295794219674;2445.6698345723457;2417.238569850509;2435.6711843901203;2441.4994926040117;2441.9145329913367;2478.1326535712537;9129.77175570616;9166.770830729218;9243.722688319362;9253.814923701555;9268.397554159026;5429.375621803503;5596.048671725816;5601.327840659147;5601.467860553241;5601.60788744788;3625.963740362589;3749.4000959846567;3820.36963900956;3861.4207868819904;3863.8454461821493;990.7869807991244;1065.4512925843196;1113.582406597526;1122.3939072900623;1143.6054561176381;12364.567240146642;12436.00511959041;12461.127721059529;12473.376331183405;12475.126741128124;3936.3111455495746;4743.028370299747;4750.524947505291;4794.065157294364;4923.818283611908;10529.262951593468;10530.05229529346;10530.631427899987;10532.789344213073;10553.366797992145;5503.559715222773;5510.0632892408385;5512.118061110203;5515.806946756844;5516.668999860021;4590.977045114753;4744.24092145262;4984.40187177541;5039.571636410873;5073.822416215415;3989.9601003989587;4042.7776472293717;4090.795460226977;4125.628693417547;4142.855000075043;1284.5247258514223;1295.378218455128;1298.3832679477173;1311.9737605247842;1313.3302015971924;810.4043528006911;882.4793371910475;910.9772255693529;913.6939125393068;930.1675000874179;5944.583879128506;5972.343042265347;6064.393560643988;6147.262328520606;6202.255729312511;927.5872236854535;954.0936110694868;968.7384406210284;972.5720682899642;1007.6725064354114;3756.1736417988;4006.399040144002;4060.5939406059156;4120.093579412584;4137.627613514798;11180.44097795107;11392;11520.423978801027;11563.76872462546;11565.595204167981;11444.313341199555;11447.54209831614;11449.255798373079;11459.656210313704;11472.94263528677;8286.212809783061;8593.914060859437;8606.397552171413;8607.311415086779;8759.693410730593;6019;6153.753849846135;6154.107654390178;6211.844703882439;6266.151485311935;10336.379817210991;10514.316569422963;10740.516676749721;10745.731356716145;10750.97865702757;10474.52864621109;10744.83882741744;10746.301490403099;10785.029347358775;10969;7247.927520724726;7415.740449084256;7776.766696999099;7801;7989.680412783424;8612.397132200686;8835.160659737314;8875.644974200959;8881.156290152425;8884.955575222082;7799.6100194988885;7864.803379915548;7911.920880791118;8039.316658084128;8057.879131813144;7649.847003059796;7741;7758.146603873456;7815.29662330393;7816.804579885548;7245.963770181115;7367.115946086504;7377.483576149618;7382;7388.298111679382;5056.57019153376;5092.898142037213;5125.205593133071;5242.292290540729;5383.81156659515;5125.461826508163;5187.936473023096;5281.128613778684;5366.973165134149;5429.755660995185 12:40:48 INFO - PROCESS | 2011 | |4;prototype.html;300.05781845006675;301.6274900497886;307.2962914924822;312.375249500998;313.7662441481097;4727.747147006046;4796.736179510125;5303.416624171338;5460.170842767672;5465.262189604402;4734.597559207472;5227.320448341719;5257.7108259045735;5532.972335138319;5543.447834606307;3422.9559984204807;3931.7247792654525;4152.653750630899;4238.57614238576;4256.489221293449;3353.8658453661824;3632;3677.9448308275396;3886.417037444378;4131.5455299916985;3831.865884694036;3907.4138879168067;4107.876763697094;4134.917301653965;4135.684016950518;3747.962520374816;3779.9794055605107;4058.5129784425912;4143.399207114967;4152.8131234094535;3584.2473080653094;3584.336897673939;3598.1904071583945;3632.6367363263726;3635.7273204509765;4791.7530304316715;4815.927761083586;5196.610254230948;5277.445868183824;5416.9729151353995;4308.375285583573;4517.6160026397465;4657.813687452498;4714.504976977402;4762.38089048425;4692.882677933045;4759.904801903943;5282.9170020145775;5722.656640601577;5788.97105514474;3170.904872853795;3542.5040494330815;3620.4931309616672;3731.776093434403;3933.600503692745;5219.895602087937;6006.159137720766;6043.546733994968;6079.513638908877;6117;3945.447637330776;3947.743396679207;3949.624785645359;3963.196745480799;3996.4005399189773;3909.8330352414637;3996.3406038003986;4023.7988100594853;4033.789863041076;4050.0482386639114;3900.551436584772;4636.473122148437;4646.7444290564345;4670;4677.906441871211;5037.269595908646;5238.633295669267;5881.0592504473425;5882.411758824083;5883.794067207627;1090.8636420447444;1277.6294874486296;1317.3149962019888;1326.0916272353277;1329.1825527300834;774.4075782026754;789.1280135450245;878.4114643189079;909.6770646420558;909.9545022748836;4996.925046124311;5399.3250843643755;5463.48096930791;5539.750711218005;5619.7471113799975;4891.63312751538;5747;5978.103284507359;6012.909806352908;6061.454469097803;5648.576356773258;5665.66006039639;5675;5696.772129114872;5698.914516282176;2492.1526680928573;2620.2794231586086;3083.537469379611;3158.8894388696744;3193.1857376368876;5116;5976.671283079386;5977.6114552553945;6167.753289868355;6177.69111544421;6086.548258845638;6088.908666369919;6113.724882380304;6127.3259941407305;6140.754369825247;4774.832880849153;5873.739656832868;6170.382961703794;6173.290071641729;6237.656928868956;5924.7037648118285;6057.454829065406;6081;6084.140453986619;6092.603980741238;5878.412158784087;5917.615355001911;5939.673317967553;5978.222831031938;6029.51763858899;4722.315264286728;5405.48643381805;6168.938310616836;6245.533014459354;6253.812385628438;3498.8425520852134;3944.5069366329208;4006.158706671515;4028.4360189574068;4069.369247766601;5105.757843769159;5219.895602087861;5485.314335708036;5522.806701765419;5749;5902.468777810018;5938.584299099021;5967.701614919323;5999.6700181488695;6007.369226231358;4901.41183058021;5846.970765146147;5946.821595352147;6037.516998640011;6081.574289799849;5481.780728770805;5570;5712.143178523089;5746.885062298647;5789.2763404574425;4521.886952826206;5716.142578613241;5821.515513544019;5824.9708751457665;5860.2967643883;4578.436075797431;5466.945330546644;5689.743961521659;5759.798407055733;5811.854703632443 12:40:48 INFO - PROCESS | 2011 | |5;yui.html;743.9479236453448;760.9961950190249;784.3881772217669;809.4940662086196;840.411711801739;11722.882771172297;14156.50452234172;16256.296994813521;16994.98030118194;17138.914305428472;15398;15458.922705386485;15596.766048509282;15609.765853512177;15635;706.5795851468368;868.053821334745;895.5746020640208;895.7268033249857;898.4250079948838;742.283696233135;751.6204316820025;752.4018405367718;752.9548227106363;754.1478129713416;931.0689310689311;958.3674774648733;961.9567119479606;964.3056998960737;966.5408930757904;958.2573505533198;960.7934294126726;962.8988956159642;965.1651321606795;965.2133511188359;716.0726858717973;716.8064622551882;719.6617589732817;720.4056653261028;722.2596838240793;15199.240037998166;15418.537443876701;15459.304331305118;15492.45776397832;15494.922525387414;14528.128312301296;14661.70676586473;14693.265336733228;14771.409143634242;14835.406583736638;13131.0808243423;13454.125481843746;13606.795898061537;13646.658833529142;13824.861751382457;4679.74261415622;4764.4759076501905;4767.69010014348;4800.399950006249;4953.232249001375;120127;121604.39197804042;127712;127869;131711.68288316994;10727.517261723242;11575.305481671126;11747.647570572897;11893.226940248856;12082.275063496218;23542.64686029711;23575.93908274132;23623.29130126099;23634.7636523636;23670.053197872236;7740.690372385154;7892.408069394818;8044.477108987897;8285.710000150086;8469.661213551512;4370.409994650681;4439.711418757771;4441.133978874153;4590.540945905383;4594.816207351735;3565.7860528368383;3677.3013127505687;3681.5582130144553;3682.3187710273687;3703.2778608171147;649.4317472211815;652.885744994624;657.5528640524394;663.1942190238883;673.6261374936958;554.9944500554943;596.8299034775068;598.1028457314029;665.3878431842717;672.9192496900404;8713.477191368538;9518.190953768868;9646.18007469373;9659.420434773936;9714.805703885882;564.9463300986399;578.4475825586554;609.8228230916973;647.1360733420936;654.9312322206194;4580.450345958439;4585.472670642852;4621.745803980746;4639.396878405786;4661.27750198713;81893.18106818975;109258.3611245832;128181;131327.68672313346;178320;113112.17219569412;139365;142136.57863421235;145912;147665.52334476518;30856.074317770504;83093.58453207817;118697.40651296689;121170.70049045753;123009.76990229983;8901.287896968357;8928.330375221754;8970.865437018581;9044.728658140266;9055.979428195511;55948.72025639846;64899.35100648933;67845.96462106144;67986.66006669935;70279.29720702728;63345;66592.66703666451;89730;102754;109016;13645.863541364459;13695.520656776966;13885.583432497042;13889.444422222998;14191;12585.93707031459;12800.295983720986;13210.867891321348;15518.456854010055;16643.41748038813;12193.207441516273;12247.510099595916;12374.690632734253;12485.31330776816;12718.936405317914;13971.790423143864;14019.579412617637;14094.859051409765;14460.855391445952;14638.634034149232;13331.266780327174;13628;14021.088629239066;14081.295935203403;14083.507077252247;11471;11666.70833229142;12035.45840437165;12099.274043557414;12132.454039568418;8496.490210587384;11654.70863228426;11658.333374710439;11841.526338946345;11900.583479578174 12:40:48 INFO - PROCESS | 2011 | __end_tp_report 12:40:48 INFO - PROCESS | 2011 | __start_cc_report 12:40:48 INFO - PROCESS | 2011 | _x_x_mozilla_cycle_collect,1184 12:40:48 INFO - PROCESS | 2011 | __end_cc_report 12:40:48 INFO - PROCESS | 2011 | __startTimestamp1479156048389__endTimestamp 12:40:48 INFO - PROCESS | 2011 | 12:40:48 INFO - PROCESS | 2011 | ------- Summary: start ------- 12:40:48 INFO - PROCESS | 2011 | Number of tests: 6 12:40:48 INFO - PROCESS | 2011 | 12:40:48 INFO - PROCESS | 2011 | [#0] dojo.html Cycles:165 Average:5859.58 Median:6106.79 stddev:638.01 (10.4%) stddev-sans-first:610.95 12:40:48 INFO - PROCESS | 2011 | Values: 3434.5 3441.8 3477.2 3492.6 3520.0 5743.1 5816.9 5855.3 5866.3 5880.9 4735.2 5837.5 5854.3 5858.6 5867.9 5268.9 5334.1 5346.2 5371.4 5384.7 5257.3 5270.4 5425.8 5427.1 5455.8 5226.2 5285.4 5380.3 5403.0 5417.0 5328.0 5346.0 5347.9 5365.2 5408.5 5294.0 5369.4 5376.0 5376.9 5414.4 5682.0 5724.6 5748.9 5925.6 5929.6 6213.3 6256.3 6278.5 6347.4 6352.6 6297.7 6346.3 6351.1 6353.0 6368.0 5802.4 5888.2 5893.1 5905.9 5910.3 6276.8 6336.0 6337.1 6369.9 6372.6 6275.7 6276.6 6280.3 6282.9 6287.8 6297.2 6306.7 6351.9 6376.7 6382.4 6102.2 6129.9 6134.1 6201.9 6253.1 6343.6 6344.7 6364.0 6365.5 6368.8 5008.5 5057.3 5059.5 5062.3 5086.4 4478.4 4481.0 4491.6 4527.8 4586.3 5829.2 5877.9 5905.3 6005.8 6019.1 6296.3 6335.0 6344.1 6349.7 6378.6 5852.0 5883.9 5886.9 5890.5 5925.8 5427.3 5469.9 5472.9 5474.5 5488.6 6469.9 6477.5 6482.3 6484.8 6491.1 6328.0 6333.5 6337.1 6346.0 6356.0 6258.7 6287.7 6317.5 6380.6 6462.1 6236.1 6292.9 6339.5 6352.4 6358.7 6068.1 6312.3 6337.0 6353.7 6363.1 6116.6 6258.0 6301.0 6304.1 6306.7 6106.8 6173.9 6175.9 6214.6 6291.1 6176.9 6180.0 6191.0 6199.7 6204.5 6205.7 6227.7 6247.9 6275.6 6279.5 5946.1 5977.5 6014.0 6049.0 6072.6 12:40:48 INFO - PROCESS | 2011 | 12:40:48 INFO - PROCESS | 2011 | [#1] ext.html Cycles:180 Average:76182.13 Median:20229.78 stddev:172253.73 (851.5%) stddev-sans-first:172643.21 12:40:48 INFO - PROCESS | 2011 | Values: 497.3 499.0 536.9 540.4 566.5 32544.0 42622.6 43797.1 44049.6 45760.8 44692.0 45116.9 45135.4 45151.5 45315.3 9360.6 10149.2 10316.9 10334.1 10345.8 9300.0 9589.8 9597.0 9628.0 12222.1 12474.7 12628.7 12633.8 12635.9 12648.5 12501.9 12572.1 12587.8 12596.0 12606.7 12423.7 12497.8 12502.7 12528.2 12531.4 41651.6 41834.6 41882.0 41897.6 41941.4 3403.9 3519.8 3678.3 3882.5 3992.7 32205.2 32287.5 32477.7 32985.2 33160.0 3316.5 3392.8 3394.3 3430.9 3446.0 475646.0 510645.0 544471.3 548675.0 549237.0 61523.4 61828.0 61948.4 61997.0 62012.7 36164.6 36717.0 36781.3 37609.4 37701.2 17855.9 18026.2 18037.4 18060.5 18076.0 13653.0 13746.5 13754.0 13812.7 13829.7 17480.0 17803.0 17895.0 17922.2 17943.5 7188.7 7350.3 7992.7 8007.4 8079.7 787.6 890.3 938.0 977.7 1002.5 30447.9 31072.0 31115.0 31706.9 31900.4 971.4 1001.2 1157.2 1208.6 1248.1 15655.8 16470.6 16494.8 16501.3 16856.0 749262.0 753819.0 754915.0 759793.0 759816.0 60942.4 61655.0 61715.4 61891.0 62123.0 1255.6 1374.4 1423.2 1443.6 1452.4 25547.4 29995.6 31207.2 31914.0 31974.5 52304.0 52624.5 52629.7 52717.7 52727.7 621394.0 623287.0 623851.0 624076.0 634090.0 19173.4 24861.8 24873.0 27564.4 27970.3 39529.0 41568.8 48563.8 49393.8 53235.0 40116.6 40478.0 41716.8 42481.7 42547.0 40980.0 41268.2 41712.0 41997.8 42381.9 39274.2 40137.2 40410.2 40565.0 40581.4 34788.5 35720.5 35957.8 36355.0 36377.8 25652.0 27133.9 27373.0 27548.6 27579.1 12:40:48 INFO - PROCESS | 2011 | 12:40:48 INFO - PROCESS | 2011 | [#2] jquery.html Cycles:180 Average:35882.81 Median:22669.99 stddev:103010.48 (454.4%) stddev-sans-first:103264.90 12:40:48 INFO - PROCESS | 2011 | Values: 350.8 376.1 386.9 395.9 405.4 16250.7 17163.7 19336.0 22572.4 22767.5 18276.0 21322.6 22048.6 22268.7 22434.2 5296.4 5317.5 5964.4 5983.4 6155.7 6123.5 6225.8 6244.4 6245.0 6252.4 5658.9 5959.8 6186.7 6257.9 6272.4 6153.5 6232.3 6317.2 6356.2 6359.4 6078.3 6141.6 6145.4 6149.7 6153.2 13490.7 13590.9 13650.5 13694.7 13893.4 2012.6 2186.3 2205.0 2824.5 2934.4 9738.8 10213.9 10488.2 10535.3 10632.2 1925.3 2004.7 2024.5 2031.7 2060.8 84303.4 108766.5 121090.4 128914.7 132122.0 11525.8 11582.1 11710.8 11764.9 11950.4 14972.9 14980.0 14983.9 14992.0 15017.3 8818.3 8911.5 8928.0 8929.0 9041.3 9006.8 9030.1 9049.2 9208.5 9212.3 4387.4 4601.7 4625.6 4638.1 4671.5 1622.5 1674.5 1923.5 1927.6 1945.9 894.2 937.1 958.3 995.2 996.4 16853.3 19864.2 21429.9 21917.6 21956.3 915.2 925.6 955.3 975.0 989.2 9293.3 10888.8 11387.7 11513.1 11516.8 570109.0 613189.0 620993.0 624405.0 644743.0 138116.3 143073.0 146077.0 146449.0 147024.4 927.8 949.1 1012.4 1019.0 1024.6 16684.7 18867.9 19566.5 20204.0 20259.9 55741.2 56655.3 58530.7 60362.4 61440.4 77622.6 79393.0 80439.2 81188.0 81570.6 6298.8 7687.2 7931.9 8069.6 8272.7 10854.0 13240.9 13261.2 13725.7 13734.8 11330.9 11511.4 11839.3 11852.9 11992.6 11243.9 11486.9 11527.3 11567.3 11846.2 11448.7 11765.9 11853.4 11887.3 12168.3 7893.6 7967.0 8040.6 8228.8 8430.6 8357.5 10979.8 11643.8 11711.1 11898.5 12:40:48 INFO - PROCESS | 2011 | 12:40:48 INFO - PROCESS | 2011 | [#3] mootools.html Cycles:180 Average:5985.93 Median:4858.94 stddev:3409.76 (70.2%) stddev-sans-first:3402.15 12:40:48 INFO - PROCESS | 2011 | Values: 1431.4 1487.5 1728.9 1741.5 1927.8 7280.0 9378.8 9382.2 9384.5 9430.2 8183.9 8380.0 8939.3 9025.8 9093.2 2411.7 2436.7 2439.8 2440.6 2448.2 2410.0 2422.6 2460.2 2462.9 2468.7 2436.8 2443.5 2454.8 2461.7 2468.1 2418.4 2420.7 2427.9 2428.3 2445.7 2417.2 2435.7 2441.5 2441.9 2478.1 9129.8 9166.8 9243.7 9253.8 9268.4 5429.4 5596.0 5601.3 5601.5 5601.6 3626.0 3749.4 3820.4 3861.4 3863.8 990.8 1065.5 1113.6 1122.4 1143.6 12364.6 12436.0 12461.1 12473.4 12475.1 3936.3 4743.0 4750.5 4794.1 4923.8 10529.3 10530.1 10530.6 10532.8 10553.4 5503.6 5510.1 5512.1 5515.8 5516.7 4591.0 4744.2 4984.4 5039.6 5073.8 3990.0 4042.8 4090.8 4125.6 4142.9 1284.5 1295.4 1298.4 1312.0 1313.3 810.4 882.5 911.0 913.7 930.2 5944.6 5972.3 6064.4 6147.3 6202.3 927.6 954.1 968.7 972.6 1007.7 3756.2 4006.4 4060.6 4120.1 4137.6 11180.4 11392.0 11520.4 11563.8 11565.6 11444.3 11447.5 11449.3 11459.7 11472.9 8286.2 8593.9 8606.4 8607.3 8759.7 6019.0 6153.8 6154.1 6211.8 6266.2 10336.4 10514.3 10740.5 10745.7 10751.0 10474.5 10744.8 10746.3 10785.0 10969.0 7247.9 7415.7 7776.8 7801.0 7989.7 8612.4 8835.2 8875.6 8881.2 8885.0 7799.6 7864.8 7911.9 8039.3 8057.9 7649.8 7741.0 7758.1 7815.3 7816.8 7246.0 7367.1 7377.5 7382.0 7388.3 5056.6 5092.9 5125.2 5242.3 5383.8 5125.5 5187.9 5281.1 5367.0 5429.8 12:40:48 INFO - PROCESS | 2011 | 12:40:48 INFO - PROCESS | 2011 | [#4] prototype.html Cycles:180 Average:4658.82 Median:5232.98 stddev:1485.28 (28.4%) stddev-sans-first:1452.97 12:40:48 INFO - PROCESS | 2011 | Values: 300.1 301.6 307.3 312.4 313.8 4727.7 4796.7 5303.4 5460.2 5465.3 4734.6 5227.3 5257.7 5533.0 5543.4 3423.0 3931.7 4152.7 4238.6 4256.5 3353.9 3632.0 3677.9 3886.4 4131.5 3831.9 3907.4 4107.9 4134.9 4135.7 3748.0 3780.0 4058.5 4143.4 4152.8 3584.2 3584.3 3598.2 3632.6 3635.7 4791.8 4815.9 5196.6 5277.4 5417.0 4308.4 4517.6 4657.8 4714.5 4762.4 4692.9 4759.9 5282.9 5722.7 5789.0 3170.9 3542.5 3620.5 3731.8 3933.6 5219.9 6006.2 6043.5 6079.5 6117.0 3945.4 3947.7 3949.6 3963.2 3996.4 3909.8 3996.3 4023.8 4033.8 4050.0 3900.6 4636.5 4646.7 4670.0 4677.9 5037.3 5238.6 5881.1 5882.4 5883.8 1090.9 1277.6 1317.3 1326.1 1329.2 774.4 789.1 878.4 909.7 910.0 4996.9 5399.3 5463.5 5539.8 5619.7 4891.6 5747.0 5978.1 6012.9 6061.5 5648.6 5665.7 5675.0 5696.8 5698.9 2492.2 2620.3 3083.5 3158.9 3193.2 5116.0 5976.7 5977.6 6167.8 6177.7 6086.5 6088.9 6113.7 6127.3 6140.8 4774.8 5873.7 6170.4 6173.3 6237.7 5924.7 6057.5 6081.0 6084.1 6092.6 5878.4 5917.6 5939.7 5978.2 6029.5 4722.3 5405.5 6168.9 6245.5 6253.8 3498.8 3944.5 4006.2 4028.4 4069.4 5105.8 5219.9 5485.3 5522.8 5749.0 5902.5 5938.6 5967.7 5999.7 6007.4 4901.4 5847.0 5946.8 6037.5 6081.6 5481.8 5570.0 5712.1 5746.9 5789.3 4521.9 5716.1 5821.5 5825.0 5860.3 4578.4 5466.9 5689.7 5759.8 5811.9 12:40:48 INFO - PROCESS | 2011 | 12:40:48 INFO - PROCESS | 2011 | [#5] yui.html Cycles:180 Average:24677.93 Median:3679.43 stddev:39418.14 (1071.3%) stddev-sans-first:39487.76 12:40:48 INFO - PROCESS | 2011 | Values: 743.9 761.0 784.4 809.5 840.4 11722.9 14156.5 16256.3 16995.0 17138.9 15398.0 15458.9 15596.8 15609.8 15635.0 706.6 868.1 895.6 895.7 898.4 742.3 751.6 752.4 753.0 754.1 931.1 958.4 962.0 964.3 966.5 958.3 960.8 962.9 965.2 965.2 716.1 716.8 719.7 720.4 722.3 15199.2 15418.5 15459.3 15492.5 15494.9 14528.1 14661.7 14693.3 14771.4 14835.4 13131.1 13454.1 13606.8 13646.7 13824.9 4679.7 4764.5 4767.7 4800.4 4953.2 120127.0 121604.4 127712.0 127869.0 131711.7 10727.5 11575.3 11747.6 11893.2 12082.3 23542.6 23575.9 23623.3 23634.8 23670.1 7740.7 7892.4 8044.5 8285.7 8469.7 4370.4 4439.7 4441.1 4590.5 4594.8 3565.8 3677.3 3681.6 3682.3 3703.3 649.4 652.9 657.6 663.2 673.6 555.0 596.8 598.1 665.4 672.9 8713.5 9518.2 9646.2 9659.4 9714.8 564.9 578.4 609.8 647.1 654.9 4580.5 4585.5 4621.7 4639.4 4661.3 81893.2 109258.4 128181.0 131327.7 178320.0 113112.2 139365.0 142136.6 145912.0 147665.5 30856.1 83093.6 118697.4 121170.7 123009.8 8901.3 8928.3 8970.9 9044.7 9056.0 55948.7 64899.4 67846.0 67986.7 70279.3 63345.0 66592.7 89730.0 102754.0 109016.0 13645.9 13695.5 13885.6 13889.4 14191.0 12585.9 12800.3 13210.9 15518.5 16643.4 12193.2 12247.5 12374.7 12485.3 12718.9 13971.8 14019.6 14094.9 14460.9 14638.6 13331.3 13628.0 14021.1 14081.3 14083.5 11471.0 11666.7 12035.5 12099.3 12132.5 8496.5 11654.7 11658.3 11841.5 11900.6 12:40:48 INFO - PROCESS | 2011 | -------- Summary: end -------- 12:40:48 INFO - PROCESS | 2011 | 12:40:48 INFO - TEST-INFO | 2011: exit 0 12:40:48 INFO - TEST-OK | dromaeo_css | took 1115164ms 12:40:48 INFO - TEST-START | kraken 12:40:48 INFO - operating with platform_type : mac_ 12:40:48 INFO - Initialising browser for kraken test... 12:40:48 INFO - TEST-INFO | started process 2018 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/tmpDWc0fg/profile http://localhost:49376/getInfo.html) 12:40:51 INFO - PROCESS | 2018 | __metrics Screen width/height:1600/1200 12:40:51 INFO - PROCESS | 2018 | colorDepth:24 12:40:51 INFO - PROCESS | 2018 | Browser inner width/height: 1024/689 12:40:51 INFO - PROCESS | 2018 | __metrics 12:40:51 INFO - PROCESS | 2018 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 12:40:51 INFO - PROCESS | 2018 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:40:51 INFO - TEST-INFO | 2018: exit 0 12:40:51 INFO - Browser initialized. 12:40:51 INFO - Running cycle 1/1 for kraken test... 12:40:51 INFO - TEST-INFO | started process 2020 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/tmpDWc0fg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:41:03 INFO - PROCESS | 2020 | RSS: Main: 168259584 12:41:03 INFO - PROCESS | 2020 | 12:41:06 INFO - PROCESS | 2020 | Cycle 1(1): loaded http://localhost:49376/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49376/tests/kraken/driver.html?testName=audio-beat-detection) 12:41:07 INFO - PROCESS | 2020 | RSS: Main: 218017792 12:41:07 INFO - PROCESS | 2020 | 12:41:10 INFO - PROCESS | 2020 | Cycle 1(1): loaded http://localhost:49376/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49376/tests/kraken/driver.html?testName=audio-dft) 12:41:10 INFO - PROCESS | 2020 | RSS: Main: 229040128 12:41:10 INFO - PROCESS | 2020 | 12:41:13 INFO - PROCESS | 2020 | Cycle 1(1): loaded http://localhost:49376/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49376/tests/kraken/driver.html?testName=audio-fft) 12:41:14 INFO - PROCESS | 2020 | RSS: Main: 326537216 12:41:14 INFO - PROCESS | 2020 | 12:41:16 INFO - PROCESS | 2020 | Cycle 1(1): loaded http://localhost:49376/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49376/tests/kraken/driver.html?testName=audio-oscillator) 12:41:17 INFO - PROCESS | 2020 | RSS: Main: 227516416 12:41:17 INFO - PROCESS | 2020 | 12:41:19 INFO - PROCESS | 2020 | Cycle 1(1): loaded http://localhost:49376/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49376/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:41:19 INFO - PROCESS | 2020 | RSS: Main: 229347328 12:41:19 INFO - PROCESS | 2020 | 12:41:22 INFO - PROCESS | 2020 | Cycle 1(1): loaded http://localhost:49376/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49376/tests/kraken/driver.html?testName=imaging-darkroom) 12:41:22 INFO - PROCESS | 2020 | RSS: Main: 267247616 12:41:22 INFO - PROCESS | 2020 | 12:41:25 INFO - PROCESS | 2020 | Cycle 1(1): loaded http://localhost:49376/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49376/tests/kraken/driver.html?testName=imaging-desaturate) 12:41:26 INFO - PROCESS | 2020 | RSS: Main: 265773056 12:41:26 INFO - PROCESS | 2020 | 12:41:29 INFO - PROCESS | 2020 | Cycle 1(1): loaded http://localhost:49376/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49376/tests/kraken/driver.html?testName=json-parse-financial) 12:41:29 INFO - PROCESS | 2020 | RSS: Main: 264802304 12:41:29 INFO - PROCESS | 2020 | 12:41:31 INFO - PROCESS | 2020 | Cycle 1(1): loaded http://localhost:49376/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49376/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:41:31 INFO - PROCESS | 2020 | RSS: Main: 240521216 12:41:31 INFO - PROCESS | 2020 | 12:41:33 INFO - PROCESS | 2020 | Cycle 1(1): loaded http://localhost:49376/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49376/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:41:34 INFO - PROCESS | 2020 | RSS: Main: 244580352 12:41:34 INFO - PROCESS | 2020 | 12:41:36 INFO - PROCESS | 2020 | Cycle 1(1): loaded http://localhost:49376/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49376/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:41:37 INFO - PROCESS | 2020 | RSS: Main: 254115840 12:41:37 INFO - PROCESS | 2020 | 12:41:39 INFO - PROCESS | 2020 | Cycle 1(1): loaded http://localhost:49376/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49376/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:41:40 INFO - PROCESS | 2020 | RSS: Main: 256438272 12:41:40 INFO - PROCESS | 2020 | 12:41:43 INFO - PROCESS | 2020 | Cycle 1(1): loaded http://localhost:49376/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49376/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:41:44 INFO - PROCESS | 2020 | RSS: Main: 258023424 12:41:44 INFO - PROCESS | 2020 | 12:41:45 INFO - PROCESS | 2020 | Cycle 1(1): loaded http://localhost:49376/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49376/tests/kraken/driver.html?testName=ai-astar) 12:41:45 INFO - PROCESS | 2020 | RSS: Main: 302383104 12:41:45 INFO - PROCESS | 2020 | 12:41:45 INFO - PROCESS | 2020 | __start_tp_report 12:41:45 INFO - PROCESS | 2020 | _x_x_mozilla_page_load 12:41:45 INFO - PROCESS | 2020 | _x_x_mozilla_page_load_details 12:41:45 INFO - PROCESS | 2020 | |i|pagename|runs| 12:41:45 INFO - PROCESS | 2020 | |0;ai-astar;114;113;114;113;113;113;112;112;114;113 12:41:45 INFO - PROCESS | 2020 | |1;audio-beat-detection;145;109;108;142;105;91;111;133;172;136 12:41:45 INFO - PROCESS | 2020 | |2;audio-dft;181;183;185;185;182;181;184;183;182;182 12:41:45 INFO - PROCESS | 2020 | |3;audio-fft;87;69;86;114;60;58;58;58;80;59 12:41:45 INFO - PROCESS | 2020 | |4;audio-oscillator;86;71;93;69;68;68;91;67;68;88 12:41:45 INFO - PROCESS | 2020 | |5;imaging-gaussian-blur;88;86;91;85;86;83;88;83;87;84 12:41:45 INFO - PROCESS | 2020 | |6;imaging-darkroom;95;94;94;94;96;95;95;95;95;95 12:41:45 INFO - PROCESS | 2020 | |7;imaging-desaturate;128;84;85;86;86;83;86;84;95;135 12:41:45 INFO - PROCESS | 2020 | |8;json-parse-financial;55;53;52;50;55;54;56;55;57;57 12:41:45 INFO - PROCESS | 2020 | |9;json-stringify-tinderbox;63;70;72;73;69;68;67;67;68;69 12:41:45 INFO - PROCESS | 2020 | |10;stanford-crypto-aes;84;81;83;81;82;83;85;88;88;111 12:41:45 INFO - PROCESS | 2020 | |11;stanford-crypto-ccm;137;145;148;135;149;142;133;132;133;131 12:41:45 INFO - PROCESS | 2020 | |12;stanford-crypto-pbkdf2;170;219;198;158;159;156;157;158;156;158 12:41:45 INFO - PROCESS | 2020 | |13;stanford-crypto-sha256-iterative;64;65;65;63;63;62;65;64;64;65 12:41:45 INFO - PROCESS | 2020 | __end_tp_report 12:41:45 INFO - PROCESS | 2020 | __start_cc_report 12:41:45 INFO - PROCESS | 2020 | _x_x_mozilla_cycle_collect,1794 12:41:45 INFO - PROCESS | 2020 | __end_cc_report 12:41:45 INFO - PROCESS | 2020 | __startTimestamp1479156105946__endTimestamp 12:41:45 INFO - PROCESS | 2020 | 12:41:45 INFO - PROCESS | 2020 | ------- Summary: start ------- 12:41:45 INFO - PROCESS | 2020 | Number of tests: 14 12:41:45 INFO - PROCESS | 2020 | 12:41:45 INFO - PROCESS | 2020 | [#0] ai-astar Cycles:10 Average:113.10 Median:113.00 stddev:0.74 (0.7%) stddev-sans-first:0.71 12:41:45 INFO - PROCESS | 2020 | Values: 114.0 113.0 114.0 113.0 113.0 113.0 112.0 112.0 114.0 113.0 12:41:45 INFO - PROCESS | 2020 | 12:41:45 INFO - PROCESS | 2020 | [#1] audio-beat-detection Cycles:10 Average:125.20 Median:139.00 stddev:24.45 (17.6%) stddev-sans-first:24.86 12:41:45 INFO - PROCESS | 2020 | Values: 145.0 109.0 108.0 142.0 105.0 91.0 111.0 133.0 172.0 136.0 12:41:45 INFO - PROCESS | 2020 | 12:41:45 INFO - PROCESS | 2020 | [#2] audio-dft Cycles:10 Average:182.80 Median:183.00 stddev:1.48 (0.8%) stddev-sans-first:1.41 12:41:45 INFO - PROCESS | 2020 | Values: 181.0 183.0 185.0 185.0 182.0 181.0 184.0 183.0 182.0 182.0 12:41:45 INFO - PROCESS | 2020 | 12:41:45 INFO - PROCESS | 2020 | [#3] audio-fft Cycles:10 Average:72.90 Median:64.50 stddev:18.71 (29.0%) stddev-sans-first:19.14 12:41:45 INFO - PROCESS | 2020 | Values: 87.0 69.0 86.0 114.0 60.0 58.0 58.0 58.0 80.0 59.0 12:41:45 INFO - PROCESS | 2020 | 12:41:45 INFO - PROCESS | 2020 | [#4] audio-oscillator Cycles:10 Average:76.90 Median:78.50 stddev:11.04 (14.1%) stddev-sans-first:11.21 12:41:45 INFO - PROCESS | 2020 | Values: 86.0 71.0 93.0 69.0 68.0 68.0 91.0 67.0 68.0 88.0 12:41:45 INFO - PROCESS | 2020 | 12:41:45 INFO - PROCESS | 2020 | [#5] imaging-gaussian-blur Cycles:10 Average:86.10 Median:86.50 stddev:2.51 (2.9%) stddev-sans-first:2.57 12:41:45 INFO - PROCESS | 2020 | Values: 88.0 86.0 91.0 85.0 86.0 83.0 88.0 83.0 87.0 84.0 12:41:45 INFO - PROCESS | 2020 | 12:41:45 INFO - PROCESS | 2020 | [#6] imaging-darkroom Cycles:10 Average:94.80 Median:95.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 12:41:45 INFO - PROCESS | 2020 | Values: 95.0 94.0 94.0 94.0 96.0 95.0 95.0 95.0 95.0 95.0 12:41:45 INFO - PROCESS | 2020 | 12:41:45 INFO - PROCESS | 2020 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:85.50 stddev:19.49 (22.8%) stddev-sans-first:16.67 12:41:45 INFO - PROCESS | 2020 | Values: 128.0 84.0 85.0 86.0 86.0 83.0 86.0 84.0 95.0 135.0 12:41:45 INFO - PROCESS | 2020 | 12:41:45 INFO - PROCESS | 2020 | [#8] json-parse-financial Cycles:10 Average:54.40 Median:55.00 stddev:2.22 (4.0%) stddev-sans-first:2.35 12:41:45 INFO - PROCESS | 2020 | Values: 55.0 53.0 52.0 50.0 55.0 54.0 56.0 55.0 57.0 57.0 12:41:45 INFO - PROCESS | 2020 | 12:41:45 INFO - PROCESS | 2020 | [#9] json-stringify-tinderbox Cycles:10 Average:68.60 Median:69.00 stddev:2.80 (4.1%) stddev-sans-first:2.11 12:41:45 INFO - PROCESS | 2020 | Values: 63.0 70.0 72.0 73.0 69.0 68.0 67.0 67.0 68.0 69.0 12:41:45 INFO - PROCESS | 2020 | 12:41:45 INFO - PROCESS | 2020 | [#10] stanford-crypto-aes Cycles:10 Average:86.60 Median:83.50 stddev:8.93 (10.7%) stddev-sans-first:9.43 12:41:45 INFO - PROCESS | 2020 | Values: 84.0 81.0 83.0 81.0 82.0 83.0 85.0 88.0 88.0 111.0 12:41:45 INFO - PROCESS | 2020 | 12:41:45 INFO - PROCESS | 2020 | [#11] stanford-crypto-ccm Cycles:10 Average:138.50 Median:139.50 stddev:6.90 (4.9%) stddev-sans-first:7.30 12:41:45 INFO - PROCESS | 2020 | Values: 137.0 145.0 148.0 135.0 149.0 142.0 133.0 132.0 133.0 131.0 12:41:45 INFO - PROCESS | 2020 | 12:41:45 INFO - PROCESS | 2020 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.90 Median:158.50 stddev:21.82 (13.8%) stddev-sans-first:23.15 12:41:45 INFO - PROCESS | 2020 | Values: 170.0 219.0 198.0 158.0 159.0 156.0 157.0 158.0 156.0 158.0 12:41:45 INFO - PROCESS | 2020 | 12:41:45 INFO - PROCESS | 2020 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.00 Median:64.50 stddev:1.05 (1.6%) stddev-sans-first:1.12 12:41:45 INFO - PROCESS | 2020 | Values: 64.0 65.0 65.0 63.0 63.0 62.0 65.0 64.0 64.0 65.0 12:41:45 INFO - PROCESS | 2020 | -------- Summary: end -------- 12:41:45 INFO - PROCESS | 2020 | 12:41:46 INFO - TEST-INFO | 2020: exit 0 12:41:46 INFO - TEST-OK | kraken | took 57831ms 12:41:46 INFO - SUITE-END | took 1172s 12:41:47 INFO - Completed test suite (00:19:33) 12:41:47 INFO - javascript benchmark 12:41:47 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3434.536337594425, 3441.810700411478, 3477.1828620274246, 3492.6158122606525, 3520.0, 5743.081107022877, 5816.883662326751, 5855.297364316278, 5866.325372582154, 5880.9411905880925, 4735.242361222206, 5837.532997360212, 5854.3267524234725, 5858.589898707092, 5867.8533036674, 5268.9473105268935, 5334.146536554152, 5346.171343441753, 5371.409144994048, 5384.703841288728, 5257.316548848645, 5270.39390470097, 5425.782968681248, 5427.1316589345715, 5455.754491047893, 5226.24219488174, 5285.365756109253, 5380.300560927074, 5403.027455058108, 5417.0, 5328.014317351302, 5345.973270133624, 5347.903679745643, 5365.248865158861, 5408.4591540845995, 5293.994141113215, 5369.382521010056, 5375.973120134413, 5376.946230537684, 5414.35027796663, 5682.0, 5724.570657200685, 5748.942510574882, 5925.644461332291, 5929.555283353766, 6213.285472170713, 6256.280527739277, 6278.497720182374, 6347.365263473615, 6352.555321127523, 6297.685115744194, 6346.30190679025, 6351.079093531458, 6352.968235158841, 6367.968160159169, 5802.448767367094, 5888.175655408247, 5893.086571581412, 5905.911411328833, 5910.290765108214, 6276.843078923063, 6335.968320158369, 6337.081123237105, 6369.904451433232, 6372.585781924253, 6275.748970041239, 6276.592021518587, 6280.340564240781, 6282.874342513124, 6287.811365659038, 6297.244330680256, 6306.716197771111, 6351.936480635134, 6376.7130479128555, 6382.361763823674, 6102.206713127265, 6129.943220939371, 6134.13617322964, 6201.875962480815, 6253.062040693932, 6343.619382837044, 6344.714487848058, 6364.045393191059, 6365.4589359904, 6368.77709280173, 5008.524190201925, 5057.291979122926, 5059.544640982329, 5062.341895553554, 5086.364204474441, 4478.350639157304, 4481.0365771358665, 4491.595756381876, 4527.7736113194205, 4586.266197408466, 5829.154772557956, 5877.9118313225335, 5905.320888097838, 6005.819825405245, 6019.127226552126, 6296.33888441707, 6335.018072198816, 6344.111824344595, 6349.6507692077375, 6378.649174295459, 5851.970740146272, 5883.94089063964, 5886.8822623547285, 5890.469857712741, 5925.762969481172, 5427.267318911975, 5469.863253418696, 5472.863178420572, 5474.479924407175, 5488.588355873326, 6469.870602587922, 6477.546571739933, 6482.319356467503, 6484.837879052967, 6491.091247225298, 6327.96836015817, 6333.493320534439, 6337.081123237197, 6346.048092786119, 6355.968220158869, 6258.655773932477, 6287.685615719287, 6317.4630156437215, 6380.649064301508, 6462.063000864754, 6236.126942228182, 6292.905606415816, 6339.492840572835, 6352.428281454691, 6358.745650173942, 6068.059450785136, 6312.337204593451, 6337.04944258365, 6353.745850166127, 6363.14097596837, 6116.602420842631, 6257.9687101564205, 6301.0, 6304.085907543472, 6306.65313407767, 6106.7862624809695, 6173.938260617337, 6175.907361389673, 6214.5960512566535, 6291.056341548804, 6176.907346389898, 6180.042093475518, 6191.040388739752, 6199.659018754011, 6204.5036397089025, 6205.720742566686, 6227.657478838707, 6247.875042499034, 6275.592086514362, 6279.466245369194, 5946.137810017437, 5977.462028417463, 6014.0, 6049.0, 6072.635641861502], "value": 5819.284939825398, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [497.2764627467036, 498.9646483546642, 536.9328833895762, 540.3569751995126, 566.4562020460357, 32544.0, 42622.57377426225, 43797.12405751883, 44049.55950440495, 45760.77119614406, 44692.0, 45116.87207819806, 45135.4202602909, 45151.548484515144, 45315.320270195974, 9360.578773955154, 10149.238807089461, 10316.948415257913, 10334.121599664, 10345.844812327821, 9300.023497532764, 9589.808203835919, 9596.95201523995, 9628.0, 12222.144449888512, 12474.688132796708, 12628.68428289291, 12633.810492842615, 12635.936820315885, 12648.49406023758, 12501.874981250208, 12572.1199516033, 12587.811182832265, 12596.0, 12606.747865042693, 12423.689407764788, 12497.812532812015, 12502.74994500105, 12528.185667931646, 12531.43608537618, 41651.58348416507, 41834.58165418337, 41881.95295117616, 41897.581024189676, 41941.370879436836, 3403.8638454461793, 3519.8064106474135, 3678.301122786662, 3882.514685664292, 3992.7005474589523, 32205.24938813399, 32287.515687264477, 32477.675223247938, 32985.17537061569, 33160.0, 3316.4527852904243, 3392.830358482066, 3394.2702319001532, 3430.879919202816, 3446.0, 475646.0, 510645.0, 544471.2776436132, 548675.0, 549237.0, 61523.38476615266, 61828.0, 61948.38051619426, 61997.0, 62012.6591138616, 36164.638353616654, 36717.0, 36781.26437471236, 37609.435858462144, 37701.24597508035, 17855.928644281386, 18026.188821503063, 18037.368692095715, 18060.458186254433, 18076.005819680046, 13653.0, 13746.450141994408, 13754.0, 13812.654683632789, 13829.723405531833, 17479.951202927612, 17803.0, 17895.0, 17922.193501292473, 17943.461696149137, 7188.748393806296, 7350.301721336465, 7992.681207600681, 8007.439479236397, 8079.747639115946, 787.6376866641294, 890.2744263425287, 937.9953100234455, 977.6773664690635, 1002.5187909803335, 30447.877294984373, 31072.0, 31115.0, 31706.89025884083, 31900.44796416281, 971.358903123949, 1001.244060734141, 1157.2304417562395, 1208.5951206345796, 1248.1076030638137, 15655.84344156544, 16470.588235294214, 16494.845360824867, 16501.33994640201, 16856.0, 749262.0, 753819.0, 754915.0, 759793.0, 759816.0, 60942.390576094556, 61655.0, 61715.38284617186, 61891.0, 62122.9999999991, 1255.598208573266, 1374.4296117111487, 1423.1532238318184, 1443.6390902274431, 1452.382737336649, 25547.36131596725, 29995.550066749453, 31207.219819504695, 31914.0, 31974.52038219382, 52303.95392092213, 52624.473755261955, 52629.7368513155, 52717.736411317695, 52727.73636131795, 621394.0, 623287.0, 623851.0, 624076.0, 634090.0, 19173.424797256106, 24861.751382486666, 24873.0, 27564.448711026067, 27970.300742480787, 39529.0, 41568.792156039024, 48563.75718121387, 49393.75303123461, 53235.0, 40116.59883401245, 40478.0, 41716.791416042724, 42481.66350850609, 42547.0, 40979.97550061272, 41268.174636507705, 41711.957201069, 41997.79001104975, 42381.94045148896, 39274.214515708954, 40137.19725605413, 40410.1917961645, 40564.985875353355, 40581.39127913143, 34788.47817282692, 35720.464193037646, 35957.820210898775, 36355.0, 36377.81811090928, 25652.0, 27133.86433067901, 27373.0, 27548.586771198046, 27579.103738549147], "value": 20959.887027442404, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [350.7842676753796, 376.12738446803394, 386.85492940147446, 395.86540576204084, 405.42024904386733, 16250.674986500262, 17163.656726865454, 19336.0, 22572.43568910776, 22767.54464910703, 18276.0, 21322.57354852902, 22048.559028819414, 22268.66597001042, 22434.214802481918, 5296.417394086648, 5317.521423071923, 5964.403559644023, 5983.401659834025, 6155.661438620874, 6123.510119190454, 6225.782097626584, 6244.406781355764, 6244.968775156118, 6252.406021427957, 5658.943410565883, 5959.761609535613, 6186.721597528122, 6257.9361508543425, 6272.404121608462, 6153.476954458876, 6232.3144454110015, 6317.210348706411, 6356.173697419329, 6359.427651511386, 6078.270607527081, 6141.6007959482495, 6145.3547377525165, 6149.723262453155, 6153.169322141498, 13490.730185396236, 13590.864091359059, 13650.522231721841, 13694.657633559142, 13893.4442622295, 2012.6477866373473, 2186.278528085728, 2204.9889750551147, 2824.4915915135266, 2934.3691106412225, 9738.805223895553, 10213.948930255376, 10488.213383996232, 10535.315204511682, 10632.202584806171, 1925.3068895197719, 2004.7393838801008, 2024.544477492567, 2031.654618714822, 2060.7527096748336, 84303.40187511154, 108766.45616771944, 121090.39454802757, 128914.71085289215, 132122.0, 11525.827112593317, 11582.131340149523, 11710.76578468426, 11764.94117529424, 11950.402479875971, 14972.925135374253, 14980.0, 14983.850161498463, 14992.0, 15017.324220410108, 8818.29453643707, 8911.50986695738, 8928.0, 8928.955355223312, 9041.321900857462, 9006.819863602823, 9030.051844556227, 9049.230815380766, 9208.539573021322, 9212.30907681913, 4387.42963414754, 4601.723896566216, 4625.560571745679, 4638.141943740419, 4671.481768425276, 1622.505135933528, 1674.4976507047836, 1923.4806602217602, 1927.6433859735994, 1945.8929758863399, 894.1550235027967, 937.1331518345503, 958.2717134977468, 995.1690338567378, 996.3971797062818, 16853.325866965184, 19864.205431782855, 21429.89285053565, 21917.561648767256, 21956.341309760413, 915.190056799737, 925.6204955968021, 955.3121752338305, 975.0152346130459, 989.248171389749, 9293.349465537347, 10888.836667449836, 11387.715307117389, 11513.078953683686, 11516.827247591125, 570109.0, 613189.0, 620993.0, 624405.0, 644743.0, 138116.30941845226, 143073.0, 146077.0, 146449.0, 147024.38390272463, 927.8422668146432, 949.1457688080783, 1012.4380968562518, 1019.0115587879596, 1024.5952848624752, 16684.749728753835, 18867.90566047161, 19566.510837229183, 20204.0, 20259.898700506405, 55741.16388254098, 56655.30034098984, 58530.707346462994, 60362.39637603568, 61440.38559614347, 77622.61188694247, 79393.0, 80439.19560804551, 81188.0, 81570.59214703889, 6298.811035668938, 7687.154413014452, 7931.920680793349, 8069.556174410463, 8272.710455134042, 10854.0, 13240.867591323964, 13261.204327740366, 13725.725485490433, 13734.793978090136, 11330.943345283551, 11511.366874821964, 11839.289642621126, 11852.881471185177, 11992.580259690869, 11243.887561124611, 11486.942565287454, 11527.250728702607, 11567.305961642329, 11846.229995050295, 11448.656540303804, 11765.941170294094, 11853.407329633656, 11887.346195959306, 12168.330741809286, 7893.565853878092, 7967.04395472547, 8040.557769322743, 8228.83542329138, 8430.6206220719, 8357.456765310235, 10979.83530247031, 11643.76712465729, 11711.063114950613, 11898.524059037542], "value": 9654.553884106523, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1431.3630434456663, 1487.509121989743, 1728.8876223045509, 1741.4514427955194, 1927.787943326234, 7280.0, 9378.765530861723, 9382.155605995458, 9384.483853388061, 9430.245580353572, 8183.877241841377, 8380.0, 8939.329550283723, 9025.774355641111, 9093.181613654786, 2411.6503107049466, 2436.683231179944, 2439.780419762221, 2440.5606990741658, 2448.2288079254977, 2410.048031027743, 2422.563938491071, 2460.2127319257843, 2462.91379801707, 2468.6543883856275, 2436.8294219404647, 2443.535728211643, 2454.8216855909086, 2461.704595448549, 2468.123816045305, 2418.3591348292716, 2420.745821688724, 2427.927162185137, 2428.295794219674, 2445.6698345723457, 2417.238569850509, 2435.6711843901203, 2441.4994926040117, 2441.9145329913367, 2478.1326535712537, 9129.77175570616, 9166.770830729218, 9243.722688319362, 9253.814923701555, 9268.397554159026, 5429.375621803503, 5596.048671725816, 5601.327840659147, 5601.467860553241, 5601.60788744788, 3625.963740362589, 3749.4000959846567, 3820.36963900956, 3861.4207868819904, 3863.8454461821493, 990.7869807991244, 1065.4512925843196, 1113.582406597526, 1122.3939072900623, 1143.6054561176381, 12364.567240146642, 12436.00511959041, 12461.127721059529, 12473.376331183405, 12475.126741128124, 3936.3111455495746, 4743.028370299747, 4750.524947505291, 4794.065157294364, 4923.818283611908, 10529.262951593468, 10530.05229529346, 10530.631427899987, 10532.789344213073, 10553.366797992145, 5503.559715222773, 5510.0632892408385, 5512.118061110203, 5515.806946756844, 5516.668999860021, 4590.977045114753, 4744.24092145262, 4984.40187177541, 5039.571636410873, 5073.822416215415, 3989.9601003989587, 4042.7776472293717, 4090.795460226977, 4125.628693417547, 4142.855000075043, 1284.5247258514223, 1295.378218455128, 1298.3832679477173, 1311.9737605247842, 1313.3302015971924, 810.4043528006911, 882.4793371910475, 910.9772255693529, 913.6939125393068, 930.1675000874179, 5944.583879128506, 5972.343042265347, 6064.393560643988, 6147.262328520606, 6202.255729312511, 927.5872236854535, 954.0936110694868, 968.7384406210284, 972.5720682899642, 1007.6725064354114, 3756.1736417988, 4006.399040144002, 4060.5939406059156, 4120.093579412584, 4137.627613514798, 11180.44097795107, 11392.0, 11520.423978801027, 11563.76872462546, 11565.595204167981, 11444.313341199555, 11447.54209831614, 11449.255798373079, 11459.656210313704, 11472.94263528677, 8286.212809783061, 8593.914060859437, 8606.397552171413, 8607.311415086779, 8759.693410730593, 6019.0, 6153.753849846135, 6154.107654390178, 6211.844703882439, 6266.151485311935, 10336.379817210991, 10514.316569422963, 10740.516676749721, 10745.731356716145, 10750.97865702757, 10474.52864621109, 10744.83882741744, 10746.301490403099, 10785.029347358775, 10969.0, 7247.927520724726, 7415.740449084256, 7776.766696999099, 7801.0, 7989.680412783424, 8612.397132200686, 8835.160659737314, 8875.644974200959, 8881.156290152425, 8884.955575222082, 7799.6100194988885, 7864.803379915548, 7911.920880791118, 8039.316658084128, 8057.879131813144, 7649.847003059796, 7741.0, 7758.146603873456, 7815.29662330393, 7816.804579885548, 7245.963770181115, 7367.115946086504, 7377.483576149618, 7382.0, 7388.298111679382, 5056.57019153376, 5092.898142037213, 5125.205593133071, 5242.292290540729, 5383.81156659515, 5125.461826508163, 5187.936473023096, 5281.128613778684, 5366.973165134149, 5429.755660995185], "value": 4778.761371439945, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [300.05781845006675, 301.6274900497886, 307.2962914924822, 312.375249500998, 313.7662441481097, 4727.747147006046, 4796.736179510125, 5303.416624171338, 5460.170842767672, 5465.262189604402, 4734.597559207472, 5227.320448341719, 5257.7108259045735, 5532.972335138319, 5543.447834606307, 3422.9559984204807, 3931.7247792654525, 4152.653750630899, 4238.57614238576, 4256.489221293449, 3353.8658453661824, 3632.0, 3677.9448308275396, 3886.417037444378, 4131.5455299916985, 3831.865884694036, 3907.4138879168067, 4107.876763697094, 4134.917301653965, 4135.684016950518, 3747.962520374816, 3779.9794055605107, 4058.5129784425912, 4143.399207114967, 4152.8131234094535, 3584.2473080653094, 3584.336897673939, 3598.1904071583945, 3632.6367363263726, 3635.7273204509765, 4791.7530304316715, 4815.927761083586, 5196.610254230948, 5277.445868183824, 5416.9729151353995, 4308.375285583573, 4517.6160026397465, 4657.813687452498, 4714.504976977402, 4762.38089048425, 4692.882677933045, 4759.904801903943, 5282.9170020145775, 5722.656640601577, 5788.97105514474, 3170.904872853795, 3542.5040494330815, 3620.4931309616672, 3731.776093434403, 3933.600503692745, 5219.895602087937, 6006.159137720766, 6043.546733994968, 6079.513638908877, 6117.0, 3945.447637330776, 3947.743396679207, 3949.624785645359, 3963.196745480799, 3996.4005399189773, 3909.8330352414637, 3996.3406038003986, 4023.7988100594853, 4033.789863041076, 4050.0482386639114, 3900.551436584772, 4636.473122148437, 4646.7444290564345, 4670.0, 4677.906441871211, 5037.269595908646, 5238.633295669267, 5881.0592504473425, 5882.411758824083, 5883.794067207627, 1090.8636420447444, 1277.6294874486296, 1317.3149962019888, 1326.0916272353277, 1329.1825527300834, 774.4075782026754, 789.1280135450245, 878.4114643189079, 909.6770646420558, 909.9545022748836, 4996.925046124311, 5399.3250843643755, 5463.48096930791, 5539.750711218005, 5619.7471113799975, 4891.63312751538, 5747.0, 5978.103284507359, 6012.909806352908, 6061.454469097803, 5648.576356773258, 5665.66006039639, 5675.0, 5696.772129114872, 5698.914516282176, 2492.1526680928573, 2620.2794231586086, 3083.537469379611, 3158.8894388696744, 3193.1857376368876, 5116.0, 5976.671283079386, 5977.6114552553945, 6167.753289868355, 6177.69111544421, 6086.548258845638, 6088.908666369919, 6113.724882380304, 6127.3259941407305, 6140.754369825247, 4774.832880849153, 5873.739656832868, 6170.382961703794, 6173.290071641729, 6237.656928868956, 5924.7037648118285, 6057.454829065406, 6081.0, 6084.140453986619, 6092.603980741238, 5878.412158784087, 5917.615355001911, 5939.673317967553, 5978.222831031938, 6029.51763858899, 4722.315264286728, 5405.48643381805, 6168.938310616836, 6245.533014459354, 6253.812385628438, 3498.8425520852134, 3944.5069366329208, 4006.158706671515, 4028.4360189574068, 4069.369247766601, 5105.757843769159, 5219.895602087861, 5485.314335708036, 5522.806701765419, 5749.0, 5902.468777810018, 5938.584299099021, 5967.701614919323, 5999.6700181488695, 6007.369226231358, 4901.41183058021, 5846.970765146147, 5946.821595352147, 6037.516998640011, 6081.574289799849, 5481.780728770805, 5570.0, 5712.143178523089, 5746.885062298647, 5789.2763404574425, 4521.886952826206, 5716.142578613241, 5821.515513544019, 5824.9708751457665, 5860.2967643883, 4578.436075797431, 5466.945330546644, 5689.743961521659, 5759.798407055733, 5811.854703632443], "value": 4177.511526404233, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [743.9479236453448, 760.9961950190249, 784.3881772217669, 809.4940662086196, 840.411711801739, 11722.882771172297, 14156.50452234172, 16256.296994813521, 16994.98030118194, 17138.914305428472, 15398.0, 15458.922705386485, 15596.766048509282, 15609.765853512177, 15635.0, 706.5795851468368, 868.053821334745, 895.5746020640208, 895.7268033249857, 898.4250079948838, 742.283696233135, 751.6204316820025, 752.4018405367718, 752.9548227106363, 754.1478129713416, 931.0689310689311, 958.3674774648733, 961.9567119479606, 964.3056998960737, 966.5408930757904, 958.2573505533198, 960.7934294126726, 962.8988956159642, 965.1651321606795, 965.2133511188359, 716.0726858717973, 716.8064622551882, 719.6617589732817, 720.4056653261028, 722.2596838240793, 15199.240037998166, 15418.537443876701, 15459.304331305118, 15492.45776397832, 15494.922525387414, 14528.128312301296, 14661.70676586473, 14693.265336733228, 14771.409143634242, 14835.406583736638, 13131.0808243423, 13454.125481843746, 13606.795898061537, 13646.658833529142, 13824.861751382457, 4679.74261415622, 4764.4759076501905, 4767.69010014348, 4800.399950006249, 4953.232249001375, 120127.0, 121604.39197804042, 127712.0, 127869.0, 131711.68288316994, 10727.517261723242, 11575.305481671126, 11747.647570572897, 11893.226940248856, 12082.275063496218, 23542.64686029711, 23575.93908274132, 23623.29130126099, 23634.7636523636, 23670.053197872236, 7740.690372385154, 7892.408069394818, 8044.477108987897, 8285.710000150086, 8469.661213551512, 4370.409994650681, 4439.711418757771, 4441.133978874153, 4590.540945905383, 4594.816207351735, 3565.7860528368383, 3677.3013127505687, 3681.5582130144553, 3682.3187710273687, 3703.2778608171147, 649.4317472211815, 652.885744994624, 657.5528640524394, 663.1942190238883, 673.6261374936958, 554.9944500554943, 596.8299034775068, 598.1028457314029, 665.3878431842717, 672.9192496900404, 8713.477191368538, 9518.190953768868, 9646.18007469373, 9659.420434773936, 9714.805703885882, 564.9463300986399, 578.4475825586554, 609.8228230916973, 647.1360733420936, 654.9312322206194, 4580.450345958439, 4585.472670642852, 4621.745803980746, 4639.396878405786, 4661.27750198713, 81893.18106818975, 109258.3611245832, 128181.0, 131327.68672313346, 178320.0, 113112.17219569412, 139365.0, 142136.57863421235, 145912.0, 147665.52334476518, 30856.074317770504, 83093.58453207817, 118697.40651296689, 121170.70049045753, 123009.76990229983, 8901.287896968357, 8928.330375221754, 8970.865437018581, 9044.728658140266, 9055.979428195511, 55948.72025639846, 64899.35100648933, 67845.96462106144, 67986.66006669935, 70279.29720702728, 63345.0, 66592.66703666451, 89730.0, 102754.0, 109016.0, 13645.863541364459, 13695.520656776966, 13885.583432497042, 13889.444422222998, 14191.0, 12585.93707031459, 12800.295983720986, 13210.867891321348, 15518.456854010055, 16643.41748038813, 12193.207441516273, 12247.510099595916, 12374.690632734253, 12485.31330776816, 12718.936405317914, 13971.790423143864, 14019.579412617637, 14094.859051409765, 14460.855391445952, 14638.634034149232, 13331.266780327174, 13628.0, 14021.088629239066, 14081.295935203403, 14083.507077252247, 11471.0, 11666.70833229142, 12035.45840437165, 12099.274043557414, 12132.454039568418, 8496.490210587384, 11654.70863228426, 11658.333374710439, 11841.526338946345, 11900.583479578174], "value": 7989.1738120535965, "unit": "score"}], "name": "dromaeo_css", "value": 7567.6633823606235, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 113.0, 114.0, 113.0, 113.0, 113.0, 112.0, 112.0, 114.0, 113.0], "value": 113.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 109.0, 108.0, 142.0, 105.0, 91.0, 111.0, 133.0, 172.0, 136.0], "value": 125.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [181.0, 183.0, 185.0, 185.0, 182.0, 181.0, 184.0, 183.0, 182.0, 182.0], "value": 182.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 69.0, 86.0, 114.0, 60.0, 58.0, 58.0, 58.0, 80.0, 59.0], "value": 72.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 71.0, 93.0, 69.0, 68.0, 68.0, 91.0, 67.0, 68.0, 88.0], "value": 76.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 86.0, 91.0, 85.0, 86.0, 83.0, 88.0, 83.0, 87.0, 84.0], "value": 86.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 94.0, 94.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 84.0, 85.0, 86.0, 86.0, 83.0, 86.0, 84.0, 95.0, 135.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 53.0, 52.0, 50.0, 55.0, 54.0, 56.0, 55.0, 57.0, 57.0], "value": 54.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 70.0, 72.0, 73.0, 69.0, 68.0, 67.0, 67.0, 68.0, 69.0], "value": 68.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 81.0, 83.0, 81.0, 82.0, 83.0, 85.0, 88.0, 88.0, 111.0], "value": 86.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 145.0, 148.0, 135.0, 149.0, 142.0, 133.0, 132.0, 133.0, 131.0], "value": 138.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 219.0, 198.0, 158.0, 159.0, 156.0, 157.0, 158.0, 156.0, 158.0], "value": 168.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 65.0, 63.0, 63.0, 62.0, 65.0, 64.0, 64.0, 65.0], "value": 64.0, "unit": "score"}], "name": "kraken", "value": 1428.0, "alertThreshold": 2.0}]} 12:41:47 INFO - Return code: 0 12:41:47 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:41:47 INFO - # TBPL SUCCESS # 12:41:47 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:41:47 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:41:47 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:41:47 INFO - 2016-11-14 12:41:47.266 screenresolution[2024:279416] starting screenresolution argv=screenresolution get 12:41:47 INFO - 2016-11-14 12:41:47.268 screenresolution[2024:279416] Display 0: 1600x1200x32@60 12:41:47 INFO - 2016-11-14 12:41:47.274 screenresolution[2025:279418] starting screenresolution argv=screenresolution list 12:41:47 INFO - Available Modes on Display 0 12:41:47 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:41:47 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:41:47 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:41:47 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:41:47 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:41:47 INFO - Intel Iris: 12:41:47 INFO - Chipset Model: Intel Iris 12:41:47 INFO - Type: GPU 12:41:47 INFO - Bus: Built-In 12:41:47 INFO - VRAM (Dynamic, Max): 1536 MB 12:41:47 INFO - Vendor: Intel (0x8086) 12:41:47 INFO - Device ID: 0x0a2e 12:41:47 INFO - Revision ID: 0x0009 12:41:47 INFO - Displays: 12:41:47 INFO - Display: 12:41:47 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:41:47 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:41:47 INFO - Display Serial Number: 1600x1200 60 12:41:47 INFO - Main Display: Yes 12:41:47 INFO - Mirror: Off 12:41:47 INFO - Online: Yes 12:41:47 INFO - Rotation: Supported 12:41:47 INFO - Return code: 0 12:41:47 INFO - Running post-action listener: _resource_record_post_action 12:41:47 INFO - [mozharness: 2016-11-14 20:41:47.508744Z] Finished run-tests step (success) 12:41:47 INFO - Running post-run listener: _resource_record_post_run 12:41:47 INFO - Total resource usage - Wall time: 1195s; CPU: 53.0%; Read bytes: 8863232; Write bytes: 493320192; Read time: 83; Write time: 1880 12:41:47 INFO - TinderboxPrint: CPU usage
53.1% 12:41:47 INFO - TinderboxPrint: I/O read bytes / time
8,863,232 / 83 12:41:47 INFO - TinderboxPrint: I/O write bytes / time
493,320,192 / 1,880 12:41:47 INFO - TinderboxPrint: CPU idle
2,240.7 (46.9%) 12:41:47 INFO - TinderboxPrint: CPU system
956.7 (20.0%) 12:41:47 INFO - TinderboxPrint: CPU user
1,584.3 (33.1%) 12:41:47 INFO - TinderboxPrint: Swap in / out
213,712,896 / 0 12:41:47 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 195873280; Write bytes: 197728256; Read time: 17981; Write time: 417 12:41:47 INFO - run-tests - Wall time: 1174s; CPU: 53.0%; Read bytes: 7876096; Write bytes: 294248448; Read time: 77; Write time: 1458 12:41:47 INFO - Running post-run listener: _upload_blobber_files 12:41:47 INFO - Blob upload gear active. 12:41:47 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:41:47 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 12:41:47 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'] 12:41:47 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 12:41:48 INFO - (blobuploader) - INFO - Open directory for files ... 12:41:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 12:41:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:41:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:41:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 12:41:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:41:49 INFO - (blobuploader) - INFO - Done attempting. 12:41:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 12:41:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:41:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:41:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 12:41:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:41:50 INFO - (blobuploader) - INFO - Done attempting. 12:41:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:41:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:41:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:41:53 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:41:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:41:53 INFO - (blobuploader) - INFO - Done attempting. 12:41:53 INFO - (blobuploader) - INFO - Iteration through files over. 12:41:53 INFO - Return code: 0 12:41:53 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:41:53 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:41:53 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/bf31d65119c3a363c878346035ed5e8ae60f681b9305f0135a2d8d683c3b57abc901b520fd2e0d758b3f69cc5edebbef32f098a8f5e3f4e85cd4c42fe985d764", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3dadff10fc2a97fc7131925f5f7b58a393833f6ee29568baf1f793f68bc043de13dd6c55903a11161bc618d310d5963676a8db3650d27ba866c409bbee08fd9d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/eafab7ae4d5fe832de318f70f440ebe72393b760086e7662bdbf4fb8ace356a60646523066563b65f2d2b1565076653ad4d7fc7cc1f3eb5d7b573fa347d4f53d"} 12:41:53 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:41:53 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:41:53 INFO - Contents: 12:41:53 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/bf31d65119c3a363c878346035ed5e8ae60f681b9305f0135a2d8d683c3b57abc901b520fd2e0d758b3f69cc5edebbef32f098a8f5e3f4e85cd4c42fe985d764", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3dadff10fc2a97fc7131925f5f7b58a393833f6ee29568baf1f793f68bc043de13dd6c55903a11161bc618d310d5963676a8db3650d27ba866c409bbee08fd9d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/eafab7ae4d5fe832de318f70f440ebe72393b760086e7662bdbf4fb8ace356a60646523066563b65f2d2b1565076653ad4d7fc7cc1f3eb5d7b573fa347d4f53d"} 12:41:53 INFO - Running post-run listener: copy_logs_to_upload_dir 12:41:53 INFO - Copying logs to upload dir... 12:41:53 INFO - mkdir: /builds/slave/test/build/upload/logs 12:41:53 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1253.516825 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2016-11-14 12:41:53.089159) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-14 12:41:53.092423) ========= 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.Y37dyXiUSe/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.rUdauvgPtK/Listeners TMPDIR=/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/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/bf31d65119c3a363c878346035ed5e8ae60f681b9305f0135a2d8d683c3b57abc901b520fd2e0d758b3f69cc5edebbef32f098a8f5e3f4e85cd4c42fe985d764", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3dadff10fc2a97fc7131925f5f7b58a393833f6ee29568baf1f793f68bc043de13dd6c55903a11161bc618d310d5963676a8db3650d27ba866c409bbee08fd9d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/eafab7ae4d5fe832de318f70f440ebe72393b760086e7662bdbf4fb8ace356a60646523066563b65f2d2b1565076653ad4d7fc7cc1f3eb5d7b573fa347d4f53d"} build_url:https://queue.taskcluster.net/v1/task/IwhJdfYOTniFWpjGgcwpMQ/artifacts/public/build/firefox-51.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011118 build_url: 'https://queue.taskcluster.net/v1/task/IwhJdfYOTniFWpjGgcwpMQ/artifacts/public/build/firefox-51.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/bf31d65119c3a363c878346035ed5e8ae60f681b9305f0135a2d8d683c3b57abc901b520fd2e0d758b3f69cc5edebbef32f098a8f5e3f4e85cd4c42fe985d764", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3dadff10fc2a97fc7131925f5f7b58a393833f6ee29568baf1f793f68bc043de13dd6c55903a11161bc618d310d5963676a8db3650d27ba866c409bbee08fd9d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/eafab7ae4d5fe832de318f70f440ebe72393b760086e7662bdbf4fb8ace356a60646523066563b65f2d2b1565076653ad4d7fc7cc1f3eb5d7b573fa347d4f53d"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-14 12:41:53.126419) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 12:41:53.126825) ========= 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.Y37dyXiUSe/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.rUdauvgPtK/Listeners TMPDIR=/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/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.005089 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 12:41:53.175808) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-14 12:41:53.176135) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-14 12:41:53.176469) ========= ========= Total master_lag: 0.18 =========