builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0273 starttime: 1482383778.46 results: success (0) buildid: 20161221200752 builduid: 14b18faa8bd04dae8dafa9906aacc197 revision: 67d97463e755c0987c8bf452bb6fe9b733621409 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-21 21:16:18.464403) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-21 21:16:18.464858) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-21 21:16:18.465146) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-21 21:16:18.490089) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-21 21:16:18.490391) ========= 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.3rpVj1KJlS/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.5lI1E4LAZQ/Listeners TMPDIR=/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/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-12-21 21:16:18-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 13.1M=0.001s 2016-12-21 21:16:18 (13.1 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.121385 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-21 21:16:18.635489) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-21 21:16:18.635800) ========= 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.3rpVj1KJlS/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.5lI1E4LAZQ/Listeners TMPDIR=/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/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.019826 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-21 21:16:18.685015) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-21 21:16:18.685377) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 67d97463e755c0987c8bf452bb6fe9b733621409 --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 67d97463e755c0987c8bf452bb6fe9b733621409 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.3rpVj1KJlS/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.5lI1E4LAZQ/Listeners TMPDIR=/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/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-12-21 21:16:18,766 truncating revision to first 12 chars 2016-12-21 21:16:18,766 Setting DEBUG logging. 2016-12-21 21:16:18,766 attempt 1/10 2016-12-21 21:16:18,766 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/67d97463e755?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-21 21:16:20,268 unpacking tar archive at: mozilla-beta-67d97463e755/testing/mozharness/ program finished with exit code 0 elapsedTime=1.811108 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-21 21:16:20.519935) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-21 21:16:20.520293) ========= script_repo_revision: 67d97463e755c0987c8bf452bb6fe9b733621409 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-21 21:16:20.520682) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-21 21:16:20.520946) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-21 21:16:20.540683) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2016-12-21 21:16:20.541042) ========= /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.3rpVj1KJlS/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.5lI1E4LAZQ/Listeners TMPDIR=/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/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 21:16:20 INFO - MultiFileLogger online at 20161221 21:16:20 in /builds/slave/test 21:16:20 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 21:16:20 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:16:20 INFO - {'append_to_log': False, 21:16:20 INFO - 'base_work_dir': '/builds/slave/test', 21:16:20 INFO - 'blob_upload_branch': 'Mozilla-Beta', 21:16:20 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:16:20 INFO - 'branch': 'Mozilla-Beta', 21:16:20 INFO - 'buildbot_json_path': 'buildprops.json', 21:16:20 INFO - 'config_files': ('talos/mac_config.py',), 21:16:20 INFO - 'default_actions': ('clobber', 21:16:20 INFO - 'read-buildbot-config', 21:16:20 INFO - 'download-and-extract', 21:16:20 INFO - 'populate-webroot', 21:16:20 INFO - 'create-virtualenv', 21:16:20 INFO - 'install', 21:16:20 INFO - 'run-tests'), 21:16:20 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:16:20 INFO - 'download_minidump_stackwalk': True, 21:16:20 INFO - 'download_symbols': 'ondemand', 21:16:20 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:16:20 INFO - 'tooltool.py': '/tools/tooltool.py', 21:16:20 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:16:20 INFO - '/tools/misc-python/virtualenv.py')}, 21:16:20 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:16:20 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:16:20 INFO - 'installer_path': 'installer.exe', 21:16:20 INFO - 'log_level': 'info', 21:16:20 INFO - 'log_name': 'talos', 21:16:20 INFO - 'log_to_console': True, 21:16:20 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 21:16:20 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 21:16:20 INFO - 'opt_config_files': (), 21:16:20 INFO - 'pip_index': False, 21:16:20 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 21:16:20 INFO - 'cmd': ('bash', 21:16:20 INFO - '-c', 21:16:20 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 21:16:20 INFO - 'enabled': True, 21:16:20 INFO - 'halt_on_failure': False, 21:16:20 INFO - 'name': 'check_screen_resolution'},), 21:16:20 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 21:16:20 INFO - 'cmd': ('bash', 21:16:20 INFO - '-c', 21:16:20 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 21:16:20 INFO - 'enabled': True, 21:16:20 INFO - 'halt_on_failure': False, 21:16:20 INFO - 'name': 'check_screen_resolution'},), 21:16:20 INFO - 'run_cmd_checks_enabled': True, 21:16:20 INFO - 'sps_profile': False, 21:16:20 INFO - 'sps_profile_interval': 0, 21:16:20 INFO - 'suite': 'dromaeojs', 21:16:20 INFO - 'system_bits': '32', 21:16:20 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:16:20 INFO - 'title': 't-yosemite-r7-0273', 21:16:20 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:16:20 INFO - 'use_talos_json': True, 21:16:20 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:16:20 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:16:20 INFO - 'work_dir': 'build'} 21:16:20 INFO - [mozharness: 2016-12-22 05:16:20.737701Z] Running clobber step. 21:16:20 INFO - Running pre-action listener: _resource_record_pre_action 21:16:20 INFO - Running main action method: clobber 21:16:20 INFO - rmtree: /builds/slave/test/build 21:16:20 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:16:21 INFO - Running post-action listener: _resource_record_post_action 21:16:21 INFO - [mozharness: 2016-12-22 05:16:21.392079Z] Finished clobber step (success) 21:16:21 INFO - [mozharness: 2016-12-22 05:16:21.392197Z] Running read-buildbot-config step. 21:16:21 INFO - Running pre-action listener: _resource_record_pre_action 21:16:21 INFO - Running main action method: read_buildbot_config 21:16:21 INFO - Using buildbot properties: 21:16:21 INFO - { 21:16:21 INFO - "project": "", 21:16:21 INFO - "product": "firefox", 21:16:21 INFO - "script_repo_revision": "production", 21:16:21 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 21:16:21 INFO - "repository": "", 21:16:21 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 21:16:21 INFO - "buildid": "20161221200752", 21:16:21 INFO - "pgo_build": "False", 21:16:21 INFO - "basedir": "/builds/slave/test", 21:16:21 INFO - "buildnumber": 96, 21:16:21 INFO - "slavename": "t-yosemite-r7-0273", 21:16:21 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 21:16:21 INFO - "platform": "yosemite_r7", 21:16:21 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 21:16:21 INFO - "branch": "mozilla-beta", 21:16:21 INFO - "repo_path": "releases/mozilla-beta", 21:16:21 INFO - "revision": "67d97463e755c0987c8bf452bb6fe9b733621409", 21:16:21 INFO - "stage_platform": "macosx64", 21:16:21 INFO - "builduid": "14b18faa8bd04dae8dafa9906aacc197", 21:16:21 INFO - "slavebuilddir": "test" 21:16:21 INFO - } 21:16:21 INFO - Found installer url https://queue.taskcluster.net/v1/task/ZEuTLy-ST1-mj_UyD7eIxQ/artifacts/public/build/firefox-51.0.en-US.mac.dmg. 21:16:21 INFO - Running post-action listener: _resource_record_post_action 21:16:21 INFO - [mozharness: 2016-12-22 05:16:21.395469Z] Finished read-buildbot-config step (success) 21:16:21 INFO - [mozharness: 2016-12-22 05:16:21.395600Z] Running download-and-extract step. 21:16:21 INFO - Running pre-action listener: _resource_record_pre_action 21:16:21 INFO - Running main action method: download_and_extract 21:16:21 INFO - mkdir: /builds/slave/test/build/tests 21:16:21 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')]} 21:16:21 INFO - trying https://queue.taskcluster.net/v1/task/ZEuTLy-ST1-mj_UyD7eIxQ/artifacts/public/build/firefox-51.0.en-US.mac.test_packages.json 21:16:21 INFO - Downloading https://queue.taskcluster.net/v1/task/ZEuTLy-ST1-mj_UyD7eIxQ/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 21:16:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZEuTLy-ST1-mj_UyD7eIxQ/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 21:16:22 INFO - Downloaded 1165 bytes. 21:16:22 INFO - Reading from file /builds/slave/test/build/firefox-51.0.en-US.mac.test_packages.json 21:16:22 INFO - Using the following test package requirements: 21:16:22 INFO - {u'common': [u'firefox-51.0.en-US.mac.common.tests.zip'], 21:16:22 INFO - u'cppunittest': [u'firefox-51.0.en-US.mac.common.tests.zip', 21:16:22 INFO - u'firefox-51.0.en-US.mac.cppunittest.tests.zip'], 21:16:22 INFO - u'gtest': [u'firefox-51.0.en-US.mac.common.tests.zip', 21:16:22 INFO - u'firefox-51.0.en-US.mac.gtest.tests.zip'], 21:16:22 INFO - u'jittest': [u'firefox-51.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 21:16:22 INFO - u'mochitest': [u'firefox-51.0.en-US.mac.common.tests.zip', 21:16:22 INFO - u'firefox-51.0.en-US.mac.mochitest.tests.zip'], 21:16:22 INFO - u'mozbase': [u'firefox-51.0.en-US.mac.common.tests.zip'], 21:16:22 INFO - u'reftest': [u'firefox-51.0.en-US.mac.common.tests.zip', 21:16:22 INFO - u'firefox-51.0.en-US.mac.reftest.tests.zip'], 21:16:22 INFO - u'talos': [u'firefox-51.0.en-US.mac.common.tests.zip', 21:16:22 INFO - u'firefox-51.0.en-US.mac.talos.tests.zip'], 21:16:22 INFO - u'web-platform': [u'firefox-51.0.en-US.mac.common.tests.zip', 21:16:22 INFO - u'firefox-51.0.en-US.mac.web-platform.tests.zip'], 21:16:22 INFO - u'xpcshell': [u'firefox-51.0.en-US.mac.common.tests.zip', 21:16:22 INFO - u'firefox-51.0.en-US.mac.xpcshell.tests.zip']} 21:16:22 INFO - Downloading packages: [u'firefox-51.0.en-US.mac.common.tests.zip'] for test suite category: common 21:16:22 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZEuTLy-ST1-mj_UyD7eIxQ/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip 21:16:22 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZEuTLy-ST1-mj_UyD7eIxQ/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip'}, attempt #1 21:16:22 INFO - Fetch https://queue.taskcluster.net/v1/task/ZEuTLy-ST1-mj_UyD7eIxQ/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip into memory 21:16:23 INFO - Expected file size: 16232550 21:16:30 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 21:16:30 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZEuTLy-ST1-mj_UyD7eIxQ/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip 21:16:30 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZEuTLy-ST1-mj_UyD7eIxQ/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip'}, attempt #1 21:16:30 INFO - Fetch https://queue.taskcluster.net/v1/task/ZEuTLy-ST1-mj_UyD7eIxQ/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip into memory 21:16:30 INFO - Expected file size: 16232550 21:16:37 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZEuTLy-ST1-mj_UyD7eIxQ/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip 21:16:37 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZEuTLy-ST1-mj_UyD7eIxQ/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip'}, attempt #1 21:16:37 INFO - Fetch https://queue.taskcluster.net/v1/task/ZEuTLy-ST1-mj_UyD7eIxQ/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip into memory 21:16:38 INFO - Expected file size: 14414089 21:16:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:16:38 INFO - trying https://queue.taskcluster.net/v1/task/ZEuTLy-ST1-mj_UyD7eIxQ/artifacts/public/build/firefox-51.0.en-US.mac.dmg 21:16:38 INFO - Downloading https://queue.taskcluster.net/v1/task/ZEuTLy-ST1-mj_UyD7eIxQ/artifacts/public/build/firefox-51.0.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0.en-US.mac.dmg 21:16:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZEuTLy-ST1-mj_UyD7eIxQ/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 21:16:41 INFO - Downloaded 86062125 bytes. 21:16:41 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZEuTLy-ST1-mj_UyD7eIxQ/artifacts/public/build/firefox-51.0.en-US.mac.dmg 21:16:41 INFO - mkdir: /builds/slave/test/properties 21:16:41 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:16:41 INFO - Writing to file /builds/slave/test/properties/build_url 21:16:41 INFO - Contents: 21:16:41 INFO - build_url:https://queue.taskcluster.net/v1/task/ZEuTLy-ST1-mj_UyD7eIxQ/artifacts/public/build/firefox-51.0.en-US.mac.dmg 21:16:41 INFO - Running post-action listener: _resource_record_post_action 21:16:41 INFO - Running post-action listener: set_extra_try_arguments 21:16:41 INFO - [mozharness: 2016-12-22 05:16:41.830359Z] Finished download-and-extract step (success) 21:16:41 INFO - [mozharness: 2016-12-22 05:16:41.830482Z] Running populate-webroot step. 21:16:41 INFO - Running pre-action listener: _resource_record_pre_action 21:16:41 INFO - Running main action method: populate_webroot 21:16:41 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:16:41 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:16:41 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:16:41 INFO - '--tppagecycles', 21:16:41 INFO - '7'], 21:16:41 INFO - 'tests': ['tsvgm']}}, 21:16:41 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 21:16:41 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:16:41 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:16:41 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 21:16:41 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:16:41 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:16:41 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:16:41 INFO - 'talos_options': ['--disable-e10s'], 21:16:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:16:41 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:16:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:16:41 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:16:41 INFO - 'talos_options': ['--disable-e10s'], 21:16:41 INFO - 'tests': ['damp', 'tps']}, 21:16:41 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:16:41 INFO - 'tests': ['damp', 'tps']}, 21:16:41 INFO - 'g3': {'talos_options': ['--disable-e10s'], 21:16:41 INFO - 'tests': ['dromaeo_dom']}, 21:16:41 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:16:41 INFO - 'g4': {'talos_options': ['--disable-e10s'], 21:16:41 INFO - 'tests': ['basic_compositor_video']}, 21:16:41 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 21:16:41 INFO - 'other': {'talos_options': ['--disable-e10s'], 21:16:41 INFO - 'tests': ['a11yr', 21:16:41 INFO - 'ts_paint', 21:16:41 INFO - 'tpaint', 21:16:41 INFO - 'sessionrestore', 21:16:41 INFO - 'sessionrestore_no_auto_restore', 21:16:41 INFO - 'tabpaint']}, 21:16:41 INFO - 'other-e10s': {'tests': ['a11yr', 21:16:41 INFO - 'ts_paint', 21:16:41 INFO - 'tpaint', 21:16:41 INFO - 'sessionrestore', 21:16:41 INFO - 'sessionrestore_no_auto_restore', 21:16:41 INFO - 'tabpaint']}, 21:16:41 INFO - 'other-e10s_l64': {'tests': ['a11yr', 21:16:41 INFO - 'ts_paint', 21:16:41 INFO - 'tpaint', 21:16:41 INFO - 'sessionrestore', 21:16:41 INFO - 'sessionrestore_no_auto_restore', 21:16:41 INFO - 'tabpaint']}, 21:16:41 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 21:16:41 INFO - 'ts_paint', 21:16:41 INFO - 'tpaint', 21:16:41 INFO - 'sessionrestore', 21:16:41 INFO - 'sessionrestore_no_auto_restore', 21:16:41 INFO - 'tabpaint']}, 21:16:41 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 21:16:41 INFO - 'tests': ['a11yr', 21:16:41 INFO - 'ts_paint', 21:16:41 INFO - 'tpaint', 21:16:41 INFO - 'sessionrestore', 21:16:41 INFO - 'sessionrestore_no_auto_restore', 21:16:41 INFO - 'tabpaint']}, 21:16:41 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 21:16:41 INFO - 'tests': ['a11yr', 21:16:41 INFO - 'ts_paint', 21:16:41 INFO - 'tpaint', 21:16:41 INFO - 'sessionrestore', 21:16:41 INFO - 'sessionrestore_no_auto_restore', 21:16:41 INFO - 'tabpaint']}, 21:16:41 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 21:16:41 INFO - 'tests': ['tsvgx', 21:16:41 INFO - 'tsvgr_opacity', 21:16:41 INFO - 'tart', 21:16:41 INFO - 'tscrollx', 21:16:41 INFO - 'cart']}, 21:16:41 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:16:41 INFO - 'tsvgr_opacity', 21:16:41 INFO - 'tart', 21:16:41 INFO - 'tscrollx', 21:16:41 INFO - 'cart']}, 21:16:41 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:16:41 INFO - 'talos_options': ['--disable-e10s'], 21:16:41 INFO - 'tests': ['tp5o']}, 21:16:41 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:16:41 INFO - 'tests': ['tp5o']}, 21:16:41 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:16:41 INFO - 'talos_options': ['--disable-e10s', 21:16:41 INFO - '--xperf_path', 21:16:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:16:41 INFO - 'tests': ['tp5n']}, 21:16:41 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:16:41 INFO - 'talos_options': ['--xperf_path', 21:16:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:16:41 INFO - 'tests': ['tp5n']}}, 21:16:41 INFO - 'talos.zip': {'path': '', 21:16:41 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:16:41 INFO - Running post-action listener: _resource_record_post_action 21:16:41 INFO - [mozharness: 2016-12-22 05:16:41.849288Z] Finished populate-webroot step (success) 21:16:41 INFO - [mozharness: 2016-12-22 05:16:41.849425Z] Running create-virtualenv step. 21:16:41 INFO - Running pre-action listener: _resource_record_pre_action 21:16:41 INFO - Running main action method: create_virtualenv 21:16:41 INFO - Creating virtualenv /builds/slave/test/build/venv 21:16:41 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 21:16:41 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:16:41 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:16:41 INFO - Using real prefix '/tools/python27' 21:16:41 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:16:42 INFO - Installing distribute.............................................................................................................................................................................................done. 21:16:45 INFO - Installing pip.................done. 21:16:45 INFO - Return code: 0 21:16:45 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:16: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')]} 21:16:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:16:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:16: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')]} 21:16:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:16:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:16:45 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 0x109088490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108ffe570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdd53c694d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108e9cd30>, '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 0x108d02db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108e94b20>, '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.3rpVj1KJlS/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.5lI1E4LAZQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/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 21:16:45 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 21:16:45 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 21:16:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3rpVj1KJlS/Render', 21:16:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:16:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:16:45 INFO - 'HOME': '/Users/cltbld', 21:16:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:16:45 INFO - 'LOGNAME': 'cltbld', 21:16:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:16:45 INFO - 'MOZ_NO_REMOTE': '1', 21:16:45 INFO - 'NO_EM_RESTART': '1', 21:16:45 INFO - 'PAGER': '/bin/cat', 21:16:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:16:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:16:45 INFO - 'PWD': '/builds/slave/test', 21:16:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:16:45 INFO - 'SHELL': '/bin/bash', 21:16:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5lI1E4LAZQ/Listeners', 21:16:45 INFO - 'TMPDIR': '/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/', 21:16:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:16:45 INFO - 'USER': 'cltbld', 21:16:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:16:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:16:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:16:45 INFO - 'XPC_FLAGS': '0x0', 21:16:45 INFO - 'XPC_SERVICE_NAME': '0', 21:16:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:16:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:16:45 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 21:16:45 INFO - Cleaning up... 21:16:45 INFO - Return code: 0 21:16:45 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 21:16: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')]} 21:16:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:16:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:16: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')]} 21:16:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:16:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:16:45 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 0x109088490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108ffe570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdd53c694d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108e9cd30>, '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 0x108d02db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108e94b20>, '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.3rpVj1KJlS/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.5lI1E4LAZQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/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 21:16:45 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 21:16:45 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 21:16:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3rpVj1KJlS/Render', 21:16:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:16:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:16:45 INFO - 'HOME': '/Users/cltbld', 21:16:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:16:45 INFO - 'LOGNAME': 'cltbld', 21:16:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:16:45 INFO - 'MOZ_NO_REMOTE': '1', 21:16:45 INFO - 'NO_EM_RESTART': '1', 21:16:45 INFO - 'PAGER': '/bin/cat', 21:16:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:16:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:16:45 INFO - 'PWD': '/builds/slave/test', 21:16:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:16:45 INFO - 'SHELL': '/bin/bash', 21:16:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5lI1E4LAZQ/Listeners', 21:16:45 INFO - 'TMPDIR': '/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/', 21:16:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:16:45 INFO - 'USER': 'cltbld', 21:16:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:16:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:16:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:16:45 INFO - 'XPC_FLAGS': '0x0', 21:16:45 INFO - 'XPC_SERVICE_NAME': '0', 21:16:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:16:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:16:46 INFO - Downloading/unpacking psutil>=3.1.1 21:16:46 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 21:16:46 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 21:16:46 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 21:16:46 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 21:16:46 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 21:16:46 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 21:16:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:16:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:16:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:16:49 INFO - Installing collected packages: psutil 21:16:49 INFO - Running setup.py install for psutil 21:16:49 INFO - building 'psutil._psutil_osx' extension 21:16:49 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 21:16:49 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 21:16:49 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 21:16:49 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 21:16:50 INFO - building 'psutil._psutil_posix' extension 21:16:50 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 21:16:50 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 21:16:50 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 21:16:50 INFO - ^ 21:16:50 INFO - 1 warning generated. 21:16:50 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 21:16:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:16:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:16:50 INFO - Successfully installed psutil 21:16:50 INFO - Cleaning up... 21:16:50 INFO - Return code: 0 21:16:50 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 21:16: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')]} 21:16:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:16:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:16: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')]} 21:16:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:16:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:16: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109088490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108ffe570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdd53c694d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108e9cd30>, '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 0x108d02db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108e94b20>, '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.3rpVj1KJlS/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.5lI1E4LAZQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/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 21:16: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 21:16: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 mozsystemmonitor==0.3 21:16:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3rpVj1KJlS/Render', 21:16:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:16:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:16:50 INFO - 'HOME': '/Users/cltbld', 21:16:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:16:50 INFO - 'LOGNAME': 'cltbld', 21:16:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:16:50 INFO - 'MOZ_NO_REMOTE': '1', 21:16:50 INFO - 'NO_EM_RESTART': '1', 21:16:50 INFO - 'PAGER': '/bin/cat', 21:16:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:16:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:16:50 INFO - 'PWD': '/builds/slave/test', 21:16:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:16:50 INFO - 'SHELL': '/bin/bash', 21:16:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5lI1E4LAZQ/Listeners', 21:16:50 INFO - 'TMPDIR': '/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/', 21:16:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:16:50 INFO - 'USER': 'cltbld', 21:16:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:16:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:16:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:16:50 INFO - 'XPC_FLAGS': '0x0', 21:16:50 INFO - 'XPC_SERVICE_NAME': '0', 21:16:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:16:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:16:50 INFO - Downloading/unpacking mozsystemmonitor==0.3 21:16:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:16:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:16:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:16:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:16:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:16:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:16:53 INFO - Downloading mozsystemmonitor-0.3.tar.gz 21:16:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:16:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 21:16:53 INFO - Installing collected packages: mozsystemmonitor 21:16:53 INFO - Running setup.py install for mozsystemmonitor 21:16:53 INFO - Successfully installed mozsystemmonitor 21:16:53 INFO - Cleaning up... 21:16:53 INFO - Return code: 0 21:16:53 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 21:16:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:16:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:16:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:16:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:16:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:16:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:16:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x109088490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108ffe570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdd53c694d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108e9cd30>, '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 0x108d02db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108e94b20>, '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.3rpVj1KJlS/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.5lI1E4LAZQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/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 21:16:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 21:16:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 21:16:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3rpVj1KJlS/Render', 21:16:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:16:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:16:53 INFO - 'HOME': '/Users/cltbld', 21:16:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:16:53 INFO - 'LOGNAME': 'cltbld', 21:16:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:16:53 INFO - 'MOZ_NO_REMOTE': '1', 21:16:53 INFO - 'NO_EM_RESTART': '1', 21:16:53 INFO - 'PAGER': '/bin/cat', 21:16:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:16:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:16:53 INFO - 'PWD': '/builds/slave/test', 21:16:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:16:53 INFO - 'SHELL': '/bin/bash', 21:16:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5lI1E4LAZQ/Listeners', 21:16:53 INFO - 'TMPDIR': '/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/', 21:16:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:16:53 INFO - 'USER': 'cltbld', 21:16:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:16:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:16:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:16:53 INFO - 'XPC_FLAGS': '0x0', 21:16:53 INFO - 'XPC_SERVICE_NAME': '0', 21:16:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:16:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:16:53 INFO - Downloading/unpacking jsonschema==2.5.1 21:16:53 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 21:16:53 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 21:16:53 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 21:16:53 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 21:16:53 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 21:16:53 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 21:16:56 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:16:56 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 21:16:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:16:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:16:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:16:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:16:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:16:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:16:56 INFO - Downloading functools32-3.2.3-2.tar.gz 21:16:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:16:57 INFO - warning: no files found matching '*.txt' 21:16:57 INFO - no previously-included directories found matching 'build' 21:16:57 INFO - no previously-included directories found matching 'dist' 21:16:57 INFO - no previously-included directories found matching '.git*' 21:16:57 INFO - Installing collected packages: jsonschema, functools32 21:16:57 INFO - Running setup.py install for functools32 21:16:57 INFO - warning: no files found matching '*.txt' 21:16:57 INFO - no previously-included directories found matching 'build' 21:16:57 INFO - no previously-included directories found matching 'dist' 21:16:57 INFO - no previously-included directories found matching '.git*' 21:16:57 INFO - Successfully installed jsonschema functools32 21:16:57 INFO - Cleaning up... 21:16:57 INFO - Return code: 0 21:16:57 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 21:16:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:16:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:16:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:16:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:16:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:16:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:16:57 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 0x109088490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108ffe570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdd53c694d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108e9cd30>, '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 0x108d02db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108e94b20>, '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.3rpVj1KJlS/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.5lI1E4LAZQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/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 21:16:57 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 21:16:57 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 21:16:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3rpVj1KJlS/Render', 21:16:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:16:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:16:57 INFO - 'HOME': '/Users/cltbld', 21:16:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:16:57 INFO - 'LOGNAME': 'cltbld', 21:16:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:16:57 INFO - 'MOZ_NO_REMOTE': '1', 21:16:57 INFO - 'NO_EM_RESTART': '1', 21:16:57 INFO - 'PAGER': '/bin/cat', 21:16:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:16:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:16:57 INFO - 'PWD': '/builds/slave/test', 21:16:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:16:57 INFO - 'SHELL': '/bin/bash', 21:16:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5lI1E4LAZQ/Listeners', 21:16:57 INFO - 'TMPDIR': '/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/', 21:16:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:16:57 INFO - 'USER': 'cltbld', 21:16:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:16:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:16:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:16:57 INFO - 'XPC_FLAGS': '0x0', 21:16:57 INFO - 'XPC_SERVICE_NAME': '0', 21:16:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:16:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:16:57 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 21:16:57 INFO - Cleaning up... 21:16:57 INFO - Return code: 0 21:16:57 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:16:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:16:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:16:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:16:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:16:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:16:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:16:57 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 0x109088490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108ffe570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdd53c694d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108e9cd30>, '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 0x108d02db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108e94b20>, '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.3rpVj1KJlS/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.5lI1E4LAZQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/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 21:16:57 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 21:16:57 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 21:16:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3rpVj1KJlS/Render', 21:16:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:16:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:16:57 INFO - 'HOME': '/Users/cltbld', 21:16:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:16:57 INFO - 'LOGNAME': 'cltbld', 21:16:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:16:57 INFO - 'MOZ_NO_REMOTE': '1', 21:16:57 INFO - 'NO_EM_RESTART': '1', 21:16:57 INFO - 'PAGER': '/bin/cat', 21:16:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:16:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:16:57 INFO - 'PWD': '/builds/slave/test', 21:16:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:16:57 INFO - 'SHELL': '/bin/bash', 21:16:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5lI1E4LAZQ/Listeners', 21:16:57 INFO - 'TMPDIR': '/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/', 21:16:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:16:57 INFO - 'USER': 'cltbld', 21:16:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:16:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:16:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:16:57 INFO - 'XPC_FLAGS': '0x0', 21:16:57 INFO - 'XPC_SERVICE_NAME': '0', 21:16:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:16:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:16:57 INFO - Downloading/unpacking blobuploader==1.2.4 21:16:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:16:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:16:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:16:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:16:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:16:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:17:00 INFO - Downloading blobuploader-1.2.4.tar.gz 21:17:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:17:00 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:17:00 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 21:17:00 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 21:17:00 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 21:17:00 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 21:17:00 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 21:17:00 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 21:17:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:17:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:17:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:17:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:17:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:17:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:17:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:17:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:17:01 INFO - Downloading docopt-0.6.1.tar.gz 21:17:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:17:01 INFO - Installing collected packages: blobuploader, requests, docopt 21:17:01 INFO - Running setup.py install for blobuploader 21:17:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:17:01 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:17:01 INFO - Running setup.py install for requests 21:17:02 INFO - Running setup.py install for docopt 21:17:02 INFO - Successfully installed blobuploader requests docopt 21:17:02 INFO - Cleaning up... 21:17:02 INFO - Return code: 0 21:17:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:17:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:17:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:17:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:17:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:17:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:17:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:17:02 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 0x109088490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108ffe570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdd53c694d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108e9cd30>, '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 0x108d02db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108e94b20>, '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.3rpVj1KJlS/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.5lI1E4LAZQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/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 21:17:02 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 21:17:02 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 21:17:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3rpVj1KJlS/Render', 21:17:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:17:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:17:02 INFO - 'HOME': '/Users/cltbld', 21:17:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:17:02 INFO - 'LOGNAME': 'cltbld', 21:17:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:17:02 INFO - 'MOZ_NO_REMOTE': '1', 21:17:02 INFO - 'NO_EM_RESTART': '1', 21:17:02 INFO - 'PAGER': '/bin/cat', 21:17:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:17:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:17:02 INFO - 'PWD': '/builds/slave/test', 21:17:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:17:02 INFO - 'SHELL': '/bin/bash', 21:17:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5lI1E4LAZQ/Listeners', 21:17:02 INFO - 'TMPDIR': '/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/', 21:17:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:17:02 INFO - 'USER': 'cltbld', 21:17:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:17:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:17:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:17:02 INFO - 'XPC_FLAGS': '0x0', 21:17:02 INFO - 'XPC_SERVICE_NAME': '0', 21:17:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:17:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:17:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:17:02 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-N2XCzq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:17:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:17:03 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-DQB30j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:17:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:17:03 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-FjCGBW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:17:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:17:03 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-fU4GY6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:17:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:17:03 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-mvjp7J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:17:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:17:03 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-SuJv5C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:17:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:17:03 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-hJLQOx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:17:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:17:03 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-s5ayn5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:17:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:17:03 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-iznDw2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:17:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:17:03 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-6kgSDa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:17:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:17:03 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-on9q9V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:17:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:17:04 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-hvCxqD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:17:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:17:04 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-eUh_ih-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:17:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:17:04 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-NM4vFd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:17:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:17:04 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-k0LpRD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:17:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:17:04 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-bh8Niq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:17:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:17:04 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-baAKDB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:17:04 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:17:04 INFO - Running setup.py install for manifestparser 21:17:04 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:17:04 INFO - Running setup.py install for mozcrash 21:17:05 INFO - Running setup.py install for mozdebug 21:17:05 INFO - Running setup.py install for mozdevice 21:17:05 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 21:17:05 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:17:05 INFO - Running setup.py install for mozfile 21:17:05 INFO - Running setup.py install for mozhttpd 21:17:05 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:17:05 INFO - Running setup.py install for mozinfo 21:17:05 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:17:05 INFO - Running setup.py install for mozInstall 21:17:05 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:17:05 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:17:05 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:17:05 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:17:05 INFO - Running setup.py install for mozleak 21:17:06 INFO - Running setup.py install for mozlog 21:17:06 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:17:06 INFO - Running setup.py install for moznetwork 21:17:06 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:17:06 INFO - Running setup.py install for mozprocess 21:17:06 INFO - Running setup.py install for mozprofile 21:17:06 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:17:06 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:17:06 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:17:06 INFO - Running setup.py install for mozrunner 21:17:06 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:17:06 INFO - Running setup.py install for mozscreenshot 21:17:07 INFO - Running setup.py install for moztest 21:17:07 INFO - Running setup.py install for mozversion 21:17:07 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:17:07 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:17:07 INFO - Cleaning up... 21:17:07 INFO - Return code: 0 21:17:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:17:07 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')]} 21:17:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:17:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:17:07 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')]} 21:17:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:17:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:17:07 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 0x109088490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108ffe570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdd53c694d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108e9cd30>, '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 0x108d02db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108e94b20>, '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.3rpVj1KJlS/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.5lI1E4LAZQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/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 21:17:07 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 21:17:07 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 21:17:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3rpVj1KJlS/Render', 21:17:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:17:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:17:07 INFO - 'HOME': '/Users/cltbld', 21:17:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:17:07 INFO - 'LOGNAME': 'cltbld', 21:17:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:17:07 INFO - 'MOZ_NO_REMOTE': '1', 21:17:07 INFO - 'NO_EM_RESTART': '1', 21:17:07 INFO - 'PAGER': '/bin/cat', 21:17:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:17:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:17:07 INFO - 'PWD': '/builds/slave/test', 21:17:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:17:07 INFO - 'SHELL': '/bin/bash', 21:17:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5lI1E4LAZQ/Listeners', 21:17:07 INFO - 'TMPDIR': '/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/', 21:17:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:17:07 INFO - 'USER': 'cltbld', 21:17:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:17:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:17:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:17:07 INFO - 'XPC_FLAGS': '0x0', 21:17:07 INFO - 'XPC_SERVICE_NAME': '0', 21:17:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:17:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:17:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:17:07 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-CIbO6A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:17:07 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)) 21:17:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:17:07 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-FaVYxj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:17:07 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)) 21:17:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:17:07 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-4yxk76-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:17:07 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)) 21:17:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:17:07 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-Hargj4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:17:08 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)) 21:17:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:17:08 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-GCuUm8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:17:08 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)) 21:17:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:17:08 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-3LR8Z1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:17:08 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)) 21:17:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:17:08 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-yuyo78-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:17:08 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)) 21:17:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:17:08 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-v96CI5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:17:08 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)) 21:17:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:17:08 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-AkonxB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:17:08 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)) 21:17:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:17:08 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-NWvBPU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:17:08 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)) 21:17:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:17:08 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-ZFDB82-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:17:08 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)) 21:17:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:17:08 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-ukErNT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:17:08 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)) 21:17:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:17:08 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-ZWmo2s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:17:09 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)) 21:17:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:17:09 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-990y7n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:17:09 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)) 21:17:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:17:09 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-ia4kc8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:17:09 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)) 21:17:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:17:09 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-P_vB7F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:17:09 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)) 21:17:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:17:09 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-0pu44X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:17:09 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)) 21:17:09 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)) 21:17:09 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)) 21:17:09 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)) 21:17:09 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)) 21:17:09 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)) 21:17:09 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:17:09 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 21:17:09 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 21:17:09 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 21:17:09 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 21:17:09 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 21:17:09 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 21:17:12 INFO - Downloading blessings-1.6.tar.gz 21:17:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:17:12 INFO - Installing collected packages: blessings 21:17:12 INFO - Running setup.py install for blessings 21:17:12 INFO - Successfully installed blessings 21:17:12 INFO - Cleaning up... 21:17:12 INFO - Return code: 0 21:17:12 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:17:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:17:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:17:12 INFO - Reading from file tmpfile_stdout 21:17:12 INFO - Current package versions: 21:17:12 INFO - blessings == 1.6 21:17:12 INFO - blobuploader == 1.2.4 21:17:12 INFO - docopt == 0.6.1 21:17:12 INFO - functools32 == 3.2.3-2 21:17:12 INFO - jsonschema == 2.5.1 21:17:12 INFO - manifestparser == 1.1 21:17:12 INFO - mozInstall == 1.12 21:17:12 INFO - mozcrash == 0.17 21:17:12 INFO - mozdebug == 0.1 21:17:12 INFO - mozdevice == 0.48 21:17:12 INFO - mozfile == 1.2 21:17:12 INFO - mozhttpd == 0.7 21:17:12 INFO - mozinfo == 0.9 21:17:12 INFO - mozleak == 0.1 21:17:12 INFO - mozlog == 3.4 21:17:12 INFO - moznetwork == 0.27 21:17:12 INFO - mozprocess == 0.23 21:17:12 INFO - mozprofile == 0.28 21:17:12 INFO - mozrunner == 6.12 21:17:12 INFO - mozscreenshot == 0.1 21:17:12 INFO - mozsystemmonitor == 0.3 21:17:12 INFO - moztest == 0.7 21:17:12 INFO - mozversion == 1.4 21:17:12 INFO - psutil == 3.1.1 21:17:12 INFO - requests == 1.2.3 21:17:12 INFO - wsgiref == 0.1.2 21:17:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:17:12 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')]} 21:17:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:17:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:17:12 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')]} 21:17:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:17:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:17:12 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 0x109088490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108ffe570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdd53c694d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108e9cd30>, '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 0x108d02db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108e94b20>, '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.3rpVj1KJlS/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.5lI1E4LAZQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/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 21:17:12 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 21:17:12 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 21:17:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3rpVj1KJlS/Render', 21:17:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:17:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:17:12 INFO - 'HOME': '/Users/cltbld', 21:17:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:17:12 INFO - 'LOGNAME': 'cltbld', 21:17:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:17:12 INFO - 'MOZ_NO_REMOTE': '1', 21:17:12 INFO - 'NO_EM_RESTART': '1', 21:17:12 INFO - 'PAGER': '/bin/cat', 21:17:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:17:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:17:12 INFO - 'PWD': '/builds/slave/test', 21:17:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:17:12 INFO - 'SHELL': '/bin/bash', 21:17:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5lI1E4LAZQ/Listeners', 21:17:12 INFO - 'TMPDIR': '/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/', 21:17:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:17:12 INFO - 'USER': 'cltbld', 21:17:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:17:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:17:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:17:12 INFO - 'XPC_FLAGS': '0x0', 21:17:12 INFO - 'XPC_SERVICE_NAME': '0', 21:17:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:17:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:17:12 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)) 21:17:12 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)) 21:17:12 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)) 21:17:12 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)) 21:17:12 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)) 21:17:12 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)) 21:17:12 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)) 21:17:12 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)) 21:17:12 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)) 21:17:12 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)) 21:17:12 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)) 21:17:12 INFO - Cleaning up... 21:17:12 INFO - Return code: 0 21:17:12 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:17:12 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')]} 21:17:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:17:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:17:12 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')]} 21:17:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:17:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:17:12 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 0x109088490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108ffe570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdd53c694d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108e9cd30>, '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 0x108d02db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108e94b20>, '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.3rpVj1KJlS/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.5lI1E4LAZQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/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 21:17:12 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 21:17:12 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 21:17:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3rpVj1KJlS/Render', 21:17:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:17:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:17:12 INFO - 'HOME': '/Users/cltbld', 21:17:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:17:12 INFO - 'LOGNAME': 'cltbld', 21:17:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:17:12 INFO - 'MOZ_NO_REMOTE': '1', 21:17:12 INFO - 'NO_EM_RESTART': '1', 21:17:12 INFO - 'PAGER': '/bin/cat', 21:17:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:17:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:17:12 INFO - 'PWD': '/builds/slave/test', 21:17:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:17:12 INFO - 'SHELL': '/bin/bash', 21:17:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5lI1E4LAZQ/Listeners', 21:17:12 INFO - 'TMPDIR': '/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/', 21:17:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:17:12 INFO - 'USER': 'cltbld', 21:17:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:17:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:17:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:17:12 INFO - 'XPC_FLAGS': '0x0', 21:17:12 INFO - 'XPC_SERVICE_NAME': '0', 21:17:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:17:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:17:13 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 21:17:13 INFO - Cleaning up... 21:17:13 INFO - Return code: 0 21:17:13 INFO - Running post-action listener: _resource_record_post_action 21:17:13 INFO - Running post-action listener: _start_resource_monitoring 21:17:13 INFO - Starting resource monitoring. 21:17:13 INFO - [mozharness: 2016-12-22 05:17:13.275841Z] Finished create-virtualenv step (success) 21:17:13 INFO - [mozharness: 2016-12-22 05:17:13.276884Z] Running install step. 21:17:13 INFO - Running pre-action listener: _resource_record_pre_action 21:17:13 INFO - Running main action method: install 21:17:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:17:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:17:13 INFO - Reading from file tmpfile_stdout 21:17:13 INFO - Detecting whether we're running mozinstall >=1.0... 21:17:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:17:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:17:13 INFO - Reading from file tmpfile_stdout 21:17:13 INFO - Output received: 21:17:13 INFO - Usage: mozinstall [options] installer 21:17:13 INFO - Options: 21:17:13 INFO - -h, --help show this help message and exit 21:17:13 INFO - -d DEST, --destination=DEST 21:17:13 INFO - Directory to install application into. [default: 21:17:13 INFO - "/builds/slave/test"] 21:17:13 INFO - --app=APP Application being installed. [default: firefox] 21:17:13 INFO - mkdir: /builds/slave/test/build/application 21:17:13 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'] 21:17:13 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 21:17:35 INFO - Reading from file tmpfile_stdout 21:17:35 INFO - Output received: 21:17:35 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 21:17:35 INFO - Running post-action listener: _resource_record_post_action 21:17:35 INFO - [mozharness: 2016-12-22 05:17:35.680336Z] Finished install step (success) 21:17:35 INFO - [mozharness: 2016-12-22 05:17:35.680494Z] Running run-tests step. 21:17:35 INFO - Running pre-action listener: _resource_record_pre_action 21:17:35 INFO - Running main action method: run_tests 21:17:35 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 21:17:35 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 21:17:35 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 21:17:35 INFO - 2016-12-21 21:17:35.695 screenresolution[29439:272434] starting screenresolution argv=screenresolution get 21:17:35 INFO - 2016-12-21 21:17:35.698 screenresolution[29439:272434] Display 0: 1600x1200x32@60 21:17:35 INFO - 2016-12-21 21:17:35.704 screenresolution[29440:272437] starting screenresolution argv=screenresolution list 21:17:35 INFO - Available Modes on Display 0 21:17:35 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 21:17:35 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 21:17:35 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 21:17:35 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 21:17:35 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 21:17:35 INFO - Intel Iris: 21:17:35 INFO - Chipset Model: Intel Iris 21:17:35 INFO - Type: GPU 21:17:35 INFO - Bus: Built-In 21:17:35 INFO - VRAM (Dynamic, Max): 1536 MB 21:17:35 INFO - Vendor: Intel (0x8086) 21:17:35 INFO - Device ID: 0x0a2e 21:17:35 INFO - Revision ID: 0x0009 21:17:35 INFO - Displays: 21:17:35 INFO - Display: 21:17:35 INFO - Resolution: 1600 x 1200 @ 60 Hz 21:17:35 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 21:17:35 INFO - Display Serial Number: 1600x1200 60 21:17:35 INFO - Main Display: Yes 21:17:35 INFO - Mirror: Off 21:17:35 INFO - Online: Yes 21:17:35 INFO - Rotation: Supported 21:17:35 INFO - Return code: 0 21:17:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:17:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:17:35 INFO - Python 2.7.3 21:17:35 INFO - Return code: 0 21:17:35 INFO - grabbing minidump binary from tooltool 21:17: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')]} 21:17:35 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 0x108e9cd30>, '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 0x108d02db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108e94b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:17:35 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 21:17:35 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 21:17:35 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 21:17:36 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:17:36 INFO - Return code: 0 21:17:36 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 21:17:36 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:17:36 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:17:36 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 21:17:36 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:17:36 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/ZEuTLy-ST1-mj_UyD7eIxQ/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0273', '--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 21:17:36 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/ZEuTLy-ST1-mj_UyD7eIxQ/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0273 --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 21:17:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3rpVj1KJlS/Render', 21:17:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:17:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:17:36 INFO - 'HOME': '/Users/cltbld', 21:17:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:17:36 INFO - 'LOGNAME': 'cltbld', 21:17:36 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:17:36 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 21:17:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:17:36 INFO - 'MOZ_NO_REMOTE': '1', 21:17:36 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:17:36 INFO - 'NO_EM_RESTART': '1', 21:17:36 INFO - 'PAGER': '/bin/cat', 21:17:36 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:17:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:17:36 INFO - 'PWD': '/builds/slave/test', 21:17:36 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:17:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:17:36 INFO - 'SHELL': '/bin/bash', 21:17:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5lI1E4LAZQ/Listeners', 21:17:36 INFO - 'TMPDIR': '/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/', 21:17:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:17:36 INFO - 'USER': 'cltbld', 21:17:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:17:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:17:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:17:36 INFO - 'XPC_FLAGS': '0x0', 21:17:36 INFO - 'XPC_SERVICE_NAME': '0', 21:17:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:17:36 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/ZEuTLy-ST1-mj_UyD7eIxQ/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0273', '--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 21:17:36 INFO - mozversion application_buildid: 20161221200752 21:17:36 INFO - mozversion application_changeset: 67d97463e755c0987c8bf452bb6fe9b733621409 21:17:36 INFO - mozversion application_display_name: Firefox 21:17:36 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:17:36 INFO - mozversion application_name: Firefox 21:17:36 INFO - mozversion application_remotingname: firefox 21:17:36 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 21:17:36 INFO - mozversion application_vendor: Mozilla 21:17:36 INFO - mozversion application_version: 51.0 21:17:36 INFO - mozversion platform_buildid: 20161221200752 21:17:36 INFO - mozversion platform_changeset: 67d97463e755c0987c8bf452bb6fe9b733621409 21:17:36 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 21:17:36 INFO - mozversion platform_version: 51.0 21:17:36 INFO - using testdate: 1482383856 21:17:36 INFO - actual date: 1482383856 21:17:36 INFO - starting webserver on 'localhost:49298' 21:17:36 INFO - SUITE-START | Running 2 tests 21:17:36 INFO - TEST-START | dromaeo_css 21:17:36 INFO - operating with platform_type : mac_ 21:17:36 INFO - Initialising browser for dromaeo_css test... 21:17:36 INFO - TEST-INFO | started process 29450 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/tmphYcHZb/profile http://localhost:49298/getInfo.html) 21:17:38 INFO - PROCESS | 29450 | __metrics Screen width/height:1600/1200 21:17:38 INFO - PROCESS | 29450 | colorDepth:24 21:17:38 INFO - PROCESS | 29450 | Browser inner width/height: 1024/689 21:17:38 INFO - PROCESS | 29450 | __metrics 21:17:38 INFO - PROCESS | 29450 | 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" 21:17:38 INFO - PROCESS | 29450 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:17:39 INFO - TEST-INFO | 29450: exit 0 21:17:39 INFO - Browser initialized. 21:17:39 INFO - Running cycle 1/1 for dromaeo_css test... 21:17:39 INFO - TEST-INFO | started process 29454 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/tmphYcHZb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:17:51 INFO - PROCESS | 29454 | RSS: Main: 169095168 21:17:51 INFO - PROCESS | 29454 | 21:18:45 INFO - PROCESS | 29454 | 1482383925355 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] 21:20:53 INFO - PROCESS | 29454 | Cycle 1(1): loaded http://localhost:49298/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49298/tests/dromaeo/cssquery-ext.html) 21:20:54 INFO - PROCESS | 29454 | RSS: Main: 290881536 21:20:54 INFO - PROCESS | 29454 | 21:23:57 INFO - PROCESS | 29454 | Cycle 1(1): loaded http://localhost:49298/tests/dromaeo/cssquery-ext.html (next: http://localhost:49298/tests/dromaeo/cssquery-jquery.html) 21:23:58 INFO - PROCESS | 29454 | RSS: Main: 301006848 21:23:58 INFO - PROCESS | 29454 | 21:27:00 INFO - PROCESS | 29454 | Cycle 1(1): loaded http://localhost:49298/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49298/tests/dromaeo/cssquery-mootools.html) 21:27:01 INFO - PROCESS | 29454 | RSS: Main: 277176320 21:27:01 INFO - PROCESS | 29454 | 21:30:03 INFO - PROCESS | 29454 | Cycle 1(1): loaded http://localhost:49298/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49298/tests/dromaeo/cssquery-prototype.html) 21:30:04 INFO - PROCESS | 29454 | RSS: Main: 267149312 21:30:04 INFO - PROCESS | 29454 | 21:33:07 INFO - PROCESS | 29454 | Cycle 1(1): loaded http://localhost:49298/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49298/tests/dromaeo/cssquery-yui.html) 21:33:07 INFO - PROCESS | 29454 | RSS: Main: 263471104 21:33:07 INFO - PROCESS | 29454 | 21:36:10 INFO - PROCESS | 29454 | Cycle 1(1): loaded http://localhost:49298/tests/dromaeo/cssquery-yui.html (next: http://localhost:49298/tests/dromaeo/cssquery-dojo.html) 21:36:11 INFO - PROCESS | 29454 | RSS: Main: 396894208 21:36:11 INFO - PROCESS | 29454 | 21:36:11 INFO - PROCESS | 29454 | __start_tp_report 21:36:11 INFO - PROCESS | 29454 | _x_x_mozilla_page_load 21:36:11 INFO - PROCESS | 29454 | _x_x_mozilla_page_load_details 21:36:11 INFO - PROCESS | 29454 | |i|pagename|runs| 21:36:11 INFO - PROCESS | 29454 | |0;dojo.html;3061.173483159547;3406.6763657452543;3428.2971990741885;3440.088376580205;3471.2363280078375;5701.657900525966;5703.9714801425935;5738.7991420300295;5748.683822389767;5798.101294299385;5040.319556859823;5238.476152384759;5535.25274087998;5598.608097433182;5599.972000140004;5036.395632524102;5046.596272298208;5075.187969924813;5122;5206.739663016853;4537.841175558856;4931.161702510582;5152.046871328816;5164.1995490699;5253.474652534755;5236.21456781482;5261.736913154346;5273.156294992802;5274.4461831507715;5281.815136470224;5182.481751824806;5248.763805628756;5250.44870288618;5255.080360936859;5277.815276465343;5099.107656160194;5116.69299842007;5138.075146473633;5138.229265610188;5182.119039763249;5826.242588463472;5830.271216097988;5854.063349864044;5877.588568800185;5880.660110547682;6107.826086956522;6125.11336343068;6126.540509461808;6141.986572215579;6265.498760099181;6164.106204600353;6220.129181914535;6252;6279.403456671609;6295.150154729099;5787.218725472091;5799.3910639382675;5802;5803.912941305884;5836.387179346192;6142.161149281699;6161.876762464725;6255.968720156461;6263.217097862767;6279.0895320178315;6138.265785110792;6187.226596675416;6204.968975155186;6206.286277078104;6215.564910456315;6182.948898687234;6212.06818977157;6225.657588832658;6231.657258850807;6244.2819075805955;6077.058056001327;6107.492261292593;6143.877122457526;6234.937650623527;6250.15622890913;6143.109249158847;6179.3202747697715;6205.441510264098;6215.875682486325;6218.657973811393;4980.626453016038;4980.875478113004;4991.575716064175;5000.699958002531;5017.623678224148;4468.151051300242;4474.865754027384;4485.439320084989;4489.281714925596;4525.343825145402;4721.693089949143;5640.407757185519;5689.260396148474;5794.681292528951;5824.213731146326;4572.634189264851;6153.169322141453;6264.185655864709;6289.905651415233;6303.6532990685955;5821.759086220083;5836.562257830595;5853.912191317134;5871.618344807659;5893.793717219963;5324.547413469821;5374.731263436891;5456.61803673739;5456.863578410492;5460.726963651801;6223.533235007302;6264.874702506016;6268.780592679325;6285.308616052322;6289.182406287154;6245.937540624717;6249.187605611241;6251.374862513894;6270;6284.497240220863;6347.777827776005;6365.809025729235;6366.64983425916;6377.840553986188;6392.360763923571;5760.395158508464;6106.084087386927;6139.447449729367;6142.130457811729;6184.134221208944;5612.803551875665;6257.155284036597;6260.342664020212;6273.121762953281;6286.9371306288185;6112.083187521907;6181.938180618136;6190.845228869134;6204.937950620617;6208.689565521796;5864.914990726558;6004.42957918997;6027.156198132177;6184.6598437086395;6205.782797602063;5962.403759624003;5981.491573216325;6008.789692360747;6092.573519853568;6111.908321375272;6162.322144564184;6174.073888916699;6174.166487524127;6185.721642526187;6188.1955345806555;5811.128330750421;5981.102834574848;6012.549058820693;6044.576879618385;6085.756569737338 21:36:11 INFO - PROCESS | 29454 | |1;ext.html;499.94750551192135;528.5612941258755;530.6391653675499;537.322973053952;539.3958766181877;28465.865060120497;37537.873863784094;38850.61149388505;41435.79282103593;45007.549924500745;43550.782246088806;43950.560494395046;44335.113297734104;44435.55564444354;44526.10947781042;9205.815883682322;9956.551955161998;10143;10163.796724065514;10177.54201060954;9268.258539316872;10151.898481015169;12507.124501284914;12539.749205015894;12643.304618245993;12470.81293780594;12571.622851314476;12577.685557861081;12579.874201257962;12616.432260548298;12446.253224806494;12503.562375316866;12515.436805343781;12524.561640342545;12545.811812822814;12326.568570100004;12426.254424734545;12440.19138755978;12445.875541244654;12461.06542009353;41414;41585.37621935673;41604.95987600334;41640.37539436911;41696.1660766786;3380.7126394256516;3662.230931504387;3970.7021973352116;4121.381792731085;4129;30526.69473305261;30945.071647850375;31591.684083159333;32956.17609559756;33381.499277510855;3304.653011433789;3306.636270010297;3493.8951831445097;3504.176518518146;3534.0811389038777;523363;531159;531812;532147;533710;60900;60986.78026439447;61023.38976610177;61070.38929610647;61132.08301875387;64713.352866470734;64760;64802.67598662071;64839.67580162069;64883.35116648773;17247.310107595807;17472.475825725247;17506.21222045011;17534.736978945326;17540.82459175392;12474.563390281297;12647.747045059048;12653.493860245488;13441;13513.459461621622;14615.92692036533;14750.188739619209;14758.188299643409;16144.354225830835;16555.420560280574;6136.815895523141;6578.243501997332;6685.997100434974;7052.894206586905;7285.943538187039;868.7046404222594;892.7501497902858;953.9046095390405;1097.3306283167262;1104.436737264001;22859.771402286096;29315.042469266376;30055;30795.538066929013;30885.845570772002;1094.7044298039484;1101.6254473479055;1107.6898468428853;1126.6113190949109;1129.9941260217151;16067.517974460785;16161.272742726605;16176.352945882032;16184.75722864158;16944.322227111024;700941;703694;704231;942723;959415;48845.755771220916;60916;60919.69540152271;64608.35391646023;64739.67630161913;1280.4366078925243;1316.1642357103117;1384.335518950909;1405.1990365491777;1434.698713270225;27144.592831107155;32399.676003239667;33009;34122.31755364829;34259.4861077089;54139;54763;54825.725871370385;54897.176542351095;54959.17561236505;617643;623099;623634;624083;625426;40697.98255043648;41277;41484.792576036925;41654;41728;48805;49106;49343.25985110298;50288.748556256985;50628.74685626548;39952.4007139899;40737.59262407457;40823.59176408317;41147.765567033035;42195;41196.79401602973;41498;42053;42237;42299.7885010573;38981.22037559289;39409;40439.1912161761;40454.59545404626;40596.78209653715;32933.83533082319;35084.80477493161;35206.11984700403;35336.93989180329;35735.64264357323;26849.120561561285;26896.789644466437;26921.92312307564;27071;27523.86238068797 21:36:11 INFO - PROCESS | 29454 | |2;jquery.html;386.3952913690075;388.54152100521384;388.9319369110405;395.6063716601981;418.111513034801;14972.401103955828;20496.180152793888;21558.676619850674;21831.345059648214;21833.781662183374;21217.681734773993;21225.469363265925;21313.57372852542;21336.679949800764;21551;6018.1875446814665;6368;6368.3313252108555;6387.361263873622;6390.808275751735;4592.74739889306;6236.126942228092;6357.586756860813;7073.045138906259;7178.641067946608;6886.380225779679;7175.246599107097;7189.17324507683;7190.928090719078;7194.136703595575;7030.71877124917;7041.366277035066;7074.858502829915;7079.327463890922;7109.751158709446;5953.523718102541;6116.449519543263;6178.289496707846;6189;6190.102435146879;23880.88059559691;23971.520569588683;27083.593746093826;27230;27677.308067298276;2449.069353645621;2466.679331686887;2514.371407148213;2523.8485690858424;2579.239124458289;15214.391424343014;16294.51116466496;16883.493495195165;16967.236474358684;17090.82909170905;1770.530809335527;1924.9615007699767;1953.7753158386683;1997.470670272379;2031.8476114291486;108609.99999999921;111933.44033279862;118632.40683796612;124062.37968810188;125556;9228.723138305862;10635.680929572125;10927.672169834917;11159;11323.32060076398;12546.81179782304;13218.140820846615;13398.531051413154;13416.932915335361;13435.395407206504;7325.7802265932105;8314.168583141638;8799.29605631548;9075.636974521078;9124.680636177702;7854.253845884746;9180.954095229481;9263.166315031545;9272.258219342437;9464.763380915394;6054.666993315322;6363.172787537683;6554.770583029571;6674.43267322283;6676.198856137197;1813.7823461184742;1818.97271540927;1863.5713785829334;1891.952701182454;1895.3794505697706;806.0609390060631;874.8556488179379;972.3388096094582;993.5677980078689;1087.7443800706828;21468.892655536936;21828.908554572525;22120.778792211873;22703.864806759597;23116.3065108047;988.9357191782511;990.6681261777385;999.1557134221571;1017.4861694844057;1059.0997651995897;11343.602973895873;12010.459529321202;12093.697657558632;12216.083793715507;12260.632181034583;558001;568222;577905;580448;586873;77117;113291;114263.42868285606;115110.42444787723;118525;1012.5949620151998;1036.896310368972;1059.1738444013681;1061.4692653673164;1063.8351055586397;19960.500987474847;20137.993100344633;20429.897850511246;20531.794682052987;20542.897285514075;35998.82000590085;43773.905652358946;50753.746231268604;52823.73588132035;53144;72952;73275.63362183156;80357;82592.58703706443;82732.58633706793;7543.924560754323;7578.317951384402;7713.382929365525;7790.961045194737;7936.206379362017;11087.72280692989;11628.837116288303;13020;14126.929365353108;14136.78794818058;9656;11613.477393517143;11653.30080195191;11873.050155987674;11962.641120766391;9803.852942206015;10934.671959841218;11983.940080299542;12137;12207.267563946192;10595.629152979609;11698.649040528799;11759.882401175879;11763;12082;7622.993164838676;7755.7673269802;7855.175206603224;7895.210478952059;8017.959910200411;6070.939290607037;11082.279651822606;11762.235454695418;11919.76160476803;12210.145289829627 21:36:11 INFO - PROCESS | 29454 | |3;mootools.html;1541.4758981946136;1571.2693597477175;1747.6504699060183;1898.2881419467699;1905.1426857913941;7514.3237108660205;8158.632861521231;8421.663133474669;8983;8985.966613839419;7223.963880180591;7603.353714934237;8131.390145739064;8180.713675021376;8749.431286966343;2404.1825779235014;2433.75662433757;2435.4033261850873;2435.537247922889;2445.8287919845616;2398;2420.6611074449593;2432;2438.780509754122;2438.7927026202706;2158.460384903774;2206.216793038472;2208.4589275627495;2423.6970378702663;2424.9151279705216;2183.6178668732987;2202.3833326668478;2339.94150146246;2419.250032489916;2419.721732000825;2367.419982104378;2403.1228601560306;2407.253751337091;2412.5777988852055;2417.782399584028;9064.637414503411;9094.272458203393;9187;9204.861927071099;9232.538373081386;5375.731213439312;5543.8891222175735;5547.833564993057;5548.91676624851;5550.27846379972;3419.46998215277;3532.6290739472242;3589.066842620937;3594.2272411431404;3598.838052287653;1073.2755390111722;1099.1042300525046;1102.8456016157663;1115.8158903780948;1123.6348186839227;11997.34014629195;12087.637370878976;12091.153619246656;12096.092793040558;12119.969802566793;4772.7136371817805;4782.3543821584335;4867.70793752376;4955.603551715854;4984.152694042022;10233.232507561963;10240.180785537139;10250.436226007492;10262.179025677928;10269.383836969806;5538.833834984957;5543.584231182677;5548.195511650869;5551.72241387929;5554.472325129106;4434;4437.890527368158;4644.628429725613;5013.49865013503;5081.949180508222;3801.809909504569;3809.8857034289017;4047.1096358801015;4051.2505186540584;4181.91636167281;1147.713071732067;1292.1019891175542;1306.0661626936785;1315.828942237503;1321.4648067532473;850.8683451010141;890.5458216309729;917.6100157433065;927.967521136757;938.1462868789368;5823.301203855564;5969.253843269591;5982.371850955674;6006.219191505076;6240.438360547572;937.5359197197295;953.7901661634429;960.6781728121158;963.2390411574918;1019.4036488654073;3966.7421617594764;4035.7376770509823;4047.251258517184;4076.7553946763287;4171.0823618803815;9291.76770580741;10809.78380432387;10975.176861735401;11059.059979901638;11077.50151243196;11002.669919902415;11015.173861960226;11015.724606884893;11023;11027.503762330714;6683.6658167091455;8400.201980811813;8478.109798471196;8483.703070392383;8540.487570745776;6008.789692360747;6057.636541807506;6115.908261376172;6128.448439640454;6186.164867742978;10116.898831011596;10397.324173928973;10412.791744164922;10418.68743937683;10436.895631043895;9074.727758167266;10017.198624110199;10068.798624027331;10404.68785936423;10506.894931050592;7168.498205125591;7365.079365079365;7384.593847338448;7749.108852482037;7940.6029698515995;8183.386246031452;8316.126806685212;8429.409941304295;8551.444156129832;8552.315814734682;7613.733519326797;7662.310392064518;7719.807004824925;7842.568658723825;7903.249191326815;7465.216152303929;7574.583397913168;7637.5035622684345;7667.69329226847;7757.844843103219;7063.505554611128;7201.567905925661;7205.459590530836;7209.990601315925;7227.205007449072;4960.652754307164;5016.393442622951;5053.267276244997;5151.175811870083;5254.632175747814;5066;5144.30551875507;5178.482151784791;5209.453007434165;5215.478452154906 21:36:11 INFO - PROCESS | 29454 | |4;prototype.html;283.1731344474136;316.9825659588722;320.1995012468828;327.4139290669701;328.8027183689788;5447.564194864412;5457.126859702448;5457.454254574541;5460.399356070839;5536.9446305536885;4987.950120498794;5356.91964620531;5398.2712333834925;5443.455654434554;5447.319085114361;3164.6360668523184;3831.9808400958027;4059.2287465381633;4067.491563554556;4076.510818701745;3536.982315088434;3713.1274150574595;3772.792496412696;4183.414321994923;4194.433751443562;4081.673466122703;4084.9591504085024;4128.896777580554;4138.772367519785;4148.97925510372;3512.1912215209186;3803.82882770276;3883.417487376888;4120.567340429257;4145.647619952278;3615.854206840066;3634.2549777295853;3635.891053228764;3639.890803275906;3646.762960407565;4972.6270529710055;5263.973525162595;5319.707416092114;5345.866353341159;5368.463153684639;4583.335416364642;4771.928421073687;4790.616750659939;4831.415192871832;4865.391826021747;5648.11945907586;5675.808080303142;5682;5682.687452190128;5740.425957404268;3974.1852920151587;3976.5426975897853;3989.4215338776007;4068.328725760246;4071.4096456013713;5191.961607678441;5433.913217356505;5806.680632565207;5959.5899034714;5987.760489580412;4047.4131250968444;4053.176070768166;4065.1259979104634;4068.7355321903983;4094.134106125724;3479.7390195734915;3686.8570743069736;4121.52602450716;4180.686448516312;4194.475690538683;4274.4870615525715;4777.641676874248;4843.733594652257;4857.247126695368;4877.634177436636;5059.848204553869;5688.544916406678;5732.369439361667;5781.566382521328;5834.708264586754;1330.7272009238084;1376.3187222324814;1408.9925703122317;1409.5700811252461;1415.6390120519202;741.5180132913649;750.3621921366904;778.875379939207;799.9960000200078;828.9336853051741;4384.618845063795;4727.338172655831;5256.763445644955;5294.947050529522;5472.91790623141;5334.679414454725;5534.612577119644;5725.799597014085;5821.854453638693;5835;4343.8705936456745;5159.678144834839;5351.759170837322;5374.758135883894;5383.5423988961375;2600.3759097816387;2811.383454513622;3023.833689147118;3080.584121143617;3080.7227349538202;5538.944610553924;5586.608937374426;5727.341355744143;5831.766729330864;6099.359567245464;5269;5718.571107166979;6016.398360163948;6051.485623722033;6096.451319381277;5263.842084737387;5642.379338272786;5963.701814909324;6085.62660562381;6145.787516494059;4688.765561721969;5540.722963851872;5818.4763371296785;5834.679092649945;5841.240638716939;5654.519365853784;5746.683932383759;5760.654360738202;5763.827085187451;5771.480566749013;5026.748662566784;5813.680247586423;6014.969925150522;6036.63780173191;6046.641809694311;3823.4073718573663;3839.540974429699;3863.9760463476637;4080.8979775504663;4104.384342348671;5109.897802044013;5206.323177986837;5283.762230699551;5695.772169113355;5917.6745279010065;5794.768209271582;5834.970825145847;5842.2405087338375;5863.736131874161;5869.207656966426;4747.053707979711;4811.591014763644;5656.105204756453;5701.234901072893;5735.283089613798;4685.149366000479;4875.512448755097;5588.916166257591;5628.943710562842;5631.324241091095;4141.053704758759;4695.5304469552775;5029.84910452687;5522.530584900329;5726.942730572808;5572.888542229214;5586.078297080936;5590.329160500766;5590.909772594305;5634.1829085457275 21:36:11 INFO - PROCESS | 29454 | |5;yui.html;690.2717632897293;757.2200633347647;793.5833687314159;836.3267569606468;853.8686240731029;16090.839091609081;16387.672246555092;16779.24493397797;16794.916025419872;16823.83176168238;15502.14738189402;15562.37750489982;15731.84268157318;15749.291281892314;15814.367425303002;735.4043224987751;759.2104211619909;879.0769691823575;899.7885496908222;902.4810733828042;741.8924255982879;900.7252787899688;904.0507467159456;906.7642412972641;910.2308549275851;961.024560071528;963.8843338799319;964.0118878149882;964.1178321835512;966.6085235479642;956.2923436656858;957.301170145794;957.4207604399343;958.5063692198523;959.098447459386;702.1714377035097;702.7505235641324;706.2972342519175;707.2503146664552;709.1808960650457;15308.081515109128;15338.846611533965;15356.923215383964;15379;15382.923085384613;13352.866471335357;13584.728305433837;13888.791668124986;15429.382824687;15503.767443488357;13359.131656442398;13390.732185356239;13585.184888906599;13764.65588360289;13796.655083622889;4690.202665546865;4749.833755818564;4760.33355330254;4791.520847915215;4919.040787046527;78733.21266787259;96807.51596242044;99764.50117749437;124066;128081.07878381832;11116.61091861781;11598.536058557564;11612.303261804318;11786.174967752175;11828.52685892572;23445.94493247808;23457.41356466102;23814.16650417227;23816.523669526858;23846.642300365507;7246.420286377077;8174.3460523158;8250.133735957757;8253;8365.539895305696;4484.641228701696;4499.190145773727;4598.471175814824;4599.977000114978;4714.882127946828;3664.76179048361;3800.448934904479;3804.752691075071;3816.2939856126704;3816.580176180618;668.9698963546653;694.0768777525878;695.8608278344351;696.2723953468637;702.8769965256059;530.6630289766026;578.2421438826005;612.5528364294001;708.6128306694011;730.4339137168737;9293.25653947696;9397.57710903011;9860.556274967643;9981.301308908452;10288.12550933179;547.6577139287945;573.8852229554105;605.276694350256;656.1306269193337;676.993230067693;4488.272015274078;4873.512648735169;4880.975595122001;4907.190313598217;4974.701517908937;161144;163618.1819090897;163731;165772;170904;135484;136129.3193534026;140135.8911670738;140682;146805;98400.50799745956;101893;104473;105725.47137264264;108851.45574272236;9376.531173441437;9669.854952175583;9973.863460317796;10447.529861156114;10698.73253168677;50809.491905080475;61836.690816545626;62913;62917;66413.66793166003;70585;71762;92279.53860230924;95742.52128739591;101369;12239.632811015685;13946.79079813824;14256.572302830931;14721.411143554138;14753.778693319824;15020.023698459565;15207.695846082795;15962.68074638524;16167.919160404123;16780.160991950597;13877.79183312231;14591.781123282946;14756.852431475549;15145.697086058437;15575.84424155744;12117.394130293274;14545.490907818175;14695.338709757872;14703.485378011717;14983.250837458301;13448.529301474402;13821.101628394123;14332.713345732818;14814.703705926036;15384.38462461489;11410;11470.770584588094;11637.359945203096;12039.217450865666;12106.334151621746;11314.264572802742;11598.768024639628;11743.706407339885;12001.339926304137;12142.635720928387 21:36:11 INFO - PROCESS | 29454 | __end_tp_report 21:36:11 INFO - PROCESS | 29454 | __start_cc_report 21:36:11 INFO - PROCESS | 29454 | _x_x_mozilla_cycle_collect,1187 21:36:11 INFO - PROCESS | 29454 | __end_cc_report 21:36:11 INFO - PROCESS | 29454 | __startTimestamp1482384971119__endTimestamp 21:36:11 INFO - PROCESS | 29454 | 21:36:11 INFO - PROCESS | 29454 | ------- Summary: start ------- 21:36:11 INFO - PROCESS | 29454 | Number of tests: 6 21:36:11 INFO - PROCESS | 29454 | 21:36:11 INFO - PROCESS | 29454 | [#0] dojo.html Cycles:165 Average:5728.14 Median:5981.49 stddev:655.94 (11.0%) stddev-sans-first:623.69 21:36:11 INFO - PROCESS | 29454 | Values: 3061.2 3406.7 3428.3 3440.1 3471.2 5701.7 5704.0 5738.8 5748.7 5798.1 5040.3 5238.5 5535.3 5598.6 5600.0 5036.4 5046.6 5075.2 5122.0 5206.7 4537.8 4931.2 5152.0 5164.2 5253.5 5236.2 5261.7 5273.2 5274.4 5281.8 5182.5 5248.8 5250.4 5255.1 5277.8 5099.1 5116.7 5138.1 5138.2 5182.1 5826.2 5830.3 5854.1 5877.6 5880.7 6107.8 6125.1 6126.5 6142.0 6265.5 6164.1 6220.1 6252.0 6279.4 6295.2 5787.2 5799.4 5802.0 5803.9 5836.4 6142.2 6161.9 6256.0 6263.2 6279.1 6138.3 6187.2 6205.0 6206.3 6215.6 6182.9 6212.1 6225.7 6231.7 6244.3 6077.1 6107.5 6143.9 6234.9 6250.2 6143.1 6179.3 6205.4 6215.9 6218.7 4980.6 4980.9 4991.6 5000.7 5017.6 4468.2 4474.9 4485.4 4489.3 4525.3 4721.7 5640.4 5689.3 5794.7 5824.2 4572.6 6153.2 6264.2 6289.9 6303.7 5821.8 5836.6 5853.9 5871.6 5893.8 5324.5 5374.7 5456.6 5456.9 5460.7 6223.5 6264.9 6268.8 6285.3 6289.2 6245.9 6249.2 6251.4 6270.0 6284.5 6347.8 6365.8 6366.6 6377.8 6392.4 5760.4 6106.1 6139.4 6142.1 6184.1 5612.8 6257.2 6260.3 6273.1 6286.9 6112.1 6181.9 6190.8 6204.9 6208.7 5864.9 6004.4 6027.2 6184.7 6205.8 5962.4 5981.5 6008.8 6092.6 6111.9 6162.3 6174.1 6174.2 6185.7 6188.2 5811.1 5981.1 6012.5 6044.6 6085.8 21:36:11 INFO - PROCESS | 29454 | 21:36:11 INFO - PROCESS | 29454 | [#1] ext.html Cycles:180 Average:78540.92 Median:21689.85 stddev:178527.69 (823.1%) stddev-sans-first:178932.36 21:36:11 INFO - PROCESS | 29454 | Values: 499.9 528.6 530.6 537.3 539.4 28465.9 37537.9 38850.6 41435.8 45007.5 43550.8 43950.6 44335.1 44435.6 44526.1 9205.8 9956.6 10143.0 10163.8 10177.5 9268.3 10151.9 12507.1 12539.7 12643.3 12470.8 12571.6 12577.7 12579.9 12616.4 12446.3 12503.6 12515.4 12524.6 12545.8 12326.6 12426.3 12440.2 12445.9 12461.1 41414.0 41585.4 41605.0 41640.4 41696.2 3380.7 3662.2 3970.7 4121.4 4129.0 30526.7 30945.1 31591.7 32956.2 33381.5 3304.7 3306.6 3493.9 3504.2 3534.1 523363.0 531159.0 531812.0 532147.0 533710.0 60900.0 60986.8 61023.4 61070.4 61132.1 64713.4 64760.0 64802.7 64839.7 64883.4 17247.3 17472.5 17506.2 17534.7 17540.8 12474.6 12647.7 12653.5 13441.0 13513.5 14615.9 14750.2 14758.2 16144.4 16555.4 6136.8 6578.2 6686.0 7052.9 7285.9 868.7 892.8 953.9 1097.3 1104.4 22859.8 29315.0 30055.0 30795.5 30885.8 1094.7 1101.6 1107.7 1126.6 1130.0 16067.5 16161.3 16176.4 16184.8 16944.3 700941.0 703694.0 704231.0 942723.0 959415.0 48845.8 60916.0 60919.7 64608.4 64739.7 1280.4 1316.2 1384.3 1405.2 1434.7 27144.6 32399.7 33009.0 34122.3 34259.5 54139.0 54763.0 54825.7 54897.2 54959.2 617643.0 623099.0 623634.0 624083.0 625426.0 40698.0 41277.0 41484.8 41654.0 41728.0 48805.0 49106.0 49343.3 50288.7 50628.7 39952.4 40737.6 40823.6 41147.8 42195.0 41196.8 41498.0 42053.0 42237.0 42299.8 38981.2 39409.0 40439.2 40454.6 40596.8 32933.8 35084.8 35206.1 35336.9 35735.6 26849.1 26896.8 26921.9 27071.0 27523.9 21:36:11 INFO - PROCESS | 29454 | 21:36:11 INFO - PROCESS | 29454 | [#2] jquery.html Cycles:180 Average:34101.03 Median:2457.87 stddev:95516.45 (3886.1%) stddev-sans-first:95750.86 21:36:11 INFO - PROCESS | 29454 | Values: 386.4 388.5 388.9 395.6 418.1 14972.4 20496.2 21558.7 21831.3 21833.8 21217.7 21225.5 21313.6 21336.7 21551.0 6018.2 6368.0 6368.3 6387.4 6390.8 4592.7 6236.1 6357.6 7073.0 7178.6 6886.4 7175.2 7189.2 7190.9 7194.1 7030.7 7041.4 7074.9 7079.3 7109.8 5953.5 6116.4 6178.3 6189.0 6190.1 23880.9 23971.5 27083.6 27230.0 27677.3 2449.1 2466.7 2514.4 2523.8 2579.2 15214.4 16294.5 16883.5 16967.2 17090.8 1770.5 1925.0 1953.8 1997.5 2031.8 108610.0 111933.4 118632.4 124062.4 125556.0 9228.7 10635.7 10927.7 11159.0 11323.3 12546.8 13218.1 13398.5 13416.9 13435.4 7325.8 8314.2 8799.3 9075.6 9124.7 7854.3 9181.0 9263.2 9272.3 9464.8 6054.7 6363.2 6554.8 6674.4 6676.2 1813.8 1819.0 1863.6 1892.0 1895.4 806.1 874.9 972.3 993.6 1087.7 21468.9 21828.9 22120.8 22703.9 23116.3 988.9 990.7 999.2 1017.5 1059.1 11343.6 12010.5 12093.7 12216.1 12260.6 558001.0 568222.0 577905.0 580448.0 586873.0 77117.0 113291.0 114263.4 115110.4 118525.0 1012.6 1036.9 1059.2 1061.5 1063.8 19960.5 20138.0 20429.9 20531.8 20542.9 35998.8 43773.9 50753.7 52823.7 53144.0 72952.0 73275.6 80357.0 82592.6 82732.6 7543.9 7578.3 7713.4 7791.0 7936.2 11087.7 11628.8 13020.0 14126.9 14136.8 9656.0 11613.5 11653.3 11873.1 11962.6 9803.9 10934.7 11983.9 12137.0 12207.3 10595.6 11698.6 11759.9 11763.0 12082.0 7623.0 7755.8 7855.2 7895.2 8018.0 6070.9 11082.3 11762.2 11919.8 12210.1 21:36:11 INFO - PROCESS | 29454 | 21:36:11 INFO - PROCESS | 29454 | [#3] mootools.html Cycles:180 Average:5803.80 Median:4958.13 stddev:3246.84 (65.5%) stddev-sans-first:3240.15 21:36:11 INFO - PROCESS | 29454 | Values: 1541.5 1571.3 1747.7 1898.3 1905.1 7514.3 8158.6 8421.7 8983.0 8986.0 7224.0 7603.4 8131.4 8180.7 8749.4 2404.2 2433.8 2435.4 2435.5 2445.8 2398.0 2420.7 2432.0 2438.8 2438.8 2158.5 2206.2 2208.5 2423.7 2424.9 2183.6 2202.4 2339.9 2419.3 2419.7 2367.4 2403.1 2407.3 2412.6 2417.8 9064.6 9094.3 9187.0 9204.9 9232.5 5375.7 5543.9 5547.8 5548.9 5550.3 3419.5 3532.6 3589.1 3594.2 3598.8 1073.3 1099.1 1102.8 1115.8 1123.6 11997.3 12087.6 12091.2 12096.1 12120.0 4772.7 4782.4 4867.7 4955.6 4984.2 10233.2 10240.2 10250.4 10262.2 10269.4 5538.8 5543.6 5548.2 5551.7 5554.5 4434.0 4437.9 4644.6 5013.5 5081.9 3801.8 3809.9 4047.1 4051.3 4181.9 1147.7 1292.1 1306.1 1315.8 1321.5 850.9 890.5 917.6 928.0 938.1 5823.3 5969.3 5982.4 6006.2 6240.4 937.5 953.8 960.7 963.2 1019.4 3966.7 4035.7 4047.3 4076.8 4171.1 9291.8 10809.8 10975.2 11059.1 11077.5 11002.7 11015.2 11015.7 11023.0 11027.5 6683.7 8400.2 8478.1 8483.7 8540.5 6008.8 6057.6 6115.9 6128.4 6186.2 10116.9 10397.3 10412.8 10418.7 10436.9 9074.7 10017.2 10068.8 10404.7 10506.9 7168.5 7365.1 7384.6 7749.1 7940.6 8183.4 8316.1 8429.4 8551.4 8552.3 7613.7 7662.3 7719.8 7842.6 7903.2 7465.2 7574.6 7637.5 7667.7 7757.8 7063.5 7201.6 7205.5 7210.0 7227.2 4960.7 5016.4 5053.3 5151.2 5254.6 5066.0 5144.3 5178.5 5209.5 5215.5 21:36:11 INFO - PROCESS | 29454 | 21:36:11 INFO - PROCESS | 29454 | [#4] prototype.html Cycles:180 Average:4612.41 Median:5263.91 stddev:1416.58 (26.9%) stddev-sans-first:1382.79 21:36:11 INFO - PROCESS | 29454 | Values: 283.2 317.0 320.2 327.4 328.8 5447.6 5457.1 5457.5 5460.4 5536.9 4988.0 5356.9 5398.3 5443.5 5447.3 3164.6 3832.0 4059.2 4067.5 4076.5 3537.0 3713.1 3772.8 4183.4 4194.4 4081.7 4085.0 4128.9 4138.8 4149.0 3512.2 3803.8 3883.4 4120.6 4145.6 3615.9 3634.3 3635.9 3639.9 3646.8 4972.6 5264.0 5319.7 5345.9 5368.5 4583.3 4771.9 4790.6 4831.4 4865.4 5648.1 5675.8 5682.0 5682.7 5740.4 3974.2 3976.5 3989.4 4068.3 4071.4 5192.0 5433.9 5806.7 5959.6 5987.8 4047.4 4053.2 4065.1 4068.7 4094.1 3479.7 3686.9 4121.5 4180.7 4194.5 4274.5 4777.6 4843.7 4857.2 4877.6 5059.8 5688.5 5732.4 5781.6 5834.7 1330.7 1376.3 1409.0 1409.6 1415.6 741.5 750.4 778.9 800.0 828.9 4384.6 4727.3 5256.8 5294.9 5472.9 5334.7 5534.6 5725.8 5821.9 5835.0 4343.9 5159.7 5351.8 5374.8 5383.5 2600.4 2811.4 3023.8 3080.6 3080.7 5538.9 5586.6 5727.3 5831.8 6099.4 5269.0 5718.6 6016.4 6051.5 6096.5 5263.8 5642.4 5963.7 6085.6 6145.8 4688.8 5540.7 5818.5 5834.7 5841.2 5654.5 5746.7 5760.7 5763.8 5771.5 5026.7 5813.7 6015.0 6036.6 6046.6 3823.4 3839.5 3864.0 4080.9 4104.4 5109.9 5206.3 5283.8 5695.8 5917.7 5794.8 5835.0 5842.2 5863.7 5869.2 4747.1 4811.6 5656.1 5701.2 5735.3 4685.1 4875.5 5588.9 5628.9 5631.3 4141.1 4695.5 5029.8 5522.5 5726.9 5572.9 5586.1 5590.3 5590.9 5634.2 21:36:11 INFO - PROCESS | 29454 | 21:36:11 INFO - PROCESS | 29454 | [#5] yui.html Cycles:180 Average:25608.46 Median:3732.61 stddev:41069.88 (1100.3%) stddev-sans-first:41142.48 21:36:11 INFO - PROCESS | 29454 | Values: 690.3 757.2 793.6 836.3 853.9 16090.8 16387.7 16779.2 16794.9 16823.8 15502.1 15562.4 15731.8 15749.3 15814.4 735.4 759.2 879.1 899.8 902.5 741.9 900.7 904.1 906.8 910.2 961.0 963.9 964.0 964.1 966.6 956.3 957.3 957.4 958.5 959.1 702.2 702.8 706.3 707.3 709.2 15308.1 15338.8 15356.9 15379.0 15382.9 13352.9 13584.7 13888.8 15429.4 15503.8 13359.1 13390.7 13585.2 13764.7 13796.7 4690.2 4749.8 4760.3 4791.5 4919.0 78733.2 96807.5 99764.5 124066.0 128081.1 11116.6 11598.5 11612.3 11786.2 11828.5 23445.9 23457.4 23814.2 23816.5 23846.6 7246.4 8174.3 8250.1 8253.0 8365.5 4484.6 4499.2 4598.5 4600.0 4714.9 3664.8 3800.4 3804.8 3816.3 3816.6 669.0 694.1 695.9 696.3 702.9 530.7 578.2 612.6 708.6 730.4 9293.3 9397.6 9860.6 9981.3 10288.1 547.7 573.9 605.3 656.1 677.0 4488.3 4873.5 4881.0 4907.2 4974.7 161144.0 163618.2 163731.0 165772.0 170904.0 135484.0 136129.3 140135.9 140682.0 146805.0 98400.5 101893.0 104473.0 105725.5 108851.5 9376.5 9669.9 9973.9 10447.5 10698.7 50809.5 61836.7 62913.0 62917.0 66413.7 70585.0 71762.0 92279.5 95742.5 101369.0 12239.6 13946.8 14256.6 14721.4 14753.8 15020.0 15207.7 15962.7 16167.9 16780.2 13877.8 14591.8 14756.9 15145.7 15575.8 12117.4 14545.5 14695.3 14703.5 14983.3 13448.5 13821.1 14332.7 14814.7 15384.4 11410.0 11470.8 11637.4 12039.2 12106.3 11314.3 11598.8 11743.7 12001.3 12142.6 21:36:11 INFO - PROCESS | 29454 | -------- Summary: end -------- 21:36:11 INFO - PROCESS | 29454 | 21:36:11 INFO - TEST-INFO | 29454: exit 0 21:36:11 INFO - TEST-OK | dromaeo_css | took 1115405ms 21:36:11 INFO - TEST-START | kraken 21:36:11 INFO - operating with platform_type : mac_ 21:36:11 INFO - Initialising browser for kraken test... 21:36:11 INFO - TEST-INFO | started process 29460 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/tmpqeSEF4/profile http://localhost:49298/getInfo.html) 21:36:13 INFO - PROCESS | 29460 | __metrics Screen width/height:1600/1200 21:36:13 INFO - PROCESS | 29460 | colorDepth:24 21:36:13 INFO - PROCESS | 29460 | Browser inner width/height: 1024/689 21:36:13 INFO - PROCESS | 29460 | __metrics 21:36:13 INFO - PROCESS | 29460 | 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" 21:36:13 INFO - PROCESS | 29460 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:36:14 INFO - TEST-INFO | 29460: exit 0 21:36:14 INFO - Browser initialized. 21:36:14 INFO - Running cycle 1/1 for kraken test... 21:36:14 INFO - TEST-INFO | started process 29462 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/tmpqeSEF4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:36:26 INFO - PROCESS | 29462 | RSS: Main: 168898560 21:36:26 INFO - PROCESS | 29462 | 21:36:29 INFO - PROCESS | 29462 | Cycle 1(1): loaded http://localhost:49298/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49298/tests/kraken/driver.html?testName=audio-beat-detection) 21:36:30 INFO - PROCESS | 29462 | RSS: Main: 218775552 21:36:30 INFO - PROCESS | 29462 | 21:36:32 INFO - PROCESS | 29462 | Cycle 1(1): loaded http://localhost:49298/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49298/tests/kraken/driver.html?testName=audio-dft) 21:36:33 INFO - PROCESS | 29462 | RSS: Main: 232493056 21:36:33 INFO - PROCESS | 29462 | 21:36:36 INFO - PROCESS | 29462 | Cycle 1(1): loaded http://localhost:49298/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49298/tests/kraken/driver.html?testName=audio-fft) 21:36:37 INFO - PROCESS | 29462 | RSS: Main: 329801728 21:36:37 INFO - PROCESS | 29462 | 21:36:39 INFO - PROCESS | 29462 | Cycle 1(1): loaded http://localhost:49298/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49298/tests/kraken/driver.html?testName=audio-oscillator) 21:36:39 INFO - PROCESS | 29462 | RSS: Main: 228413440 21:36:39 INFO - PROCESS | 29462 | 21:36:41 INFO - PROCESS | 29462 | Cycle 1(1): loaded http://localhost:49298/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49298/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:36:42 INFO - PROCESS | 29462 | RSS: Main: 231428096 21:36:42 INFO - PROCESS | 29462 | 21:36:45 INFO - PROCESS | 29462 | Cycle 1(1): loaded http://localhost:49298/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49298/tests/kraken/driver.html?testName=imaging-darkroom) 21:36:45 INFO - PROCESS | 29462 | RSS: Main: 266137600 21:36:45 INFO - PROCESS | 29462 | 21:36:48 INFO - PROCESS | 29462 | Cycle 1(1): loaded http://localhost:49298/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49298/tests/kraken/driver.html?testName=imaging-desaturate) 21:36:49 INFO - PROCESS | 29462 | RSS: Main: 268619776 21:36:49 INFO - PROCESS | 29462 | 21:36:51 INFO - PROCESS | 29462 | Cycle 1(1): loaded http://localhost:49298/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49298/tests/kraken/driver.html?testName=json-parse-financial) 21:36:52 INFO - PROCESS | 29462 | RSS: Main: 266223616 21:36:52 INFO - PROCESS | 29462 | 21:36:54 INFO - PROCESS | 29462 | Cycle 1(1): loaded http://localhost:49298/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49298/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:36:54 INFO - PROCESS | 29462 | RSS: Main: 240390144 21:36:54 INFO - PROCESS | 29462 | 21:36:56 INFO - PROCESS | 29462 | Cycle 1(1): loaded http://localhost:49298/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49298/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:36:57 INFO - PROCESS | 29462 | RSS: Main: 246267904 21:36:57 INFO - PROCESS | 29462 | 21:36:59 INFO - PROCESS | 29462 | Cycle 1(1): loaded http://localhost:49298/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49298/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:37:00 INFO - PROCESS | 29462 | RSS: Main: 254636032 21:37:00 INFO - PROCESS | 29462 | 21:37:02 INFO - PROCESS | 29462 | Cycle 1(1): loaded http://localhost:49298/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49298/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:37:03 INFO - PROCESS | 29462 | RSS: Main: 258658304 21:37:03 INFO - PROCESS | 29462 | 21:37:06 INFO - PROCESS | 29462 | Cycle 1(1): loaded http://localhost:49298/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49298/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:37:06 INFO - PROCESS | 29462 | RSS: Main: 259952640 21:37:06 INFO - PROCESS | 29462 | 21:37:08 INFO - PROCESS | 29462 | Cycle 1(1): loaded http://localhost:49298/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49298/tests/kraken/driver.html?testName=ai-astar) 21:37:08 INFO - PROCESS | 29462 | RSS: Main: 303882240 21:37:08 INFO - PROCESS | 29462 | 21:37:08 INFO - PROCESS | 29462 | __start_tp_report 21:37:08 INFO - PROCESS | 29462 | _x_x_mozilla_page_load 21:37:08 INFO - PROCESS | 29462 | _x_x_mozilla_page_load_details 21:37:08 INFO - PROCESS | 29462 | |i|pagename|runs| 21:37:08 INFO - PROCESS | 29462 | |0;ai-astar;113;114;114;114;117;164;166;114;113;113 21:37:08 INFO - PROCESS | 29462 | |1;audio-beat-detection;153;131;141;176;140;107;109;105;140;103 21:37:08 INFO - PROCESS | 29462 | |2;audio-dft;182;183;185;184;182;184;184;182;182;183 21:37:08 INFO - PROCESS | 29462 | |3;audio-fft;84;59;59;87;63;62;49;74;100;81 21:37:08 INFO - PROCESS | 29462 | |4;audio-oscillator;90;69;94;69;67;70;92;68;68;90 21:37:08 INFO - PROCESS | 29462 | |5;imaging-gaussian-blur;87;84;88;84;87;84;87;85;86;83 21:37:08 INFO - PROCESS | 29462 | |6;imaging-darkroom;93;92;94;94;93;93;93;93;93;93 21:37:08 INFO - PROCESS | 29462 | |7;imaging-desaturate;86;84;84;85;83;98;132;134;84;84 21:37:08 INFO - PROCESS | 29462 | |8;json-parse-financial;56;54;55;53;54;58;58;57;56;56 21:37:08 INFO - PROCESS | 29462 | |9;json-stringify-tinderbox;69;67;79;71;72;68;69;71;71;71 21:37:08 INFO - PROCESS | 29462 | |10;stanford-crypto-aes;85;84;84;84;81;81;86;86;81;100 21:37:08 INFO - PROCESS | 29462 | |11;stanford-crypto-ccm;134;134;138;142;146;132;136;132;146;136 21:37:08 INFO - PROCESS | 29462 | |12;stanford-crypto-pbkdf2;159;160;164;159;157;152;159;165;161;159 21:37:08 INFO - PROCESS | 29462 | |13;stanford-crypto-sha256-iterative;65;68;66;65;66;65;65;68;66;67 21:37:08 INFO - PROCESS | 29462 | __end_tp_report 21:37:08 INFO - PROCESS | 29462 | __start_cc_report 21:37:08 INFO - PROCESS | 29462 | _x_x_mozilla_cycle_collect,1857 21:37:08 INFO - PROCESS | 29462 | __end_cc_report 21:37:08 INFO - PROCESS | 29462 | __startTimestamp1482385028775__endTimestamp 21:37:08 INFO - PROCESS | 29462 | 21:37:08 INFO - PROCESS | 29462 | ------- Summary: start ------- 21:37:08 INFO - PROCESS | 29462 | Number of tests: 14 21:37:08 INFO - PROCESS | 29462 | 21:37:08 INFO - PROCESS | 29462 | [#0] ai-astar Cycles:10 Average:124.20 Median:114.00 stddev:21.54 (18.9%) stddev-sans-first:22.46 21:37:08 INFO - PROCESS | 29462 | Values: 113.0 114.0 114.0 114.0 117.0 164.0 166.0 114.0 113.0 113.0 21:37:08 INFO - PROCESS | 29462 | 21:37:08 INFO - PROCESS | 29462 | [#1] audio-beat-detection Cycles:10 Average:130.50 Median:140.00 stddev:24.24 (17.3%) stddev-sans-first:24.31 21:37:08 INFO - PROCESS | 29462 | Values: 153.0 131.0 141.0 176.0 140.0 107.0 109.0 105.0 140.0 103.0 21:37:08 INFO - PROCESS | 29462 | 21:37:08 INFO - PROCESS | 29462 | [#2] audio-dft Cycles:10 Average:183.10 Median:183.50 stddev:1.10 (0.6%) stddev-sans-first:1.09 21:37:08 INFO - PROCESS | 29462 | Values: 182.0 183.0 185.0 184.0 182.0 184.0 184.0 182.0 182.0 183.0 21:37:08 INFO - PROCESS | 29462 | 21:37:08 INFO - PROCESS | 29462 | [#3] audio-fft Cycles:10 Average:71.80 Median:68.50 stddev:15.94 (23.3%) stddev-sans-first:16.28 21:37:08 INFO - PROCESS | 29462 | Values: 84.0 59.0 59.0 87.0 63.0 62.0 49.0 74.0 100.0 81.0 21:37:08 INFO - PROCESS | 29462 | 21:37:08 INFO - PROCESS | 29462 | [#4] audio-oscillator Cycles:10 Average:77.70 Median:80.00 stddev:11.95 (14.9%) stddev-sans-first:11.82 21:37:08 INFO - PROCESS | 29462 | Values: 90.0 69.0 94.0 69.0 67.0 70.0 92.0 68.0 68.0 90.0 21:37:08 INFO - PROCESS | 29462 | 21:37:08 INFO - PROCESS | 29462 | [#5] imaging-gaussian-blur Cycles:10 Average:85.50 Median:86.50 stddev:1.72 (2.0%) stddev-sans-first:1.73 21:37:08 INFO - PROCESS | 29462 | Values: 87.0 84.0 88.0 84.0 87.0 84.0 87.0 85.0 86.0 83.0 21:37:08 INFO - PROCESS | 29462 | 21:37:08 INFO - PROCESS | 29462 | [#6] imaging-darkroom Cycles:10 Average:93.10 Median:93.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 21:37:08 INFO - PROCESS | 29462 | Values: 93.0 92.0 94.0 94.0 93.0 93.0 93.0 93.0 93.0 93.0 21:37:08 INFO - PROCESS | 29462 | 21:37:08 INFO - PROCESS | 29462 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:84.00 stddev:20.29 (24.2%) stddev-sans-first:21.24 21:37:08 INFO - PROCESS | 29462 | Values: 86.0 84.0 84.0 85.0 83.0 98.0 132.0 134.0 84.0 84.0 21:37:08 INFO - PROCESS | 29462 | 21:37:08 INFO - PROCESS | 29462 | [#8] json-parse-financial Cycles:10 Average:55.70 Median:56.00 stddev:1.70 (3.0%) stddev-sans-first:1.80 21:37:08 INFO - PROCESS | 29462 | Values: 56.0 54.0 55.0 53.0 54.0 58.0 58.0 57.0 56.0 56.0 21:37:08 INFO - PROCESS | 29462 | 21:37:08 INFO - PROCESS | 29462 | [#9] json-stringify-tinderbox Cycles:10 Average:70.80 Median:71.00 stddev:3.29 (4.6%) stddev-sans-first:3.43 21:37:08 INFO - PROCESS | 29462 | Values: 69.0 67.0 79.0 71.0 72.0 68.0 69.0 71.0 71.0 71.0 21:37:08 INFO - PROCESS | 29462 | 21:37:08 INFO - PROCESS | 29462 | [#10] stanford-crypto-aes Cycles:10 Average:85.20 Median:84.00 stddev:5.55 (6.6%) stddev-sans-first:5.89 21:37:08 INFO - PROCESS | 29462 | Values: 85.0 84.0 84.0 84.0 81.0 81.0 86.0 86.0 81.0 100.0 21:37:08 INFO - PROCESS | 29462 | 21:37:08 INFO - PROCESS | 29462 | [#11] stanford-crypto-ccm Cycles:10 Average:137.60 Median:137.00 stddev:5.32 (3.9%) stddev-sans-first:5.48 21:37:08 INFO - PROCESS | 29462 | Values: 134.0 134.0 138.0 142.0 146.0 132.0 136.0 132.0 146.0 136.0 21:37:08 INFO - PROCESS | 29462 | 21:37:08 INFO - PROCESS | 29462 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.50 Median:159.50 stddev:3.60 (2.3%) stddev-sans-first:3.81 21:37:08 INFO - PROCESS | 29462 | Values: 159.0 160.0 164.0 159.0 157.0 152.0 159.0 165.0 161.0 159.0 21:37:08 INFO - PROCESS | 29462 | 21:37:08 INFO - PROCESS | 29462 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.10 Median:66.00 stddev:1.20 (1.8%) stddev-sans-first:1.20 21:37:08 INFO - PROCESS | 29462 | Values: 65.0 68.0 66.0 65.0 66.0 65.0 65.0 68.0 66.0 67.0 21:37:08 INFO - PROCESS | 29462 | -------- Summary: end -------- 21:37:08 INFO - PROCESS | 29462 | 21:37:09 INFO - TEST-INFO | 29462: exit 0 21:37:09 INFO - TEST-OK | kraken | took 57970ms 21:37:09 INFO - SUITE-END | took 1173s 21:37:09 INFO - Completed test suite (00:19:33) 21:37:09 INFO - javascript benchmark 21:37:09 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3061.173483159547, 3406.6763657452543, 3428.2971990741885, 3440.088376580205, 3471.2363280078375, 5701.657900525966, 5703.9714801425935, 5738.7991420300295, 5748.683822389767, 5798.101294299385, 5040.319556859823, 5238.476152384759, 5535.25274087998, 5598.608097433182, 5599.972000140004, 5036.395632524102, 5046.596272298208, 5075.187969924813, 5122.0, 5206.739663016853, 4537.841175558856, 4931.161702510582, 5152.046871328816, 5164.1995490699, 5253.474652534755, 5236.21456781482, 5261.736913154346, 5273.156294992802, 5274.4461831507715, 5281.815136470224, 5182.481751824806, 5248.763805628756, 5250.44870288618, 5255.080360936859, 5277.815276465343, 5099.107656160194, 5116.69299842007, 5138.075146473633, 5138.229265610188, 5182.119039763249, 5826.242588463472, 5830.271216097988, 5854.063349864044, 5877.588568800185, 5880.660110547682, 6107.826086956522, 6125.11336343068, 6126.540509461808, 6141.986572215579, 6265.498760099181, 6164.106204600353, 6220.129181914535, 6252.0, 6279.403456671609, 6295.150154729099, 5787.218725472091, 5799.3910639382675, 5802.0, 5803.912941305884, 5836.387179346192, 6142.161149281699, 6161.876762464725, 6255.968720156461, 6263.217097862767, 6279.0895320178315, 6138.265785110792, 6187.226596675416, 6204.968975155186, 6206.286277078104, 6215.564910456315, 6182.948898687234, 6212.06818977157, 6225.657588832658, 6231.657258850807, 6244.2819075805955, 6077.058056001327, 6107.492261292593, 6143.877122457526, 6234.937650623527, 6250.15622890913, 6143.109249158847, 6179.3202747697715, 6205.441510264098, 6215.875682486325, 6218.657973811393, 4980.626453016038, 4980.875478113004, 4991.575716064175, 5000.699958002531, 5017.623678224148, 4468.151051300242, 4474.865754027384, 4485.439320084989, 4489.281714925596, 4525.343825145402, 4721.693089949143, 5640.407757185519, 5689.260396148474, 5794.681292528951, 5824.213731146326, 4572.634189264851, 6153.169322141453, 6264.185655864709, 6289.905651415233, 6303.6532990685955, 5821.759086220083, 5836.562257830595, 5853.912191317134, 5871.618344807659, 5893.793717219963, 5324.547413469821, 5374.731263436891, 5456.61803673739, 5456.863578410492, 5460.726963651801, 6223.533235007302, 6264.874702506016, 6268.780592679325, 6285.308616052322, 6289.182406287154, 6245.937540624717, 6249.187605611241, 6251.374862513894, 6270.0, 6284.497240220863, 6347.777827776005, 6365.809025729235, 6366.64983425916, 6377.840553986188, 6392.360763923571, 5760.395158508464, 6106.084087386927, 6139.447449729367, 6142.130457811729, 6184.134221208944, 5612.803551875665, 6257.155284036597, 6260.342664020212, 6273.121762953281, 6286.9371306288185, 6112.083187521907, 6181.938180618136, 6190.845228869134, 6204.937950620617, 6208.689565521796, 5864.914990726558, 6004.42957918997, 6027.156198132177, 6184.6598437086395, 6205.782797602063, 5962.403759624003, 5981.491573216325, 6008.789692360747, 6092.573519853568, 6111.908321375272, 6162.322144564184, 6174.073888916699, 6174.166487524127, 6185.721642526187, 6188.1955345806555, 5811.128330750421, 5981.102834574848, 6012.549058820693, 6044.576879618385, 6085.756569737338], "value": 5686.6819052550645, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [499.94750551192135, 528.5612941258755, 530.6391653675499, 537.322973053952, 539.3958766181877, 28465.865060120497, 37537.873863784094, 38850.61149388505, 41435.79282103593, 45007.549924500745, 43550.782246088806, 43950.560494395046, 44335.113297734104, 44435.55564444354, 44526.10947781042, 9205.815883682322, 9956.551955161998, 10143.0, 10163.796724065514, 10177.54201060954, 9268.258539316872, 10151.898481015169, 12507.124501284914, 12539.749205015894, 12643.304618245993, 12470.81293780594, 12571.622851314476, 12577.685557861081, 12579.874201257962, 12616.432260548298, 12446.253224806494, 12503.562375316866, 12515.436805343781, 12524.561640342545, 12545.811812822814, 12326.568570100004, 12426.254424734545, 12440.19138755978, 12445.875541244654, 12461.06542009353, 41414.0, 41585.37621935673, 41604.95987600334, 41640.37539436911, 41696.1660766786, 3380.7126394256516, 3662.230931504387, 3970.7021973352116, 4121.381792731085, 4129.0, 30526.69473305261, 30945.071647850375, 31591.684083159333, 32956.17609559756, 33381.499277510855, 3304.653011433789, 3306.636270010297, 3493.8951831445097, 3504.176518518146, 3534.0811389038777, 523363.0, 531159.0, 531812.0, 532147.0, 533710.0, 60900.0, 60986.78026439447, 61023.38976610177, 61070.38929610647, 61132.08301875387, 64713.352866470734, 64760.0, 64802.67598662071, 64839.67580162069, 64883.35116648773, 17247.310107595807, 17472.475825725247, 17506.21222045011, 17534.736978945326, 17540.82459175392, 12474.563390281297, 12647.747045059048, 12653.493860245488, 13441.0, 13513.459461621622, 14615.92692036533, 14750.188739619209, 14758.188299643409, 16144.354225830835, 16555.420560280574, 6136.815895523141, 6578.243501997332, 6685.997100434974, 7052.894206586905, 7285.943538187039, 868.7046404222594, 892.7501497902858, 953.9046095390405, 1097.3306283167262, 1104.436737264001, 22859.771402286096, 29315.042469266376, 30055.0, 30795.538066929013, 30885.845570772002, 1094.7044298039484, 1101.6254473479055, 1107.6898468428853, 1126.6113190949109, 1129.9941260217151, 16067.517974460785, 16161.272742726605, 16176.352945882032, 16184.75722864158, 16944.322227111024, 700941.0, 703694.0, 704231.0, 942723.0, 959415.0, 48845.755771220916, 60916.0, 60919.69540152271, 64608.35391646023, 64739.67630161913, 1280.4366078925243, 1316.1642357103117, 1384.335518950909, 1405.1990365491777, 1434.698713270225, 27144.592831107155, 32399.676003239667, 33009.0, 34122.31755364829, 34259.4861077089, 54139.0, 54763.0, 54825.725871370385, 54897.176542351095, 54959.17561236505, 617643.0, 623099.0, 623634.0, 624083.0, 625426.0, 40697.98255043648, 41277.0, 41484.792576036925, 41654.0, 41728.0, 48805.0, 49106.0, 49343.25985110298, 50288.748556256985, 50628.74685626548, 39952.4007139899, 40737.59262407457, 40823.59176408317, 41147.765567033035, 42195.0, 41196.79401602973, 41498.0, 42053.0, 42237.0, 42299.7885010573, 38981.22037559289, 39409.0, 40439.1912161761, 40454.59545404626, 40596.78209653715, 32933.83533082319, 35084.80477493161, 35206.11984700403, 35336.93989180329, 35735.64264357323, 26849.120561561285, 26896.789644466437, 26921.92312307564, 27071.0, 27523.86238068797], "value": 21438.060471155863, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [386.3952913690075, 388.54152100521384, 388.9319369110405, 395.6063716601981, 418.111513034801, 14972.401103955828, 20496.180152793888, 21558.676619850674, 21831.345059648214, 21833.781662183374, 21217.681734773993, 21225.469363265925, 21313.57372852542, 21336.679949800764, 21551.0, 6018.1875446814665, 6368.0, 6368.3313252108555, 6387.361263873622, 6390.808275751735, 4592.74739889306, 6236.126942228092, 6357.586756860813, 7073.045138906259, 7178.641067946608, 6886.380225779679, 7175.246599107097, 7189.17324507683, 7190.928090719078, 7194.136703595575, 7030.71877124917, 7041.366277035066, 7074.858502829915, 7079.327463890922, 7109.751158709446, 5953.523718102541, 6116.449519543263, 6178.289496707846, 6189.0, 6190.102435146879, 23880.88059559691, 23971.520569588683, 27083.593746093826, 27230.0, 27677.308067298276, 2449.069353645621, 2466.679331686887, 2514.371407148213, 2523.8485690858424, 2579.239124458289, 15214.391424343014, 16294.51116466496, 16883.493495195165, 16967.236474358684, 17090.82909170905, 1770.530809335527, 1924.9615007699767, 1953.7753158386683, 1997.470670272379, 2031.8476114291486, 108609.99999999921, 111933.44033279862, 118632.40683796612, 124062.37968810188, 125556.0, 9228.723138305862, 10635.680929572125, 10927.672169834917, 11159.0, 11323.32060076398, 12546.81179782304, 13218.140820846615, 13398.531051413154, 13416.932915335361, 13435.395407206504, 7325.7802265932105, 8314.168583141638, 8799.29605631548, 9075.636974521078, 9124.680636177702, 7854.253845884746, 9180.954095229481, 9263.166315031545, 9272.258219342437, 9464.763380915394, 6054.666993315322, 6363.172787537683, 6554.770583029571, 6674.43267322283, 6676.198856137197, 1813.7823461184742, 1818.97271540927, 1863.5713785829334, 1891.952701182454, 1895.3794505697706, 806.0609390060631, 874.8556488179379, 972.3388096094582, 993.5677980078689, 1087.7443800706828, 21468.892655536936, 21828.908554572525, 22120.778792211873, 22703.864806759597, 23116.3065108047, 988.9357191782511, 990.6681261777385, 999.1557134221571, 1017.4861694844057, 1059.0997651995897, 11343.602973895873, 12010.459529321202, 12093.697657558632, 12216.083793715507, 12260.632181034583, 558001.0, 568222.0, 577905.0, 580448.0, 586873.0, 77117.0, 113291.0, 114263.42868285606, 115110.42444787723, 118525.0, 1012.5949620151998, 1036.896310368972, 1059.1738444013681, 1061.4692653673164, 1063.8351055586397, 19960.500987474847, 20137.993100344633, 20429.897850511246, 20531.794682052987, 20542.897285514075, 35998.82000590085, 43773.905652358946, 50753.746231268604, 52823.73588132035, 53144.0, 72952.0, 73275.63362183156, 80357.0, 82592.58703706443, 82732.58633706793, 7543.924560754323, 7578.317951384402, 7713.382929365525, 7790.961045194737, 7936.206379362017, 11087.72280692989, 11628.837116288303, 13020.0, 14126.929365353108, 14136.78794818058, 9656.0, 11613.477393517143, 11653.30080195191, 11873.050155987674, 11962.641120766391, 9803.852942206015, 10934.671959841218, 11983.940080299542, 12137.0, 12207.267563946192, 10595.629152979609, 11698.649040528799, 11759.882401175879, 11763.0, 12082.0, 7622.993164838676, 7755.7673269802, 7855.175206603224, 7895.210478952059, 8017.959910200411, 6070.939290607037, 11082.279651822606, 11762.235454695418, 11919.76160476803, 12210.145289829627], "value": 10004.398589511828, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1541.4758981946136, 1571.2693597477175, 1747.6504699060183, 1898.2881419467699, 1905.1426857913941, 7514.3237108660205, 8158.632861521231, 8421.663133474669, 8983.0, 8985.966613839419, 7223.963880180591, 7603.353714934237, 8131.390145739064, 8180.713675021376, 8749.431286966343, 2404.1825779235014, 2433.75662433757, 2435.4033261850873, 2435.537247922889, 2445.8287919845616, 2398.0, 2420.6611074449593, 2432.0, 2438.780509754122, 2438.7927026202706, 2158.460384903774, 2206.216793038472, 2208.4589275627495, 2423.6970378702663, 2424.9151279705216, 2183.6178668732987, 2202.3833326668478, 2339.94150146246, 2419.250032489916, 2419.721732000825, 2367.419982104378, 2403.1228601560306, 2407.253751337091, 2412.5777988852055, 2417.782399584028, 9064.637414503411, 9094.272458203393, 9187.0, 9204.861927071099, 9232.538373081386, 5375.731213439312, 5543.8891222175735, 5547.833564993057, 5548.91676624851, 5550.27846379972, 3419.46998215277, 3532.6290739472242, 3589.066842620937, 3594.2272411431404, 3598.838052287653, 1073.2755390111722, 1099.1042300525046, 1102.8456016157663, 1115.8158903780948, 1123.6348186839227, 11997.34014629195, 12087.637370878976, 12091.153619246656, 12096.092793040558, 12119.969802566793, 4772.7136371817805, 4782.3543821584335, 4867.70793752376, 4955.603551715854, 4984.152694042022, 10233.232507561963, 10240.180785537139, 10250.436226007492, 10262.179025677928, 10269.383836969806, 5538.833834984957, 5543.584231182677, 5548.195511650869, 5551.72241387929, 5554.472325129106, 4434.0, 4437.890527368158, 4644.628429725613, 5013.49865013503, 5081.949180508222, 3801.809909504569, 3809.8857034289017, 4047.1096358801015, 4051.2505186540584, 4181.91636167281, 1147.713071732067, 1292.1019891175542, 1306.0661626936785, 1315.828942237503, 1321.4648067532473, 850.8683451010141, 890.5458216309729, 917.6100157433065, 927.967521136757, 938.1462868789368, 5823.301203855564, 5969.253843269591, 5982.371850955674, 6006.219191505076, 6240.438360547572, 937.5359197197295, 953.7901661634429, 960.6781728121158, 963.2390411574918, 1019.4036488654073, 3966.7421617594764, 4035.7376770509823, 4047.251258517184, 4076.7553946763287, 4171.0823618803815, 9291.76770580741, 10809.78380432387, 10975.176861735401, 11059.059979901638, 11077.50151243196, 11002.669919902415, 11015.173861960226, 11015.724606884893, 11023.0, 11027.503762330714, 6683.6658167091455, 8400.201980811813, 8478.109798471196, 8483.703070392383, 8540.487570745776, 6008.789692360747, 6057.636541807506, 6115.908261376172, 6128.448439640454, 6186.164867742978, 10116.898831011596, 10397.324173928973, 10412.791744164922, 10418.68743937683, 10436.895631043895, 9074.727758167266, 10017.198624110199, 10068.798624027331, 10404.68785936423, 10506.894931050592, 7168.498205125591, 7365.079365079365, 7384.593847338448, 7749.108852482037, 7940.6029698515995, 8183.386246031452, 8316.126806685212, 8429.409941304295, 8551.444156129832, 8552.315814734682, 7613.733519326797, 7662.310392064518, 7719.807004824925, 7842.568658723825, 7903.249191326815, 7465.216152303929, 7574.583397913168, 7637.5035622684345, 7667.69329226847, 7757.844843103219, 7063.505554611128, 7201.567905925661, 7205.459590530836, 7209.990601315925, 7227.205007449072, 4960.652754307164, 5016.393442622951, 5053.267276244997, 5151.175811870083, 5254.632175747814, 5066.0, 5144.30551875507, 5178.482151784791, 5209.453007434165, 5215.478452154906], "value": 4670.548288724739, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [283.1731344474136, 316.9825659588722, 320.1995012468828, 327.4139290669701, 328.8027183689788, 5447.564194864412, 5457.126859702448, 5457.454254574541, 5460.399356070839, 5536.9446305536885, 4987.950120498794, 5356.91964620531, 5398.2712333834925, 5443.455654434554, 5447.319085114361, 3164.6360668523184, 3831.9808400958027, 4059.2287465381633, 4067.491563554556, 4076.510818701745, 3536.982315088434, 3713.1274150574595, 3772.792496412696, 4183.414321994923, 4194.433751443562, 4081.673466122703, 4084.9591504085024, 4128.896777580554, 4138.772367519785, 4148.97925510372, 3512.1912215209186, 3803.82882770276, 3883.417487376888, 4120.567340429257, 4145.647619952278, 3615.854206840066, 3634.2549777295853, 3635.891053228764, 3639.890803275906, 3646.762960407565, 4972.6270529710055, 5263.973525162595, 5319.707416092114, 5345.866353341159, 5368.463153684639, 4583.335416364642, 4771.928421073687, 4790.616750659939, 4831.415192871832, 4865.391826021747, 5648.11945907586, 5675.808080303142, 5682.0, 5682.687452190128, 5740.425957404268, 3974.1852920151587, 3976.5426975897853, 3989.4215338776007, 4068.328725760246, 4071.4096456013713, 5191.961607678441, 5433.913217356505, 5806.680632565207, 5959.5899034714, 5987.760489580412, 4047.4131250968444, 4053.176070768166, 4065.1259979104634, 4068.7355321903983, 4094.134106125724, 3479.7390195734915, 3686.8570743069736, 4121.52602450716, 4180.686448516312, 4194.475690538683, 4274.4870615525715, 4777.641676874248, 4843.733594652257, 4857.247126695368, 4877.634177436636, 5059.848204553869, 5688.544916406678, 5732.369439361667, 5781.566382521328, 5834.708264586754, 1330.7272009238084, 1376.3187222324814, 1408.9925703122317, 1409.5700811252461, 1415.6390120519202, 741.5180132913649, 750.3621921366904, 778.875379939207, 799.9960000200078, 828.9336853051741, 4384.618845063795, 4727.338172655831, 5256.763445644955, 5294.947050529522, 5472.91790623141, 5334.679414454725, 5534.612577119644, 5725.799597014085, 5821.854453638693, 5835.0, 4343.8705936456745, 5159.678144834839, 5351.759170837322, 5374.758135883894, 5383.5423988961375, 2600.3759097816387, 2811.383454513622, 3023.833689147118, 3080.584121143617, 3080.7227349538202, 5538.944610553924, 5586.608937374426, 5727.341355744143, 5831.766729330864, 6099.359567245464, 5269.0, 5718.571107166979, 6016.398360163948, 6051.485623722033, 6096.451319381277, 5263.842084737387, 5642.379338272786, 5963.701814909324, 6085.62660562381, 6145.787516494059, 4688.765561721969, 5540.722963851872, 5818.4763371296785, 5834.679092649945, 5841.240638716939, 5654.519365853784, 5746.683932383759, 5760.654360738202, 5763.827085187451, 5771.480566749013, 5026.748662566784, 5813.680247586423, 6014.969925150522, 6036.63780173191, 6046.641809694311, 3823.4073718573663, 3839.540974429699, 3863.9760463476637, 4080.8979775504663, 4104.384342348671, 5109.897802044013, 5206.323177986837, 5283.762230699551, 5695.772169113355, 5917.6745279010065, 5794.768209271582, 5834.970825145847, 5842.2405087338375, 5863.736131874161, 5869.207656966426, 4747.053707979711, 4811.591014763644, 5656.105204756453, 5701.234901072893, 5735.283089613798, 4685.149366000479, 4875.512448755097, 5588.916166257591, 5628.943710562842, 5631.324241091095, 4141.053704758759, 4695.5304469552775, 5029.84910452687, 5522.530584900329, 5726.942730572808, 5572.888542229214, 5586.078297080936, 5590.329160500766, 5590.909772594305, 5634.1829085457275], "value": 4152.196828819289, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [690.2717632897293, 757.2200633347647, 793.5833687314159, 836.3267569606468, 853.8686240731029, 16090.839091609081, 16387.672246555092, 16779.24493397797, 16794.916025419872, 16823.83176168238, 15502.14738189402, 15562.37750489982, 15731.84268157318, 15749.291281892314, 15814.367425303002, 735.4043224987751, 759.2104211619909, 879.0769691823575, 899.7885496908222, 902.4810733828042, 741.8924255982879, 900.7252787899688, 904.0507467159456, 906.7642412972641, 910.2308549275851, 961.024560071528, 963.8843338799319, 964.0118878149882, 964.1178321835512, 966.6085235479642, 956.2923436656858, 957.301170145794, 957.4207604399343, 958.5063692198523, 959.098447459386, 702.1714377035097, 702.7505235641324, 706.2972342519175, 707.2503146664552, 709.1808960650457, 15308.081515109128, 15338.846611533965, 15356.923215383964, 15379.0, 15382.923085384613, 13352.866471335357, 13584.728305433837, 13888.791668124986, 15429.382824687, 15503.767443488357, 13359.131656442398, 13390.732185356239, 13585.184888906599, 13764.65588360289, 13796.655083622889, 4690.202665546865, 4749.833755818564, 4760.33355330254, 4791.520847915215, 4919.040787046527, 78733.21266787259, 96807.51596242044, 99764.50117749437, 124066.0, 128081.07878381832, 11116.61091861781, 11598.536058557564, 11612.303261804318, 11786.174967752175, 11828.52685892572, 23445.94493247808, 23457.41356466102, 23814.16650417227, 23816.523669526858, 23846.642300365507, 7246.420286377077, 8174.3460523158, 8250.133735957757, 8253.0, 8365.539895305696, 4484.641228701696, 4499.190145773727, 4598.471175814824, 4599.977000114978, 4714.882127946828, 3664.76179048361, 3800.448934904479, 3804.752691075071, 3816.2939856126704, 3816.580176180618, 668.9698963546653, 694.0768777525878, 695.8608278344351, 696.2723953468637, 702.8769965256059, 530.6630289766026, 578.2421438826005, 612.5528364294001, 708.6128306694011, 730.4339137168737, 9293.25653947696, 9397.57710903011, 9860.556274967643, 9981.301308908452, 10288.12550933179, 547.6577139287945, 573.8852229554105, 605.276694350256, 656.1306269193337, 676.993230067693, 4488.272015274078, 4873.512648735169, 4880.975595122001, 4907.190313598217, 4974.701517908937, 161144.0, 163618.1819090897, 163731.0, 165772.0, 170904.0, 135484.0, 136129.3193534026, 140135.8911670738, 140682.0, 146805.0, 98400.50799745956, 101893.0, 104473.0, 105725.47137264264, 108851.45574272236, 9376.531173441437, 9669.854952175583, 9973.863460317796, 10447.529861156114, 10698.73253168677, 50809.491905080475, 61836.690816545626, 62913.0, 62917.0, 66413.66793166003, 70585.0, 71762.0, 92279.53860230924, 95742.52128739591, 101369.0, 12239.632811015685, 13946.79079813824, 14256.572302830931, 14721.411143554138, 14753.778693319824, 15020.023698459565, 15207.695846082795, 15962.68074638524, 16167.919160404123, 16780.160991950597, 13877.79183312231, 14591.781123282946, 14756.852431475549, 15145.697086058437, 15575.84424155744, 12117.394130293274, 14545.490907818175, 14695.338709757872, 14703.485378011717, 14983.250837458301, 13448.529301474402, 13821.101628394123, 14332.713345732818, 14814.703705926036, 15384.38462461489, 11410.0, 11470.770584588094, 11637.359945203096, 12039.217450865666, 12106.334151621746, 11314.264572802742, 11598.768024639628, 11743.706407339885, 12001.339926304137, 12142.635720928387], "value": 8212.011563595777, "unit": "score"}], "name": "dromaeo_css", "value": 7610.207095963869, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 114.0, 114.0, 117.0, 164.0, 166.0, 114.0, 113.0, 113.0], "value": 124.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 131.0, 141.0, 176.0, 140.0, 107.0, 109.0, 105.0, 140.0, 103.0], "value": 130.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 183.0, 185.0, 184.0, 182.0, 184.0, 184.0, 182.0, 182.0, 183.0], "value": 183.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 59.0, 59.0, 87.0, 63.0, 62.0, 49.0, 74.0, 100.0, 81.0], "value": 71.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 69.0, 94.0, 69.0, 67.0, 70.0, 92.0, 68.0, 68.0, 90.0], "value": 77.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 84.0, 88.0, 84.0, 87.0, 84.0, 87.0, 85.0, 86.0, 83.0], "value": 85.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 92.0, 94.0, 94.0, 93.0, 93.0, 93.0, 93.0, 93.0, 93.0], "value": 93.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 84.0, 85.0, 83.0, 98.0, 132.0, 134.0, 84.0, 84.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 54.0, 55.0, 53.0, 54.0, 58.0, 58.0, 57.0, 56.0, 56.0], "value": 55.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 67.0, 79.0, 71.0, 72.0, 68.0, 69.0, 71.0, 71.0, 71.0], "value": 70.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 84.0, 84.0, 81.0, 81.0, 86.0, 86.0, 81.0, 100.0], "value": 85.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 134.0, 138.0, 142.0, 146.0, 132.0, 136.0, 132.0, 146.0, 136.0], "value": 137.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 160.0, 164.0, 159.0, 157.0, 152.0, 159.0, 165.0, 161.0, 159.0], "value": 159.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 68.0, 66.0, 65.0, 66.0, 65.0, 65.0, 68.0, 66.0, 67.0], "value": 66.1, "unit": "score"}], "name": "kraken", "value": 1436.1999999999998, "alertThreshold": 2.0}]} 21:37:09 INFO - Return code: 0 21:37:10 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 21:37:10 INFO - # TBPL SUCCESS # 21:37:10 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 21:37:10 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 21:37:10 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 21:37:10 INFO - 2016-12-21 21:37:10.076 screenresolution[29466:274638] starting screenresolution argv=screenresolution get 21:37:10 INFO - 2016-12-21 21:37:10.078 screenresolution[29466:274638] Display 0: 1600x1200x32@60 21:37:10 INFO - 2016-12-21 21:37:10.084 screenresolution[29467:274641] starting screenresolution argv=screenresolution list 21:37:10 INFO - Available Modes on Display 0 21:37:10 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 21:37:10 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 21:37:10 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 21:37:10 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 21:37:10 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 21:37:10 INFO - Intel Iris: 21:37:10 INFO - Chipset Model: Intel Iris 21:37:10 INFO - Type: GPU 21:37:10 INFO - Bus: Built-In 21:37:10 INFO - VRAM (Dynamic, Max): 1536 MB 21:37:10 INFO - Vendor: Intel (0x8086) 21:37:10 INFO - Device ID: 0x0a2e 21:37:10 INFO - Revision ID: 0x0009 21:37:10 INFO - Displays: 21:37:10 INFO - Display: 21:37:10 INFO - Resolution: 1600 x 1200 @ 60 Hz 21:37:10 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 21:37:10 INFO - Display Serial Number: 1600x1200 60 21:37:10 INFO - Main Display: Yes 21:37:10 INFO - Mirror: Off 21:37:10 INFO - Online: Yes 21:37:10 INFO - Rotation: Supported 21:37:10 INFO - Return code: 0 21:37:10 INFO - Running post-action listener: _resource_record_post_action 21:37:10 INFO - [mozharness: 2016-12-22 05:37:10.321731Z] Finished run-tests step (success) 21:37:10 INFO - Running post-run listener: _resource_record_post_run 21:37:10 INFO - Total resource usage - Wall time: 1196s; CPU: 53.0%; Read bytes: 31222784; Write bytes: 494938112; Read time: 187; Write time: 1566 21:37:10 INFO - TinderboxPrint: CPU usage
53.2% 21:37:10 INFO - TinderboxPrint: I/O read bytes / time
31,222,784 / 187 21:37:10 INFO - TinderboxPrint: I/O write bytes / time
494,938,112 / 1,566 21:37:10 INFO - TinderboxPrint: CPU idle
2,239.8 (46.8%) 21:37:10 INFO - TinderboxPrint: CPU system
960.4 (20.1%) 21:37:10 INFO - TinderboxPrint: CPU user
1,585.5 (33.1%) 21:37:10 INFO - TinderboxPrint: Swap in / out
220,700,672 / 0 21:37:10 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 190089728; Write bytes: 188084736; Read time: 17249; Write time: 426 21:37:10 INFO - run-tests - Wall time: 1175s; CPU: 53.0%; Read bytes: 30149632; Write bytes: 295699968; Read time: 180; Write time: 1101 21:37:10 INFO - Running post-run listener: _upload_blobber_files 21:37:10 INFO - Blob upload gear active. 21:37:10 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 21:37:10 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 21:37:10 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'] 21:37:10 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 21:37:11 INFO - (blobuploader) - INFO - Open directory for files ... 21:37:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 21:37:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:37:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:37:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 21:37:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:37:12 INFO - (blobuploader) - INFO - Done attempting. 21:37:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 21:37:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:37:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:37:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 21:37:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:37:13 INFO - (blobuploader) - INFO - Done attempting. 21:37:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 21:37:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:37:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:37:15 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 21:37:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:37:15 INFO - (blobuploader) - INFO - Done attempting. 21:37:15 INFO - (blobuploader) - INFO - Iteration through files over. 21:37:15 INFO - Return code: 0 21:37:15 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 21:37:15 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 21:37:15 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/cb97d35d0f3f5e305bcd5840c98656d25c7a5a5d8b73a82649109ecf307159c498731f0295098585de6b90e04ca95fac712013451c8eb3255f6897721f43645c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d7be54de0d3ee48ff0e423fa818c4946f19ba5229d3ae352433cb56a655ec758745ab50ade626336927f7b40645c6b0b71aca9d2035366db4e6f402e85279b2c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/fa6561625dda2ff68c6bae23a2c55b46e2d0eed3c95a2322250fadaab8a38984ee1e84a84e743087d66edaa75ec68fba2bb45b91504811efca8dab2ff4f52833"} 21:37:15 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 21:37:15 INFO - Writing to file /builds/slave/test/properties/blobber_files 21:37:15 INFO - Contents: 21:37:15 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/cb97d35d0f3f5e305bcd5840c98656d25c7a5a5d8b73a82649109ecf307159c498731f0295098585de6b90e04ca95fac712013451c8eb3255f6897721f43645c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d7be54de0d3ee48ff0e423fa818c4946f19ba5229d3ae352433cb56a655ec758745ab50ade626336927f7b40645c6b0b71aca9d2035366db4e6f402e85279b2c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/fa6561625dda2ff68c6bae23a2c55b46e2d0eed3c95a2322250fadaab8a38984ee1e84a84e743087d66edaa75ec68fba2bb45b91504811efca8dab2ff4f52833"} 21:37:15 INFO - Running post-run listener: copy_logs_to_upload_dir 21:37:15 INFO - Copying logs to upload dir... 21:37:15 INFO - mkdir: /builds/slave/test/build/upload/logs 21:37:15 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1254.855905 ========= master_lag: 0.87 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2016-12-21 21:37:16.263185) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-21 21:37:16.270456) ========= 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.3rpVj1KJlS/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.5lI1E4LAZQ/Listeners TMPDIR=/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/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/cb97d35d0f3f5e305bcd5840c98656d25c7a5a5d8b73a82649109ecf307159c498731f0295098585de6b90e04ca95fac712013451c8eb3255f6897721f43645c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d7be54de0d3ee48ff0e423fa818c4946f19ba5229d3ae352433cb56a655ec758745ab50ade626336927f7b40645c6b0b71aca9d2035366db4e6f402e85279b2c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/fa6561625dda2ff68c6bae23a2c55b46e2d0eed3c95a2322250fadaab8a38984ee1e84a84e743087d66edaa75ec68fba2bb45b91504811efca8dab2ff4f52833"} build_url:https://queue.taskcluster.net/v1/task/ZEuTLy-ST1-mj_UyD7eIxQ/artifacts/public/build/firefox-51.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011028 build_url: 'https://queue.taskcluster.net/v1/task/ZEuTLy-ST1-mj_UyD7eIxQ/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/cb97d35d0f3f5e305bcd5840c98656d25c7a5a5d8b73a82649109ecf307159c498731f0295098585de6b90e04ca95fac712013451c8eb3255f6897721f43645c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d7be54de0d3ee48ff0e423fa818c4946f19ba5229d3ae352433cb56a655ec758745ab50ade626336927f7b40645c6b0b71aca9d2035366db4e6f402e85279b2c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/fa6561625dda2ff68c6bae23a2c55b46e2d0eed3c95a2322250fadaab8a38984ee1e84a84e743087d66edaa75ec68fba2bb45b91504811efca8dab2ff4f52833"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-21 21:37:16.315174) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-21 21:37:16.315518) ========= 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.3rpVj1KJlS/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.5lI1E4LAZQ/Listeners TMPDIR=/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/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.005472 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-21 21:37:16.364757) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-21 21:37:16.365109) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-21 21:37:16.365412) ========= ========= Total master_lag: 1.02 =========