builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0293 starttime: 1483550298.18 results: success (0) buildid: 20170104061938 builduid: 2bea09c8749f46eda187e23a1887d296 revision: 8d8533198db9f71ab9cca9727e387fac8ef28a08 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-04 09:18:18.176387) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-04 09:18:18.176849) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-04 09:18:18.177167) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-04 09:18:18.267621) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-04 09:18:18.268119) ========= 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.UisKHEU7VB/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.msKkbAvfu1/Listeners TMPDIR=/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-01-04 09:18:18-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 7.82M=0.001s 2017-01-04 09:18:18 (7.82 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.122348 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-04 09:18:18.418589) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-04 09:18:18.418905) ========= 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.UisKHEU7VB/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.msKkbAvfu1/Listeners TMPDIR=/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/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.019624 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-04 09:18:18.467882) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-04 09:18:18.468308) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 8d8533198db9f71ab9cca9727e387fac8ef28a08 --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 8d8533198db9f71ab9cca9727e387fac8ef28a08 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.UisKHEU7VB/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.msKkbAvfu1/Listeners TMPDIR=/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-01-04 09:18:18,555 truncating revision to first 12 chars 2017-01-04 09:18:18,555 Setting DEBUG logging. 2017-01-04 09:18:18,555 attempt 1/10 2017-01-04 09:18:18,555 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/8d8533198db9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-04 09:18:19,903 unpacking tar archive at: mozilla-beta-8d8533198db9/testing/mozharness/ program finished with exit code 0 elapsedTime=1.615628 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-04 09:18:20.107815) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-04 09:18:20.108212) ========= script_repo_revision: 8d8533198db9f71ab9cca9727e387fac8ef28a08 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-04 09:18:20.108667) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-04 09:18:20.108984) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-04 09:18:20.129203) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2017-01-04 09:18:20.129634) ========= /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.UisKHEU7VB/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.msKkbAvfu1/Listeners TMPDIR=/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 09:18:20 INFO - MultiFileLogger online at 20170104 09:18:20 in /builds/slave/test 09:18: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 09:18:20 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:18:20 INFO - {'append_to_log': False, 09:18:20 INFO - 'base_work_dir': '/builds/slave/test', 09:18:20 INFO - 'blob_upload_branch': 'Mozilla-Beta', 09:18:20 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:18:20 INFO - 'branch': 'Mozilla-Beta', 09:18:20 INFO - 'buildbot_json_path': 'buildprops.json', 09:18:20 INFO - 'config_files': ('talos/mac_config.py',), 09:18:20 INFO - 'default_actions': ('clobber', 09:18:20 INFO - 'read-buildbot-config', 09:18:20 INFO - 'download-and-extract', 09:18:20 INFO - 'populate-webroot', 09:18:20 INFO - 'create-virtualenv', 09:18:20 INFO - 'install', 09:18:20 INFO - 'run-tests'), 09:18:20 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:18:20 INFO - 'download_minidump_stackwalk': True, 09:18:20 INFO - 'download_symbols': 'ondemand', 09:18:20 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:18:20 INFO - 'tooltool.py': '/tools/tooltool.py', 09:18:20 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:18:20 INFO - '/tools/misc-python/virtualenv.py')}, 09:18:20 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:18:20 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:18:20 INFO - 'installer_path': 'installer.exe', 09:18:20 INFO - 'log_level': 'info', 09:18:20 INFO - 'log_name': 'talos', 09:18:20 INFO - 'log_to_console': True, 09:18:20 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 09:18:20 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 09:18:20 INFO - 'opt_config_files': (), 09:18:20 INFO - 'pip_index': False, 09:18:20 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:18:20 INFO - 'cmd': ('bash', 09:18:20 INFO - '-c', 09:18:20 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:18:20 INFO - 'enabled': True, 09:18:20 INFO - 'halt_on_failure': False, 09:18:20 INFO - 'name': 'check_screen_resolution'},), 09:18:20 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:18:20 INFO - 'cmd': ('bash', 09:18:20 INFO - '-c', 09:18:20 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:18:20 INFO - 'enabled': True, 09:18:20 INFO - 'halt_on_failure': False, 09:18:20 INFO - 'name': 'check_screen_resolution'},), 09:18:20 INFO - 'run_cmd_checks_enabled': True, 09:18:20 INFO - 'sps_profile': False, 09:18:20 INFO - 'sps_profile_interval': 0, 09:18:20 INFO - 'suite': 'dromaeojs', 09:18:20 INFO - 'system_bits': '32', 09:18:20 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:18:20 INFO - 'title': 't-yosemite-r7-0293', 09:18:20 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:18:20 INFO - 'use_talos_json': True, 09:18:20 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:18:20 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:18:20 INFO - 'work_dir': 'build'} 09:18:20 INFO - [mozharness: 2017-01-04 17:18:20.328254Z] Running clobber step. 09:18:20 INFO - Running pre-action listener: _resource_record_pre_action 09:18:20 INFO - Running main action method: clobber 09:18:20 INFO - rmtree: /builds/slave/test/build 09:18:20 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:18:21 INFO - Running post-action listener: _resource_record_post_action 09:18:21 INFO - [mozharness: 2017-01-04 17:18:21.219353Z] Finished clobber step (success) 09:18:21 INFO - [mozharness: 2017-01-04 17:18:21.219489Z] Running read-buildbot-config step. 09:18:21 INFO - Running pre-action listener: _resource_record_pre_action 09:18:21 INFO - Running main action method: read_buildbot_config 09:18:21 INFO - Using buildbot properties: 09:18:21 INFO - { 09:18:21 INFO - "project": "", 09:18:21 INFO - "product": "firefox", 09:18:21 INFO - "script_repo_revision": "production", 09:18:21 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 09:18:21 INFO - "repository": "", 09:18:21 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 09:18:21 INFO - "buildid": "20170104061938", 09:18:21 INFO - "pgo_build": "False", 09:18:21 INFO - "basedir": "/builds/slave/test", 09:18:21 INFO - "buildnumber": 2, 09:18:21 INFO - "slavename": "t-yosemite-r7-0293", 09:18:21 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 09:18:21 INFO - "platform": "yosemite_r7", 09:18:21 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 09:18:21 INFO - "branch": "mozilla-beta", 09:18:21 INFO - "repo_path": "releases/mozilla-beta", 09:18:21 INFO - "revision": "8d8533198db9f71ab9cca9727e387fac8ef28a08", 09:18:21 INFO - "stage_platform": "macosx64", 09:18:21 INFO - "builduid": "2bea09c8749f46eda187e23a1887d296", 09:18:21 INFO - "slavebuilddir": "test" 09:18:21 INFO - } 09:18:21 INFO - Found installer url https://queue.taskcluster.net/v1/task/HCQJgrRxSjmD8wBQfUivxQ/artifacts/public/build/firefox-51.0.en-US.mac.dmg. 09:18:21 INFO - Running post-action listener: _resource_record_post_action 09:18:21 INFO - [mozharness: 2017-01-04 17:18:21.222801Z] Finished read-buildbot-config step (success) 09:18:21 INFO - [mozharness: 2017-01-04 17:18:21.222924Z] Running download-and-extract step. 09:18:21 INFO - Running pre-action listener: _resource_record_pre_action 09:18:21 INFO - Running main action method: download_and_extract 09:18:21 INFO - mkdir: /builds/slave/test/build/tests 09:18: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')]} 09:18:21 INFO - trying https://queue.taskcluster.net/v1/task/HCQJgrRxSjmD8wBQfUivxQ/artifacts/public/build/firefox-51.0.en-US.mac.test_packages.json 09:18:21 INFO - Downloading https://queue.taskcluster.net/v1/task/HCQJgrRxSjmD8wBQfUivxQ/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 09:18:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HCQJgrRxSjmD8wBQfUivxQ/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 09:18:22 INFO - Downloaded 1165 bytes. 09:18:22 INFO - Reading from file /builds/slave/test/build/firefox-51.0.en-US.mac.test_packages.json 09:18:22 INFO - Using the following test package requirements: 09:18:22 INFO - {u'common': [u'firefox-51.0.en-US.mac.common.tests.zip'], 09:18:22 INFO - u'cppunittest': [u'firefox-51.0.en-US.mac.common.tests.zip', 09:18:22 INFO - u'firefox-51.0.en-US.mac.cppunittest.tests.zip'], 09:18:22 INFO - u'gtest': [u'firefox-51.0.en-US.mac.common.tests.zip', 09:18:22 INFO - u'firefox-51.0.en-US.mac.gtest.tests.zip'], 09:18:22 INFO - u'jittest': [u'firefox-51.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 09:18:22 INFO - u'mochitest': [u'firefox-51.0.en-US.mac.common.tests.zip', 09:18:22 INFO - u'firefox-51.0.en-US.mac.mochitest.tests.zip'], 09:18:22 INFO - u'mozbase': [u'firefox-51.0.en-US.mac.common.tests.zip'], 09:18:22 INFO - u'reftest': [u'firefox-51.0.en-US.mac.common.tests.zip', 09:18:22 INFO - u'firefox-51.0.en-US.mac.reftest.tests.zip'], 09:18:22 INFO - u'talos': [u'firefox-51.0.en-US.mac.common.tests.zip', 09:18:22 INFO - u'firefox-51.0.en-US.mac.talos.tests.zip'], 09:18:22 INFO - u'web-platform': [u'firefox-51.0.en-US.mac.common.tests.zip', 09:18:22 INFO - u'firefox-51.0.en-US.mac.web-platform.tests.zip'], 09:18:22 INFO - u'xpcshell': [u'firefox-51.0.en-US.mac.common.tests.zip', 09:18:22 INFO - u'firefox-51.0.en-US.mac.xpcshell.tests.zip']} 09:18:22 INFO - Downloading packages: [u'firefox-51.0.en-US.mac.common.tests.zip'] for test suite category: common 09:18:22 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HCQJgrRxSjmD8wBQfUivxQ/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip 09:18:22 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HCQJgrRxSjmD8wBQfUivxQ/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip'}, attempt #1 09:18:22 INFO - Fetch https://queue.taskcluster.net/v1/task/HCQJgrRxSjmD8wBQfUivxQ/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip into memory 09:18:22 INFO - Expected file size: 16234530 09:18:29 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 09:18:29 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HCQJgrRxSjmD8wBQfUivxQ/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip 09:18:29 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HCQJgrRxSjmD8wBQfUivxQ/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip'}, attempt #1 09:18:29 INFO - Fetch https://queue.taskcluster.net/v1/task/HCQJgrRxSjmD8wBQfUivxQ/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip into memory 09:18:30 INFO - Expected file size: 16234530 09:18:36 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HCQJgrRxSjmD8wBQfUivxQ/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip 09:18:36 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HCQJgrRxSjmD8wBQfUivxQ/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip'}, attempt #1 09:18:36 INFO - Fetch https://queue.taskcluster.net/v1/task/HCQJgrRxSjmD8wBQfUivxQ/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip into memory 09:18:37 INFO - Expected file size: 14414089 09:18:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:18:37 INFO - trying https://queue.taskcluster.net/v1/task/HCQJgrRxSjmD8wBQfUivxQ/artifacts/public/build/firefox-51.0.en-US.mac.dmg 09:18:37 INFO - Downloading https://queue.taskcluster.net/v1/task/HCQJgrRxSjmD8wBQfUivxQ/artifacts/public/build/firefox-51.0.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0.en-US.mac.dmg 09:18:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HCQJgrRxSjmD8wBQfUivxQ/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 09:18:40 INFO - Downloaded 86096385 bytes. 09:18:40 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HCQJgrRxSjmD8wBQfUivxQ/artifacts/public/build/firefox-51.0.en-US.mac.dmg 09:18:40 INFO - mkdir: /builds/slave/test/properties 09:18:40 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:18:40 INFO - Writing to file /builds/slave/test/properties/build_url 09:18:40 INFO - Contents: 09:18:40 INFO - build_url:https://queue.taskcluster.net/v1/task/HCQJgrRxSjmD8wBQfUivxQ/artifacts/public/build/firefox-51.0.en-US.mac.dmg 09:18:40 INFO - Running post-action listener: _resource_record_post_action 09:18:40 INFO - Running post-action listener: set_extra_try_arguments 09:18:40 INFO - [mozharness: 2017-01-04 17:18:40.710386Z] Finished download-and-extract step (success) 09:18:40 INFO - [mozharness: 2017-01-04 17:18:40.710509Z] Running populate-webroot step. 09:18:40 INFO - Running pre-action listener: _resource_record_pre_action 09:18:40 INFO - Running main action method: populate_webroot 09:18:40 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:18:40 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:18:40 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:18:40 INFO - '--tppagecycles', 09:18:40 INFO - '7'], 09:18:40 INFO - 'tests': ['tsvgm']}}, 09:18:40 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:18:40 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:18:40 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:18:40 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:18:40 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:18:40 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:18:40 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:18:40 INFO - 'talos_options': ['--disable-e10s'], 09:18:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:18:40 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:18:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:18:40 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:18:40 INFO - 'talos_options': ['--disable-e10s'], 09:18:40 INFO - 'tests': ['damp', 'tps']}, 09:18:40 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:18:40 INFO - 'tests': ['damp', 'tps']}, 09:18:40 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:18:40 INFO - 'tests': ['dromaeo_dom']}, 09:18:40 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:18:40 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:18:40 INFO - 'tests': ['basic_compositor_video']}, 09:18:40 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:18:40 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:18:40 INFO - 'tests': ['a11yr', 09:18:40 INFO - 'ts_paint', 09:18:40 INFO - 'tpaint', 09:18:40 INFO - 'sessionrestore', 09:18:40 INFO - 'sessionrestore_no_auto_restore', 09:18:40 INFO - 'tabpaint']}, 09:18:40 INFO - 'other-e10s': {'tests': ['a11yr', 09:18:40 INFO - 'ts_paint', 09:18:40 INFO - 'tpaint', 09:18:40 INFO - 'sessionrestore', 09:18:40 INFO - 'sessionrestore_no_auto_restore', 09:18:40 INFO - 'tabpaint']}, 09:18:40 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:18:40 INFO - 'ts_paint', 09:18:40 INFO - 'tpaint', 09:18:40 INFO - 'sessionrestore', 09:18:40 INFO - 'sessionrestore_no_auto_restore', 09:18:40 INFO - 'tabpaint']}, 09:18:40 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:18:40 INFO - 'ts_paint', 09:18:40 INFO - 'tpaint', 09:18:40 INFO - 'sessionrestore', 09:18:40 INFO - 'sessionrestore_no_auto_restore', 09:18:40 INFO - 'tabpaint']}, 09:18:40 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:18:40 INFO - 'tests': ['a11yr', 09:18:40 INFO - 'ts_paint', 09:18:40 INFO - 'tpaint', 09:18:40 INFO - 'sessionrestore', 09:18:40 INFO - 'sessionrestore_no_auto_restore', 09:18:40 INFO - 'tabpaint']}, 09:18:40 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:18:40 INFO - 'tests': ['a11yr', 09:18:40 INFO - 'ts_paint', 09:18:40 INFO - 'tpaint', 09:18:40 INFO - 'sessionrestore', 09:18:40 INFO - 'sessionrestore_no_auto_restore', 09:18:40 INFO - 'tabpaint']}, 09:18:40 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:18:40 INFO - 'tests': ['tsvgx', 09:18:40 INFO - 'tsvgr_opacity', 09:18:40 INFO - 'tart', 09:18:40 INFO - 'tscrollx', 09:18:40 INFO - 'cart']}, 09:18:40 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:18:40 INFO - 'tsvgr_opacity', 09:18:40 INFO - 'tart', 09:18:40 INFO - 'tscrollx', 09:18:40 INFO - 'cart']}, 09:18:40 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:18:40 INFO - 'talos_options': ['--disable-e10s'], 09:18:40 INFO - 'tests': ['tp5o']}, 09:18:40 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:18:40 INFO - 'tests': ['tp5o']}, 09:18:40 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:18:40 INFO - 'talos_options': ['--disable-e10s', 09:18:40 INFO - '--xperf_path', 09:18:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:18:40 INFO - 'tests': ['tp5n']}, 09:18:40 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:18:40 INFO - 'talos_options': ['--xperf_path', 09:18:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:18:40 INFO - 'tests': ['tp5n']}}, 09:18:40 INFO - 'talos.zip': {'path': '', 09:18:40 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:18:40 INFO - Running post-action listener: _resource_record_post_action 09:18:40 INFO - [mozharness: 2017-01-04 17:18:40.729603Z] Finished populate-webroot step (success) 09:18:40 INFO - [mozharness: 2017-01-04 17:18:40.729736Z] Running create-virtualenv step. 09:18:40 INFO - Running pre-action listener: _resource_record_pre_action 09:18:40 INFO - Running main action method: create_virtualenv 09:18:40 INFO - Creating virtualenv /builds/slave/test/build/venv 09:18:40 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 09:18:40 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:18:40 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:18:40 INFO - Using real prefix '/tools/python27' 09:18:40 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:18:41 INFO - Installing distribute.............................................................................................................................................................................................done. 09:18:44 INFO - Installing pip.................done. 09:18:44 INFO - Return code: 0 09:18:44 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:18:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:18:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:18:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:18:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:18:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18:44 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 0x108603490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108579570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffbb848fa80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108417d30>, '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 0x10827ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10840fb20>, '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.UisKHEU7VB/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.msKkbAvfu1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:18:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 09:18:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:18:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UisKHEU7VB/Render', 09:18:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:18:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:18:44 INFO - 'HOME': '/Users/cltbld', 09:18:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:18:44 INFO - 'LOGNAME': 'cltbld', 09:18:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:18:44 INFO - 'MOZ_NO_REMOTE': '1', 09:18:44 INFO - 'NO_EM_RESTART': '1', 09:18:44 INFO - 'PAGER': '/bin/cat', 09:18:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:18:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:18:44 INFO - 'PWD': '/builds/slave/test', 09:18:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:18:44 INFO - 'SHELL': '/bin/bash', 09:18:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.msKkbAvfu1/Listeners', 09:18:44 INFO - 'TMPDIR': '/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/', 09:18:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:18:44 INFO - 'USER': 'cltbld', 09:18:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:18:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:18:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:18:44 INFO - 'XPC_FLAGS': '0x0', 09:18:44 INFO - 'XPC_SERVICE_NAME': '0', 09:18:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:18:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:18:44 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 09:18:44 INFO - Cleaning up... 09:18:44 INFO - Return code: 0 09:18:44 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:18:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:18:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:18:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:18:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:18:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18:44 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 0x108603490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108579570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffbb848fa80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108417d30>, '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 0x10827ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10840fb20>, '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.UisKHEU7VB/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.msKkbAvfu1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:18:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 09:18:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 09:18:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UisKHEU7VB/Render', 09:18:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:18:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:18:44 INFO - 'HOME': '/Users/cltbld', 09:18:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:18:44 INFO - 'LOGNAME': 'cltbld', 09:18:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:18:44 INFO - 'MOZ_NO_REMOTE': '1', 09:18:44 INFO - 'NO_EM_RESTART': '1', 09:18:44 INFO - 'PAGER': '/bin/cat', 09:18:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:18:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:18:44 INFO - 'PWD': '/builds/slave/test', 09:18:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:18:44 INFO - 'SHELL': '/bin/bash', 09:18:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.msKkbAvfu1/Listeners', 09:18:44 INFO - 'TMPDIR': '/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/', 09:18:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:18:44 INFO - 'USER': 'cltbld', 09:18:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:18:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:18:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:18:44 INFO - 'XPC_FLAGS': '0x0', 09:18:44 INFO - 'XPC_SERVICE_NAME': '0', 09:18:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:18:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:18:44 INFO - Downloading/unpacking psutil>=3.1.1 09:18:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:18:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:18:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:18:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:18:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:18:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:18:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:18:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:18:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:18:48 INFO - Installing collected packages: psutil 09:18:48 INFO - Running setup.py install for psutil 09:18:48 INFO - building 'psutil._psutil_osx' extension 09:18:48 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 09:18:48 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 09:18:48 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 09:18:48 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 09:18:48 INFO - building 'psutil._psutil_posix' extension 09:18:48 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 09:18:48 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 09:18:48 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 09:18:48 INFO - ^ 09:18:48 INFO - 1 warning generated. 09:18:48 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 09:18:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:18:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:18:48 INFO - Successfully installed psutil 09:18:48 INFO - Cleaning up... 09:18:48 INFO - Return code: 0 09:18:48 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:18:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:18:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:18:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:18:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:18:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18:48 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 0x108603490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108579570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffbb848fa80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108417d30>, '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 0x10827ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10840fb20>, '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.UisKHEU7VB/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.msKkbAvfu1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:18:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 09:18:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 09:18:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UisKHEU7VB/Render', 09:18:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:18:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:18:48 INFO - 'HOME': '/Users/cltbld', 09:18:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:18:48 INFO - 'LOGNAME': 'cltbld', 09:18:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:18:48 INFO - 'MOZ_NO_REMOTE': '1', 09:18:48 INFO - 'NO_EM_RESTART': '1', 09:18:48 INFO - 'PAGER': '/bin/cat', 09:18:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:18:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:18:48 INFO - 'PWD': '/builds/slave/test', 09:18:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:18:48 INFO - 'SHELL': '/bin/bash', 09:18:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.msKkbAvfu1/Listeners', 09:18:48 INFO - 'TMPDIR': '/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/', 09:18:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:18:48 INFO - 'USER': 'cltbld', 09:18:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:18:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:18:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:18:48 INFO - 'XPC_FLAGS': '0x0', 09:18:48 INFO - 'XPC_SERVICE_NAME': '0', 09:18:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:18:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:18:49 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:18:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:18:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:18:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:18:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:18:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:18:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:18:51 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:18:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:18:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:18:51 INFO - Installing collected packages: mozsystemmonitor 09:18:51 INFO - Running setup.py install for mozsystemmonitor 09:18:51 INFO - Successfully installed mozsystemmonitor 09:18:51 INFO - Cleaning up... 09:18:52 INFO - Return code: 0 09:18:52 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:18:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:18:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:18:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:18:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:18:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18:52 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 0x108603490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108579570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffbb848fa80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108417d30>, '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 0x10827ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10840fb20>, '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.UisKHEU7VB/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.msKkbAvfu1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:18:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 09:18:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 09:18:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UisKHEU7VB/Render', 09:18:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:18:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:18:52 INFO - 'HOME': '/Users/cltbld', 09:18:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:18:52 INFO - 'LOGNAME': 'cltbld', 09:18:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:18:52 INFO - 'MOZ_NO_REMOTE': '1', 09:18:52 INFO - 'NO_EM_RESTART': '1', 09:18:52 INFO - 'PAGER': '/bin/cat', 09:18:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:18:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:18:52 INFO - 'PWD': '/builds/slave/test', 09:18:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:18:52 INFO - 'SHELL': '/bin/bash', 09:18:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.msKkbAvfu1/Listeners', 09:18:52 INFO - 'TMPDIR': '/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/', 09:18:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:18:52 INFO - 'USER': 'cltbld', 09:18:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:18:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:18:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:18:52 INFO - 'XPC_FLAGS': '0x0', 09:18:52 INFO - 'XPC_SERVICE_NAME': '0', 09:18:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:18:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:18:52 INFO - Downloading/unpacking jsonschema==2.5.1 09:18:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:18:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:18:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:18:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:18:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:18:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:18:54 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:18:54 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:18:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:18:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:18:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:18:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:18:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:18:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:18:55 INFO - Downloading functools32-3.2.3-2.tar.gz 09:18:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:18:55 INFO - warning: no files found matching '*.txt' 09:18:55 INFO - no previously-included directories found matching 'build' 09:18:55 INFO - no previously-included directories found matching 'dist' 09:18:55 INFO - no previously-included directories found matching '.git*' 09:18:55 INFO - Installing collected packages: jsonschema, functools32 09:18:55 INFO - Running setup.py install for functools32 09:18:55 INFO - warning: no files found matching '*.txt' 09:18:55 INFO - no previously-included directories found matching 'build' 09:18:55 INFO - no previously-included directories found matching 'dist' 09:18:55 INFO - no previously-included directories found matching '.git*' 09:18:55 INFO - Successfully installed jsonschema functools32 09:18:55 INFO - Cleaning up... 09:18:55 INFO - Return code: 0 09:18:55 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:18:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:18:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:18:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:18:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:18:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x108603490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108579570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffbb848fa80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108417d30>, '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 0x10827ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10840fb20>, '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.UisKHEU7VB/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.msKkbAvfu1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:18:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 09:18:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 09:18:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UisKHEU7VB/Render', 09:18:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:18:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:18:55 INFO - 'HOME': '/Users/cltbld', 09:18:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:18:55 INFO - 'LOGNAME': 'cltbld', 09:18:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:18:55 INFO - 'MOZ_NO_REMOTE': '1', 09:18:55 INFO - 'NO_EM_RESTART': '1', 09:18:55 INFO - 'PAGER': '/bin/cat', 09:18:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:18:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:18:55 INFO - 'PWD': '/builds/slave/test', 09:18:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:18:55 INFO - 'SHELL': '/bin/bash', 09:18:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.msKkbAvfu1/Listeners', 09:18:55 INFO - 'TMPDIR': '/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/', 09:18:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:18:55 INFO - 'USER': 'cltbld', 09:18:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:18:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:18:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:18:55 INFO - 'XPC_FLAGS': '0x0', 09:18:55 INFO - 'XPC_SERVICE_NAME': '0', 09:18:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:18:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:18:55 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:18:55 INFO - Cleaning up... 09:18:56 INFO - Return code: 0 09:18:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:18:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:18:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:18:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:18:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:18:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x108603490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108579570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffbb848fa80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108417d30>, '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 0x10827ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10840fb20>, '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.UisKHEU7VB/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.msKkbAvfu1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:18:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:18:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:18:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UisKHEU7VB/Render', 09:18:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:18:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:18:56 INFO - 'HOME': '/Users/cltbld', 09:18:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:18:56 INFO - 'LOGNAME': 'cltbld', 09:18:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:18:56 INFO - 'MOZ_NO_REMOTE': '1', 09:18:56 INFO - 'NO_EM_RESTART': '1', 09:18:56 INFO - 'PAGER': '/bin/cat', 09:18:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:18:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:18:56 INFO - 'PWD': '/builds/slave/test', 09:18:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:18:56 INFO - 'SHELL': '/bin/bash', 09:18:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.msKkbAvfu1/Listeners', 09:18:56 INFO - 'TMPDIR': '/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/', 09:18:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:18:56 INFO - 'USER': 'cltbld', 09:18:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:18:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:18:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:18:56 INFO - 'XPC_FLAGS': '0x0', 09:18:56 INFO - 'XPC_SERVICE_NAME': '0', 09:18:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:18:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:18:56 INFO - Downloading/unpacking blobuploader==1.2.4 09:18: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 09:18: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 09:18: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 09:18: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 09:18: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 09:18: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 09:18:58 INFO - Downloading blobuploader-1.2.4.tar.gz 09:18:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:18:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:18:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:18:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:18:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:18:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:18:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:18:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:18:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:18:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:18:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:18:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:18:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:18:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:18:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:18:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:19:00 INFO - Downloading docopt-0.6.1.tar.gz 09:19:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:19:00 INFO - Installing collected packages: blobuploader, requests, docopt 09:19:00 INFO - Running setup.py install for blobuploader 09:19:00 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:19:00 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:19:00 INFO - Running setup.py install for requests 09:19:00 INFO - Running setup.py install for docopt 09:19:00 INFO - Successfully installed blobuploader requests docopt 09:19:00 INFO - Cleaning up... 09:19:01 INFO - Return code: 0 09:19:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:19:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:19:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:19:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:19:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:19:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:01 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 0x108603490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108579570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffbb848fa80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108417d30>, '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 0x10827ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10840fb20>, '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.UisKHEU7VB/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.msKkbAvfu1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:19:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:19:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:19:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UisKHEU7VB/Render', 09:19:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:19:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:19:01 INFO - 'HOME': '/Users/cltbld', 09:19:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:19:01 INFO - 'LOGNAME': 'cltbld', 09:19:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:19:01 INFO - 'MOZ_NO_REMOTE': '1', 09:19:01 INFO - 'NO_EM_RESTART': '1', 09:19:01 INFO - 'PAGER': '/bin/cat', 09:19:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:19:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:19:01 INFO - 'PWD': '/builds/slave/test', 09:19:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:19:01 INFO - 'SHELL': '/bin/bash', 09:19:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.msKkbAvfu1/Listeners', 09:19:01 INFO - 'TMPDIR': '/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/', 09:19:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:19:01 INFO - 'USER': 'cltbld', 09:19:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:19:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:19:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:19:01 INFO - 'XPC_FLAGS': '0x0', 09:19:01 INFO - 'XPC_SERVICE_NAME': '0', 09:19:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:19:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:19:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:19:01 INFO - Running setup.py (path:/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/pip-6QVgqP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:19:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:19:01 INFO - Running setup.py (path:/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/pip-NZ38gU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:19:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:19:01 INFO - Running setup.py (path:/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/pip-oYpcsn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:19:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:19:01 INFO - Running setup.py (path:/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/pip-eBqyWz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:19:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:19:01 INFO - Running setup.py (path:/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/pip-ktatVL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:19:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:19:01 INFO - Running setup.py (path:/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/pip-usz2iV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:19:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:19:01 INFO - Running setup.py (path:/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/pip-FTeRYy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:19:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:19:02 INFO - Running setup.py (path:/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/pip-2jx_km-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:19:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:19:02 INFO - Running setup.py (path:/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/pip-mnMTqC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:19:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:19:02 INFO - Running setup.py (path:/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/pip-Cj1Kx4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:19:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:19:02 INFO - Running setup.py (path:/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/pip-OXvRGW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:19:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:19:02 INFO - Running setup.py (path:/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/pip-BwtFBc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:19:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:19:02 INFO - Running setup.py (path:/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/pip-qcCvHI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:19:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:19:02 INFO - Running setup.py (path:/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/pip-PcDUrP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:19:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:19:02 INFO - Running setup.py (path:/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/pip-2np7Yl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:19:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:19:02 INFO - Running setup.py (path:/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/pip-QnIOtk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:19:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:19:03 INFO - Running setup.py (path:/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/pip-cToqUw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:19:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:19:03 INFO - Running setup.py install for manifestparser 09:19:03 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:19:03 INFO - Running setup.py install for mozcrash 09:19:03 INFO - Running setup.py install for mozdebug 09:19:03 INFO - Running setup.py install for mozdevice 09:19:03 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:19:03 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:19:03 INFO - Running setup.py install for mozfile 09:19:03 INFO - Running setup.py install for mozhttpd 09:19:03 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:19:04 INFO - Running setup.py install for mozinfo 09:19:04 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:19:04 INFO - Running setup.py install for mozInstall 09:19:04 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:19:04 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:19:04 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:19:04 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:19:04 INFO - Running setup.py install for mozleak 09:19:04 INFO - Running setup.py install for mozlog 09:19:04 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:19:04 INFO - Running setup.py install for moznetwork 09:19:04 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:19:04 INFO - Running setup.py install for mozprocess 09:19:04 INFO - Running setup.py install for mozprofile 09:19:05 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:19:05 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:19:05 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:19:05 INFO - Running setup.py install for mozrunner 09:19:05 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:19:05 INFO - Running setup.py install for mozscreenshot 09:19:05 INFO - Running setup.py install for moztest 09:19:05 INFO - Running setup.py install for mozversion 09:19:05 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:19:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:19:05 INFO - Cleaning up... 09:19:05 INFO - Return code: 0 09:19:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:19:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:19:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:19:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:19:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:19:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:05 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 0x108603490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108579570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffbb848fa80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108417d30>, '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 0x10827ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10840fb20>, '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.UisKHEU7VB/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.msKkbAvfu1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:19:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:19:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:19:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UisKHEU7VB/Render', 09:19:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:19:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:19:05 INFO - 'HOME': '/Users/cltbld', 09:19:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:19:05 INFO - 'LOGNAME': 'cltbld', 09:19:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:19:05 INFO - 'MOZ_NO_REMOTE': '1', 09:19:05 INFO - 'NO_EM_RESTART': '1', 09:19:05 INFO - 'PAGER': '/bin/cat', 09:19:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:19:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:19:05 INFO - 'PWD': '/builds/slave/test', 09:19:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:19:05 INFO - 'SHELL': '/bin/bash', 09:19:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.msKkbAvfu1/Listeners', 09:19:05 INFO - 'TMPDIR': '/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/', 09:19:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:19:05 INFO - 'USER': 'cltbld', 09:19:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:19:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:19:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:19:05 INFO - 'XPC_FLAGS': '0x0', 09:19:05 INFO - 'XPC_SERVICE_NAME': '0', 09:19:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:19:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:19:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:19:05 INFO - Running setup.py (path:/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/pip-Xoz5x3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:19:06 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 09:19:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:19:06 INFO - Running setup.py (path:/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/pip-Yw9vxa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:19:06 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)) 09:19:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:19:06 INFO - Running setup.py (path:/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/pip-IFXXSJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:19:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:19:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:19:06 INFO - Running setup.py (path:/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/pip-wQ3o4L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:19:06 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)) 09:19:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:19:06 INFO - Running setup.py (path:/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/pip-mGLQ8V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:19:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 09:19:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:19:06 INFO - Running setup.py (path:/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/pip-JEDodf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:19:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 09:19:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:19:06 INFO - Running setup.py (path:/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/pip-zwg5xb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:19:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 09:19:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:19:06 INFO - Running setup.py (path:/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/pip-m8uPFX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:19:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 09:19:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:19:06 INFO - Running setup.py (path:/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/pip-BIcQeS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:19:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 09:19:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:19:06 INFO - Running setup.py (path:/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/pip-OIIB8p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:19:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:19:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:19:07 INFO - Running setup.py (path:/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/pip-3ns5t2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:19:07 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 09:19:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:19:07 INFO - Running setup.py (path:/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/pip-KUBpi6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:19:07 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)) 09:19:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:19:07 INFO - Running setup.py (path:/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/pip-JSo3ve-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:19:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 09:19:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:19:07 INFO - Running setup.py (path:/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/pip-oPRROk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:19:07 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)) 09:19:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:19:07 INFO - Running setup.py (path:/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/pip-Qgsq4W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:19:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 09:19:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:19:07 INFO - Running setup.py (path:/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/pip-PYdZXV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:19:07 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)) 09:19:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:19:07 INFO - Running setup.py (path:/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/pip-BKgsZP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:19:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 09:19:07 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)) 09:19:07 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)) 09:19:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:19:07 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)) 09:19:07 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)) 09:19:07 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:19:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:19:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:19:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:19:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:19:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:19:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:19:10 INFO - Downloading blessings-1.6.tar.gz 09:19:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:19:10 INFO - Installing collected packages: blessings 09:19:10 INFO - Running setup.py install for blessings 09:19:10 INFO - Successfully installed blessings 09:19:10 INFO - Cleaning up... 09:19:10 INFO - Return code: 0 09:19:10 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:19:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:19:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:19:11 INFO - Reading from file tmpfile_stdout 09:19:11 INFO - Current package versions: 09:19:11 INFO - blessings == 1.6 09:19:11 INFO - blobuploader == 1.2.4 09:19:11 INFO - docopt == 0.6.1 09:19:11 INFO - functools32 == 3.2.3-2 09:19:11 INFO - jsonschema == 2.5.1 09:19:11 INFO - manifestparser == 1.1 09:19:11 INFO - mozInstall == 1.12 09:19:11 INFO - mozcrash == 0.17 09:19:11 INFO - mozdebug == 0.1 09:19:11 INFO - mozdevice == 0.48 09:19:11 INFO - mozfile == 1.2 09:19:11 INFO - mozhttpd == 0.7 09:19:11 INFO - mozinfo == 0.9 09:19:11 INFO - mozleak == 0.1 09:19:11 INFO - mozlog == 3.4 09:19:11 INFO - moznetwork == 0.27 09:19:11 INFO - mozprocess == 0.23 09:19:11 INFO - mozprofile == 0.28 09:19:11 INFO - mozrunner == 6.12 09:19:11 INFO - mozscreenshot == 0.1 09:19:11 INFO - mozsystemmonitor == 0.3 09:19:11 INFO - moztest == 0.7 09:19:11 INFO - mozversion == 1.4 09:19:11 INFO - psutil == 3.1.1 09:19:11 INFO - requests == 1.2.3 09:19:11 INFO - wsgiref == 0.1.2 09:19:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:19:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:19:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:19:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:19:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:19:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:11 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 0x108603490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108579570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffbb848fa80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108417d30>, '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 0x10827ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10840fb20>, '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.UisKHEU7VB/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.msKkbAvfu1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:19:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 09:19:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:19:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UisKHEU7VB/Render', 09:19:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:19:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:19:11 INFO - 'HOME': '/Users/cltbld', 09:19:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:19:11 INFO - 'LOGNAME': 'cltbld', 09:19:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:19:11 INFO - 'MOZ_NO_REMOTE': '1', 09:19:11 INFO - 'NO_EM_RESTART': '1', 09:19:11 INFO - 'PAGER': '/bin/cat', 09:19:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:19:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:19:11 INFO - 'PWD': '/builds/slave/test', 09:19:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:19:11 INFO - 'SHELL': '/bin/bash', 09:19:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.msKkbAvfu1/Listeners', 09:19:11 INFO - 'TMPDIR': '/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/', 09:19:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:19:11 INFO - 'USER': 'cltbld', 09:19:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:19:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:19:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:19:11 INFO - 'XPC_FLAGS': '0x0', 09:19:11 INFO - 'XPC_SERVICE_NAME': '0', 09:19:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:19:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:19:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:19:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 09:19:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 09:19:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:19:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 09:19:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 09:19:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 09:19:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 09:19:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 09:19:11 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:19:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:19:11 INFO - Cleaning up... 09:19:11 INFO - Return code: 0 09:19:11 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:19:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:19:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:19:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:19:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:19:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:11 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 0x108603490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108579570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffbb848fa80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108417d30>, '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 0x10827ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10840fb20>, '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.UisKHEU7VB/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.msKkbAvfu1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:19:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 09:19:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:19:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UisKHEU7VB/Render', 09:19:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:19:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:19:11 INFO - 'HOME': '/Users/cltbld', 09:19:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:19:11 INFO - 'LOGNAME': 'cltbld', 09:19:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:19:11 INFO - 'MOZ_NO_REMOTE': '1', 09:19:11 INFO - 'NO_EM_RESTART': '1', 09:19:11 INFO - 'PAGER': '/bin/cat', 09:19:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:19:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:19:11 INFO - 'PWD': '/builds/slave/test', 09:19:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:19:11 INFO - 'SHELL': '/bin/bash', 09:19:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.msKkbAvfu1/Listeners', 09:19:11 INFO - 'TMPDIR': '/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/', 09:19:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:19:11 INFO - 'USER': 'cltbld', 09:19:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:19:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:19:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:19:11 INFO - 'XPC_FLAGS': '0x0', 09:19:11 INFO - 'XPC_SERVICE_NAME': '0', 09:19:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:19:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:19:11 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:19:11 INFO - Cleaning up... 09:19:11 INFO - Return code: 0 09:19:11 INFO - Running post-action listener: _resource_record_post_action 09:19:11 INFO - Running post-action listener: _start_resource_monitoring 09:19:11 INFO - Starting resource monitoring. 09:19:11 INFO - [mozharness: 2017-01-04 17:19:11.658066Z] Finished create-virtualenv step (success) 09:19:11 INFO - [mozharness: 2017-01-04 17:19:11.659033Z] Running install step. 09:19:11 INFO - Running pre-action listener: _resource_record_pre_action 09:19:11 INFO - Running main action method: install 09:19:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:19:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:19:11 INFO - Reading from file tmpfile_stdout 09:19:11 INFO - Detecting whether we're running mozinstall >=1.0... 09:19:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:19:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:19:12 INFO - Reading from file tmpfile_stdout 09:19:12 INFO - Output received: 09:19:12 INFO - Usage: mozinstall [options] installer 09:19:12 INFO - Options: 09:19:12 INFO - -h, --help show this help message and exit 09:19:12 INFO - -d DEST, --destination=DEST 09:19:12 INFO - Directory to install application into. [default: 09:19:12 INFO - "/builds/slave/test"] 09:19:12 INFO - --app=APP Application being installed. [default: firefox] 09:19:12 INFO - mkdir: /builds/slave/test/build/application 09:19:12 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'] 09:19:12 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 09:19:33 INFO - Reading from file tmpfile_stdout 09:19:33 INFO - Output received: 09:19:33 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 09:19:33 INFO - Running post-action listener: _resource_record_post_action 09:19:33 INFO - [mozharness: 2017-01-04 17:19:33.729059Z] Finished install step (success) 09:19:33 INFO - [mozharness: 2017-01-04 17:19:33.729235Z] Running run-tests step. 09:19:33 INFO - Running pre-action listener: _resource_record_pre_action 09:19:33 INFO - Running main action method: run_tests 09:19:33 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:19:33 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:19:33 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:19:33 INFO - 2017-01-04 09:19:33.743 screenresolution[29844:282029] starting screenresolution argv=screenresolution get 09:19:33 INFO - 2017-01-04 09:19:33.746 screenresolution[29844:282029] Display 0: 1600x1200x32@60 09:19:33 INFO - 2017-01-04 09:19:33.752 screenresolution[29845:282031] starting screenresolution argv=screenresolution list 09:19:33 INFO - Available Modes on Display 0 09:19:33 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:19:33 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:19:33 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:19:33 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:19:33 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:19:33 INFO - Intel Iris: 09:19:33 INFO - Chipset Model: Intel Iris 09:19:33 INFO - Type: GPU 09:19:33 INFO - Bus: Built-In 09:19:33 INFO - VRAM (Dynamic, Max): 1536 MB 09:19:33 INFO - Vendor: Intel (0x8086) 09:19:33 INFO - Device ID: 0x0a2e 09:19:33 INFO - Revision ID: 0x0009 09:19:33 INFO - Displays: 09:19:33 INFO - Display: 09:19:33 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:19:33 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:19:33 INFO - Display Serial Number: 1600x1200 60 09:19:33 INFO - Main Display: Yes 09:19:33 INFO - Mirror: Off 09:19:33 INFO - Online: Yes 09:19:33 INFO - Rotation: Supported 09:19:33 INFO - Return code: 0 09:19:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:19:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:19:33 INFO - Python 2.7.3 09:19:33 INFO - Return code: 0 09:19:33 INFO - grabbing minidump binary from tooltool 09:19:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:19:33 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 0x108417d30>, '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 0x10827ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10840fb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:19:33 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 09:19:33 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 09:19:33 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 09:19:34 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:19:34 INFO - Return code: 0 09:19:34 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 09:19:34 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:19:34 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:19:34 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 09:19:34 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:19:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HCQJgrRxSjmD8wBQfUivxQ/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0293', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 09:19:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/HCQJgrRxSjmD8wBQfUivxQ/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0293 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 09:19:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UisKHEU7VB/Render', 09:19:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:19:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:19:34 INFO - 'HOME': '/Users/cltbld', 09:19:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:19:34 INFO - 'LOGNAME': 'cltbld', 09:19:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:19:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 09:19:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:19:34 INFO - 'MOZ_NO_REMOTE': '1', 09:19:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:19:34 INFO - 'NO_EM_RESTART': '1', 09:19:34 INFO - 'PAGER': '/bin/cat', 09:19:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:19:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:19:34 INFO - 'PWD': '/builds/slave/test', 09:19:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:19:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:19:34 INFO - 'SHELL': '/bin/bash', 09:19:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.msKkbAvfu1/Listeners', 09:19:34 INFO - 'TMPDIR': '/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/', 09:19:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:19:34 INFO - 'USER': 'cltbld', 09:19:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:19:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:19:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:19:34 INFO - 'XPC_FLAGS': '0x0', 09:19:34 INFO - 'XPC_SERVICE_NAME': '0', 09:19:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:19:34 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HCQJgrRxSjmD8wBQfUivxQ/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0293', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 09:19:34 INFO - mozversion application_buildid: 20170104061938 09:19:34 INFO - mozversion application_changeset: 8d8533198db9f71ab9cca9727e387fac8ef28a08 09:19:34 INFO - mozversion application_display_name: Firefox 09:19:34 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:19:34 INFO - mozversion application_name: Firefox 09:19:34 INFO - mozversion application_remotingname: firefox 09:19:34 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 09:19:34 INFO - mozversion application_vendor: Mozilla 09:19:34 INFO - mozversion application_version: 51.0 09:19:34 INFO - mozversion platform_buildid: 20170104061938 09:19:34 INFO - mozversion platform_changeset: 8d8533198db9f71ab9cca9727e387fac8ef28a08 09:19:34 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 09:19:34 INFO - mozversion platform_version: 51.0 09:19:34 INFO - using testdate: 1483550374 09:19:34 INFO - actual date: 1483550374 09:19:34 INFO - starting webserver on 'localhost:52623' 09:19:34 INFO - SUITE-START | Running 2 tests 09:19:34 INFO - TEST-START | dromaeo_css 09:19:34 INFO - operating with platform_type : mac_ 09:19:34 INFO - Initialising browser for dromaeo_css test... 09:19:34 INFO - TEST-INFO | started process 29855 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/tmpNqlPDJ/profile http://localhost:52623/getInfo.html) 09:19:36 INFO - PROCESS | 29855 | __metrics Screen width/height:1600/1200 09:19:36 INFO - PROCESS | 29855 | colorDepth:24 09:19:36 INFO - PROCESS | 29855 | Browser inner width/height: 1024/689 09:19:36 INFO - PROCESS | 29855 | __metrics 09:19:36 INFO - PROCESS | 29855 | 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" 09:19:36 INFO - PROCESS | 29855 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:19:37 INFO - TEST-INFO | 29855: exit 0 09:19:37 INFO - Browser initialized. 09:19:37 INFO - Running cycle 1/1 for dromaeo_css test... 09:19:37 INFO - TEST-INFO | started process 29859 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/tmpNqlPDJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:19:49 INFO - PROCESS | 29859 | RSS: Main: 169381888 09:19:49 INFO - PROCESS | 29859 | 09:20:41 INFO - PROCESS | 29859 | 1483550441108 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] 09:22:51 INFO - PROCESS | 29859 | Cycle 1(1): loaded http://localhost:52623/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52623/tests/dromaeo/cssquery-ext.html) 09:22:52 INFO - PROCESS | 29859 | RSS: Main: 332300288 09:22:52 INFO - PROCESS | 29859 | 09:25:55 INFO - PROCESS | 29859 | Cycle 1(1): loaded http://localhost:52623/tests/dromaeo/cssquery-ext.html (next: http://localhost:52623/tests/dromaeo/cssquery-jquery.html) 09:25:56 INFO - PROCESS | 29859 | RSS: Main: 300437504 09:25:56 INFO - PROCESS | 29859 | 09:28:58 INFO - PROCESS | 29859 | Cycle 1(1): loaded http://localhost:52623/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52623/tests/dromaeo/cssquery-mootools.html) 09:28:59 INFO - PROCESS | 29859 | RSS: Main: 271962112 09:28:59 INFO - PROCESS | 29859 | 09:32:01 INFO - PROCESS | 29859 | Cycle 1(1): loaded http://localhost:52623/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52623/tests/dromaeo/cssquery-prototype.html) 09:32:01 INFO - PROCESS | 29859 | RSS: Main: 270893056 09:32:01 INFO - PROCESS | 29859 | 09:35:05 INFO - PROCESS | 29859 | Cycle 1(1): loaded http://localhost:52623/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52623/tests/dromaeo/cssquery-yui.html) 09:35:05 INFO - PROCESS | 29859 | RSS: Main: 261300224 09:35:05 INFO - PROCESS | 29859 | 09:38:08 INFO - PROCESS | 29859 | Cycle 1(1): loaded http://localhost:52623/tests/dromaeo/cssquery-yui.html (next: http://localhost:52623/tests/dromaeo/cssquery-dojo.html) 09:38:08 INFO - PROCESS | 29859 | RSS: Main: 307507200 09:38:08 INFO - PROCESS | 29859 | 09:38:08 INFO - PROCESS | 29859 | __start_tp_report 09:38:08 INFO - PROCESS | 29859 | _x_x_mozilla_page_load 09:38:08 INFO - PROCESS | 29859 | _x_x_mozilla_page_load_details 09:38:08 INFO - PROCESS | 29859 | |i|pagename|runs| 09:38:08 INFO - PROCESS | 29859 | |0;dojo.html;3365.2259980204553;3378.375000624884;3385.4414021686407;3416.743744219184;3432.897013089608;5669;5747.741351639186;5754.913676294848;5755.942440575593;5757.856053598657;5729.197912292272;5795.101759227316;5815.912761308584;5822.155787410823;5830.708464576775;5185.481451854813;5257.369115706101;5267.55225805807;5288.418273989858;5323.574114070884;5183.714895680736;5186.351706036746;5193;5329.706866122362;5341.893162136755;5249.553787928031;5257.211418287249;5259.974305010524;5260.605454590902;5265.526102650761;5244.344456942882;5262.631615786877;5320.654157479751;5320.893582128336;5330.813421530228;5125.974370128163;5188.533032027136;5259.368875734898;5285.233641122054;5291.3385826771655;5689.943100569024;5697.430256974311;5706.315242170925;5732.254806875121;5780.479756821906;6177.62934223948;6220.626762394226;6233.781817636406;6256.468200202989;6291.402316779899;6247.156633854417;6300.905486417661;6302.338254483305;6302.621842689453;6313.842153946142;5695.060315048054;5748.511376532958;5809.7095145242565;5908.14331921869;5913.349531551526;6260.24877014752;6276.372362763687;6295.055741638791;6310.495160387158;6315.842103947346;6205.503559715302;6207.751689932352;6227.221597300338;6228.719707613168;6232.626042437469;6117.675163990694;6119.258838874149;6212.751489940442;6238.906416403667;6282.434580887651;6262.3111457739615;6270.467010304175;6288.245410550763;6291.056341548713;6301.6534090625455;6229.813105606839;6246.875062498815;6289.182406287154;6312.747490100436;6317.020861766434;4865.197242455026;4906.975465122651;4919.729414882216;4975.154223781966;5023.246513023076;4455.933161002587;4511.887202819956;4515.841945531891;4519.638428925678;4567.132244873464;5672.290963629546;5681.176229446707;5694.743736531866;5695;5703.17303990919;6122.112293717475;6288.339724328879;6296.464800491918;6309.053641953744;6310.52671049664;5587.385387607441;5594.440555944373;5640.492355688008;5642.069058605366;5671.971640141773;5404.567634589223;5425.674459532441;5432.348118225838;5436.10304299794;5455.072637651609;6329.651869147241;6329.841753956096;6336.651484168415;6339.366063393623;6339.809805705836;6128.136482154469;6136.886723215932;6180.227471566054;6238.968805155945;6312.873742525032;6285.308616052139;6290.779822706367;6310.968445157929;6319.9052014218905;6335.841603959753;6228.190335256388;6237.719302631302;6243.219597550306;6243.8126856194385;6263.937360626335;6113.537117903944;6177.907331389943;6209.689515524115;6256.311805701278;6281.685915704288;5988.520918326436;6080.331163571915;6164.599301045418;6170.10533472653;6193.287771906288;6173.660448675366;6177.4749146323065;6183.876322473615;6186.783462578788;6189.319174890848;5833.891560603472;5855.94144058571;6004.919621338132;6058.303295121117;6061.181740464981;5191.169412893919;6045.21412216409;6105.752712533616;6113.150045066789;6133.233345831771;5976.252968378953;6020.795840831764;6024.186734790747;6024.819255422344;6032.849178770566 09:38:08 INFO - PROCESS | 29859 | |1;ext.html;491.9016196760646;509.93880734311875;511.87970826855684;528.3659608469833;539.8704310965367;31800.522992155107;42034.36948445772;43123.13753724928;43140.78429607848;45688.54311456884;44471.555284447146;44823.55176448235;44884.775576122156;44957;45270.094598108015;10053.949730251357;10246.38521688701;10246.692599221999;10257.846132308021;10258.948705256464;9259.398139120936;9510.144087032166;12209.572664956728;12498.500059997588;12502.374881255946;12386.752264954695;12492.625221243332;12493.750624937478;12496.437660305308;12501;10512.947435262851;12447.813282800766;12493.750124997448;12532.874671253261;12564.183328083736;12258;12359;12364.876351236553;12373.381330933418;12376.752464950741;41714.748557543324;42041.73874783761;42140.94647633803;42159.7892010538;42226;3305;3338.9499157512655;3416;3649.3613617617075;3688.815559222055;30648.387032259452;31937.041888743373;31938.840305798323;32418.189545261557;32656.69373225092;3099.5505651680605;3170.318381547955;3297.653746356646;3336;3340.5657264555693;480515;544330;548838;550534.2473287648;550821;34958.82520587432;64830.351696483376;65071.67464162743;65297;65421.67289163524;35957.820210898775;37329.25341493155;37384.81307593499;37427.62572374296;37444.625553744656;15920.363185472452;16036.957597756109;16042.679146417006;16078.276477558538;16093.195340232942;12352.25886446816;12502.249865008129;13465.596032119052;13561.525346612822;13587.932060339832;6704.564203326768;7127.536710113826;8189.385796065199;8194.54929978845;8264.380171487162;3357.5635167428077;3381.3406385755034;3388.678075582816;3402.5236466894653;3405.0806282304134;988.6984469736799;989.4014121456559;1004.8794144702682;1014.325473560089;1076.962306319275;29865.253368665522;30837.38325233483;31185.220369490944;31237;31639.841800790848;1098.6154845804065;1100.8899110088928;1114.0864491117206;1120.843081968525;1142.8285757136496;13652.65868353299;13991.860081399056;15675.608109797346;16212.189390530426;16347.937384069997;728417;761702;763299;764749;767696;60976.390236097955;61339;61429;61436.69281653563;61502.69248653817;1295.1452041652465;1332.3072002558615;1413.5264686330195;1443.2927865345905;1470.5000299898086;30267.848660756554;31628.841855791496;32716.50925236171;32756.34487310288;33425.33149337048;50776;51538;51672;51692.74153629358;51713.48286517087;589628;594116;595033;595869;596540;24658.753412465645;25100.372490687147;27347.042853500032;27815.582766258118;27970;48435.5156448431;48491.27263091127;49021;49456.763580909326;49610;39444.60555394409;39744.2051158981;39979.800605981865;40025;41731.791341044314;35651.82174089113;38022.61977380191;39609.80195099006;40267.99330016773;41487.377689334084;38912.41631375588;39284.410733839584;39607.60392396039;39872.60127398689;39984.600153998086;32120.109190172996;34081.97754067382;35263;35424.096913666384;36003.63996360003;25165.74834251634;26330.73669263283;26478.205653830417;26519.939202431688;26881.059162929203 09:38:08 INFO - PROCESS | 29859 | |2;jquery.html;336.99743263790225;386.3065796894574;397.46143974914;406.0863058119232;417.8537511870846;19119.71320430195;21376.57246855062;21670.674939875877;22344.106235750573;22664.206752763657;20563.588728225426;21205.57588848226;21443.67834482484;21575.1369945202;21997.67003494949;5310.283111779918;5602.355729091166;5676.205331253628;5683.3464151622475;5688.516476099516;4117.732347397409;4158.064435502003;4163.042500224935;5582.637128586649;5691.004074287004;6023.849403764919;6259.687015649222;6304.401081897236;6349.365063493637;6352.428281454668;6088.604240724361;6268.5298602604535;6328.462080723098;6331.746730130789;6341.619502829845;5925.111233315038;6169.969150154266;6195.628262304276;6196.163517925068;6201.9689901550655;13439.66400839977;13704;13708.108972916829;13718.38267277975;15485.380584776596;2192.440927563461;2215.490437199453;2259.469024779192;2652.9786032377674;2852.671942726592;10440.32137911041;10493.632722854663;10586.894131058667;10715.785684286271;14734.336954837057;1606.1567676969566;1883.8116188381189;1890.6124244529976;1949.3567122849427;1964.9214031438726;101229;141838;142353;143729.5627043737;144074;11617.53529858813;11714.121440891968;11772.823407648892;11775.470103845348;11993.700157496132;12622.684432889251;15220.771688424682;15224.619384515476;15258.237088145548;15324.923375383052;8571.271441927505;8705.828453049735;8746.956265218632;8792.824143517093;8912.465252084896;8598.398112132216;8626.654933802578;8629.626852615456;8709.956450217709;8880.37837351392;4562.019165879352;4617.145828021827;4618.330342100444;4630.6063984561015;4699.2481203007355;1793.5336812428861;1840.8029692301575;1921.5964647424198;1966.2823069579501;1989.383291179739;815.4210510537584;908.0873721909438;920.8480600700809;978.9608415663436;1004.8492726091145;20955.790442095687;21565.56868862614;21836;21939.67090493644;21955.2315668954;913.9405938613969;977.154761131616;985.0494273026563;1022.805666923297;1030.9278350515392;10724.41015744126;11542.13433992454;11557.190996630155;11563.364014979257;11567.942160289145;678774.6061269662;685037;689730;691631;692311;136029;137611;138569;142463;143195;449.17576247586044;467.7637792914624;468.3910915809502;468.51274674338987;468.63212378283566;9870.457124858201;11033.83449248278;11127.443627818739;11591.18861679708;11676.824847627462;53570.46429535655;54126;55629;57073.28780136602;60867.69566152141;87563;89008;89345.65981510152;89768.10231897859;91090;8260.091389947222;8316.6673333066;8427.620757065824;8492.683634036734;8570.271526920282;7346.191918888811;9509.809803804024;10558.736031599272;12858.357082145669;13907.791383129059;9131.452112873249;10175.72803399575;10328.845067324146;10913.945430272797;11349.035331996542;10008.599656013968;10628.41543715103;10752.354858708502;10778.568857245622;10945.83581246298;11368.54525818991;11397.601083962021;11422.029127524254;11432.08543316516;11886.049116070866;7969.681212751425;8131.471454355448;8243.670253189804;8439.620217090369;8541.572921353783;10359.585616575252;11158.944205278922;11167.218294719292;11447.713807154887;11556.59551915679 09:38:08 INFO - PROCESS | 29859 | |3;mootools.html;1530.1737061986523;1558.080732367903;1782.9732554011691;1937.8740381875168;1952.0825212150294;8642.308615310776;9174;9178.265738740893;9181.357304988645;9190.126937940902;8035.477693949903;8279.172082791718;8679.132086791318;8872.157145071207;8946.507942063185;2401.9071322548243;2421.2736179146186;2433.6471211674298;2434.1115492845074;2435.232901635979;2398.688170537828;2408.036785285882;2439.9996001639242;2443.4624382635793;2443.5479436304254;2421.1767998880377;2427.526632306692;2439.8048156147465;2442.255112190781;2473.6042233242683;2056.290579749991;2390;2412.300432874464;2414.987925060372;2419.903203871843;2399.3761621978238;2410.156445244168;2413.1312727418117;2416.867072311022;2418.1899063813644;8986.68546600866;9041.909580904172;9101.772455688595;9113.043130471338;9125.315601329861;5436.673799572039;5597.496225339698;5597.6641401516035;5609.495145436889;5613.859653508654;3548.6983606393487;3642.1987162824134;3656.323580137683;3717.981410092932;3719.6280371962857;1084.7017070305728;1087.5595383869465;1090.4275255490852;1101.1796211822164;1112.327042139502;11831.408429578487;11881.168318217728;11998.96017676997;12000;12004.399780011052;4523.185826551186;4581.411502501076;4763.476017638057;4766.451858036301;4773.71357718538;9465.100815422524;9466.715998520056;9467.337286390024;9468.28987825902;9471.810563788824;5422.105352616774;5437;5440.075187218183;5441.782328706887;5454.61817672767;4584.1977653910435;4747.643926705511;4878.463369029404;5004.224345226496;5101.158308879068;3871.6321949415324;3886.1839013806853;3993.84024639017;3996.84012639497;3999.92000160001;1182.9645110646695;1191.4578866615668;1194.056695210791;1201.6635342104225;1206.240068756695;813.6745301879178;890.7819529371947;910.3172620534599;917.5045475443186;947.303731757158;5700.3444603871085;5811.476967072899;6045.244344456943;6064.545159112996;6110.205673262536;434.86084452974745;447.16603534408745;453.28381157770644;458.86692859070496;466.59406316504857;3872.8644497442456;3968.6825053995613;3996.620321069494;4065.166640838621;4086.7752273625238;10559;11047.226694131494;11060.944695276634;11076;11083.224174307721;8695.478271303742;10570.048695617277;11037.668869933754;11068.778624427627;11070.114390848712;8355.248027677539;8396.958015209884;8457.957710211409;8552.059273479912;8571.100034496412;5727.11229759388;5952.375000624872;5997.610155339889;6000.729967151401;6044.425779550936;9999.55002024896;10219.48902554884;10238.539265733209;10280.485975701036;10300.330478518872;10314.730759232956;10419.479026048515;10474.371537707762;10575.995280448346;10581.947090264499;7198.640067996684;7255.419566434567;7257.673404696907;7296.379807716404;7316.0489136411925;8423.620937057725;8503.1921967413;8505.277051450696;8507.702230421906;8516.659333626834;7609.961950190213;7763.650635721519;7804.2585954334245;7889.684412623431;7893.42131573676;7515.624218788929;7625.809354765954;7634.656440460081;7664.540127592362;7674.53952762836;7091.60996145217;7205.171405288459;7215.60314182725;7220.855582888418;7231.4214862809795;4880.145974454527;4954.256861470664;5010.874728131826;5080.7205603692155;5249.238860365149;4277.401163837003;4927.802887884444;4954.355933728592;5062.519060689228;5097.541221290102 09:38:08 INFO - PROCESS | 29859 | |4;prototype.html;306.4896946583938;312.58738465225895;315.56767228896416;324.34482345661763;325.90171123314434;4460.375547423363;5177.974110129444;5328.653637513559;5344.412114667383;5420.539254163401;4536.773161341928;5176.58587313015;5257.319876086735;5288.973555132219;5301.1253143231415;3337.4826901830133;3462.3767721810063;4076.673866090706;4081.3877918312196;4089.427480152781;3348.961821835239;3651.726120540957;3804.706399824059;3836.769793812366;4090.406891000803;3177.380410819891;3942.4086387041884;4049.959500404988;4074.6129117733917;4113.56807535209;3387.491876218575;4013.097053163044;4048.473698419187;4059.147579008412;4076.266272071026;3524.8237588120746;3530.3468858261303;3534.1164708822794;3535.7701749386465;3557.790351280551;3860.9806950965344;5240.240165176028;5257.764425360076;5307.946920530784;5318.095923692981;3941.881743547698;4679.22792739201;4699.647526435531;4706.623470122382;4751.097291514636;4997.875053123665;5151.871203219912;5702.401247868997;5730.398308177623;5743.540516758691;3733.099192510117;3855.5373355197557;3893.357595996657;3932.508436445444;3937.5471820740695;5423.2949716537;5954.970225148846;5978.3260687007705;5992.063888694508;6009.579329446897;3557.7153827693724;3927.9410808837893;3931.8427262909736;3955.268275369066;3970.7021973352116;3099.9225019374694;3694.4827724118645;3744.588095309514;4037.454943582579;4052.230076285496;4643.558861908114;4646.907061858744;4651.906961860744;4658.161530924398;4663.743494107789;4715;5036.917062831509;5118.872028199325;5713.5714821388565;5752.395998420106;1164.8835116488283;1229.624964385871;1283.345493798151;1330.5808670269028;1338.785794272931;750.5496701978769;821.7370441458676;897.5056530876018;920.1488623023677;920.6788258848574;5217.660852044605;5219.869503262449;5223.686578805284;5253.553447956967;5270.288511051036;4791.6406269529925;4982.60139188864;5747;5786.189933409326;5795.290389335156;4414.146058655372;4823.831165909176;5047.394312682502;5188.507091826271;5209.765560549784;2365.474269096423;2514.245726282108;2850.1307101333878;3053.5724998500227;3056.984715076455;4740.146773580788;4939.678920870132;5325.0148722486465;6039.553980637848;6151.016756872913;4998.450170481244;5171.3277273954145;5686.2607860977805;5992.370801065913;5999.730012149464;5513.5037846593195;5782.508486778671;5969.253843269591;6022.69886505673;6050.788222412194;5823.777006828444;5826.659868230246;5837.1244313351635;5848.385919478394;5870.53035757147;4592.280252995085;5226.928479661737;5552.861178470571;5720.227769251264;5896.6756828374855;5037.596992240685;6119.602225855305;6142.969285153546;6151.630902145886;6153.692315384303;3361.596608407007;3712.424574191005;3980.8009599520487;4010.3984402339884;4017.216642754635;5538.113901775697;5625.634333768456;5856.916470452979;5882.176495290748;5887.499562537232;5604.607677462538;5654.6889921054735;5792;5794.62334948227;5801.1878337033695;4542.613877820422;4787.61699064067;5091.516305950929;5551.361593416808;5739.483446489836;4619.69971951822;4670.206064969031;5461.481159289861;5643.633163844337;5672.5461963042035;5439.48324909133;5700.862176683743;5765;5769.711514424178;5790.768369265351;4919.926201106915;5154.196031388984;5621.550275977994;5640.633358831663;5812.476877081083 09:38:08 INFO - PROCESS | 29859 | |5;yui.html;683.2825533190152;712.9108861392326;735.7829440315106;797.7247849491927;839.366278459763;15721.842781572195;16795.244214010367;16810.32758689651;16816;16822.074785886773;14723;14803.481878134267;14843.480478183266;14848.777268340984;14883.404663813435;711.9822004449904;734.456502188382;738.8854727517244;885.59705334073;891.5230351761809;902.6524787956652;903.2864037410438;919.0946917286467;919.6873063158524;922.299052719931;988.8269552828226;989.0060489208336;990.8365119755268;990.8563258327538;991.1575161113033;973.8198433289864;976.7069879036261;977.6236149082619;977.8826540815077;978.862959185711;732.6886073418775;732.7362149626131;732.7984804178893;733.339994005394;734.7208060936863;15857.60355991098;16184.271707773178;16281.837181628269;16327;16342.182890855529;13569.52506662262;13726.45094196231;15191.505953630727;15300.911945133632;15306.464273750365;11173.83239251412;11745.58890438839;12139.332336721476;13418.93290533541;13447.32763361828;3742.2328422673286;4024.6176613221696;4076.001379662002;4160.54234034256;4164.229617520768;119626;120685.79314206833;121300;121525.39237303757;122739.38630306881;11001.724956876142;11499.367534785668;11605.187636865507;11702.648920532398;11774.587889423829;23026.884865575565;23097.88451057734;23098.307050788168;23138.421539461313;23334;7884.921150788534;8061.959690201512;8071.838563228703;8137.98275215598;8249.79375515617;4517.638588912879;4532.864014079583;4638.350630911675;4764.523547645208;4764.951710623657;3641.7268704847243;3735.2529494101286;3786.659200671953;3787.3372159872465;3796.0699628591174;680.0954730208811;685.1059367525427;685.8628274345151;692.3388164303078;694.9027136200936;591.899377105893;679.8708245433352;696.1472196559275;705.4990956420999;713.2403989750899;9774.067779666071;10037.141583717188;10299.124574411258;10299.17606591471;10434.791304173874;561.7584438691321;632.9556232216787;712.6401167410528;713.8893471511924;715.2454160860239;4188.308929026676;4591.357209990604;4611.654125940501;4617.376654151646;4630.351750754897;128939.35530322476;154881;160630;162286;166001;131598.34200829125;133658;137943.24113517674;142046;142575.86136207965;73926.8910966336;76721.61639191768;79701;79936.6003169992;119356.40321798161;8775.912240877766;8830.205281524693;8885.777855553662;9030.187283144549;9042.773930651787;59487.1076933855;61398.386016141056;62476;63172.684136580865;64968.05095847132;97280;100557.49163762695;103599;104216.47891760492;104895.4265686;11851.585194518151;11886.524539018343;12060.336681482602;12303.200291980993;12398;13102.606921792361;13198.406071726604;13274.137181083199;13937.860621393656;14354.49759258421;12471.251724896536;12642.620721378373;12668.936655316664;13049.869501304865;13070.411831467796;12018.639440816789;12605.49578016869;12733.93633031866;12790.36048197605;13122.671933201746;10805.837912431163;12184.51261949512;12228.571999979958;12341.197822141532;12628.43172057278;9274.397164184307;9326.36289788043;10684.984926431976;10838.241323107306;10940.890591093987;9069.863952040592;9734.221262299141;10452.268341216346;10467.842982355118;10884.183686223407 09:38:08 INFO - PROCESS | 29859 | __end_tp_report 09:38:08 INFO - PROCESS | 29859 | __start_cc_report 09:38:08 INFO - PROCESS | 29859 | _x_x_mozilla_cycle_collect,1573 09:38:08 INFO - PROCESS | 29859 | __end_cc_report 09:38:08 INFO - PROCESS | 29859 | __startTimestamp1483551488827__endTimestamp 09:38:08 INFO - PROCESS | 29859 | 09:38:08 INFO - PROCESS | 29859 | ------- Summary: start ------- 09:38:08 INFO - PROCESS | 29859 | Number of tests: 6 09:38:08 INFO - PROCESS | 29859 | 09:38:08 INFO - PROCESS | 29859 | [#0] dojo.html Cycles:165 Average:5773.27 Median:6024.19 stddev:631.90 (10.5%) stddev-sans-first:604.94 09:38:08 INFO - PROCESS | 29859 | Values: 3365.2 3378.4 3385.4 3416.7 3432.9 5669.0 5747.7 5754.9 5755.9 5757.9 5729.2 5795.1 5815.9 5822.2 5830.7 5185.5 5257.4 5267.6 5288.4 5323.6 5183.7 5186.4 5193.0 5329.7 5341.9 5249.6 5257.2 5260.0 5260.6 5265.5 5244.3 5262.6 5320.7 5320.9 5330.8 5126.0 5188.5 5259.4 5285.2 5291.3 5689.9 5697.4 5706.3 5732.3 5780.5 6177.6 6220.6 6233.8 6256.5 6291.4 6247.2 6300.9 6302.3 6302.6 6313.8 5695.1 5748.5 5809.7 5908.1 5913.3 6260.2 6276.4 6295.1 6310.5 6315.8 6205.5 6207.8 6227.2 6228.7 6232.6 6117.7 6119.3 6212.8 6238.9 6282.4 6262.3 6270.5 6288.2 6291.1 6301.7 6229.8 6246.9 6289.2 6312.7 6317.0 4865.2 4907.0 4919.7 4975.2 5023.2 4455.9 4511.9 4515.8 4519.6 4567.1 5672.3 5681.2 5694.7 5695.0 5703.2 6122.1 6288.3 6296.5 6309.1 6310.5 5587.4 5594.4 5640.5 5642.1 5672.0 5404.6 5425.7 5432.3 5436.1 5455.1 6329.7 6329.8 6336.7 6339.4 6339.8 6128.1 6136.9 6180.2 6239.0 6312.9 6285.3 6290.8 6311.0 6319.9 6335.8 6228.2 6237.7 6243.2 6243.8 6263.9 6113.5 6177.9 6209.7 6256.3 6281.7 5988.5 6080.3 6164.6 6170.1 6193.3 6173.7 6177.5 6183.9 6186.8 6189.3 5833.9 5855.9 6004.9 6058.3 6061.2 5191.2 6045.2 6105.8 6113.2 6133.2 5976.3 6020.8 6024.2 6024.8 6032.8 09:38:08 INFO - PROCESS | 29859 | 09:38:08 INFO - PROCESS | 29859 | [#1] ext.html Cycles:180 Average:74951.06 Median:18748.99 stddev:170644.71 (910.2%) stddev-sans-first:171031.84 09:38:08 INFO - PROCESS | 29859 | Values: 491.9 509.9 511.9 528.4 539.9 31800.5 42034.4 43123.1 43140.8 45688.5 44471.6 44823.6 44884.8 44957.0 45270.1 10053.9 10246.4 10246.7 10257.8 10258.9 9259.4 9510.1 12209.6 12498.5 12502.4 12386.8 12492.6 12493.8 12496.4 12501.0 10512.9 12447.8 12493.8 12532.9 12564.2 12258.0 12359.0 12364.9 12373.4 12376.8 41714.7 42041.7 42140.9 42159.8 42226.0 3305.0 3338.9 3416.0 3649.4 3688.8 30648.4 31937.0 31938.8 32418.2 32656.7 3099.6 3170.3 3297.7 3336.0 3340.6 480515.0 544330.0 548838.0 550534.2 550821.0 34958.8 64830.4 65071.7 65297.0 65421.7 35957.8 37329.3 37384.8 37427.6 37444.6 15920.4 16037.0 16042.7 16078.3 16093.2 12352.3 12502.2 13465.6 13561.5 13587.9 6704.6 7127.5 8189.4 8194.5 8264.4 3357.6 3381.3 3388.7 3402.5 3405.1 988.7 989.4 1004.9 1014.3 1077.0 29865.3 30837.4 31185.2 31237.0 31639.8 1098.6 1100.9 1114.1 1120.8 1142.8 13652.7 13991.9 15675.6 16212.2 16347.9 728417.0 761702.0 763299.0 764749.0 767696.0 60976.4 61339.0 61429.0 61436.7 61502.7 1295.1 1332.3 1413.5 1443.3 1470.5 30267.8 31628.8 32716.5 32756.3 33425.3 50776.0 51538.0 51672.0 51692.7 51713.5 589628.0 594116.0 595033.0 595869.0 596540.0 24658.8 25100.4 27347.0 27815.6 27970.0 48435.5 48491.3 49021.0 49456.8 49610.0 39444.6 39744.2 39979.8 40025.0 41731.8 35651.8 38022.6 39609.8 40268.0 41487.4 38912.4 39284.4 39607.6 39872.6 39984.6 32120.1 34082.0 35263.0 35424.1 36003.6 25165.7 26330.7 26478.2 26519.9 26881.1 09:38:08 INFO - PROCESS | 29859 | 09:38:08 INFO - PROCESS | 29859 | [#2] jquery.html Cycles:180 Average:38258.53 Median:12461.84 stddev:114879.35 (921.8%) stddev-sans-first:115166.33 09:38:08 INFO - PROCESS | 29859 | Values: 337.0 386.3 397.5 406.1 417.9 19119.7 21376.6 21670.7 22344.1 22664.2 20563.6 21205.6 21443.7 21575.1 21997.7 5310.3 5602.4 5676.2 5683.3 5688.5 4117.7 4158.1 4163.0 5582.6 5691.0 6023.8 6259.7 6304.4 6349.4 6352.4 6088.6 6268.5 6328.5 6331.7 6341.6 5925.1 6170.0 6195.6 6196.2 6202.0 13439.7 13704.0 13708.1 13718.4 15485.4 2192.4 2215.5 2259.5 2653.0 2852.7 10440.3 10493.6 10586.9 10715.8 14734.3 1606.2 1883.8 1890.6 1949.4 1964.9 101229.0 141838.0 142353.0 143729.6 144074.0 11617.5 11714.1 11772.8 11775.5 11993.7 12622.7 15220.8 15224.6 15258.2 15324.9 8571.3 8705.8 8747.0 8792.8 8912.5 8598.4 8626.7 8629.6 8710.0 8880.4 4562.0 4617.1 4618.3 4630.6 4699.2 1793.5 1840.8 1921.6 1966.3 1989.4 815.4 908.1 920.8 979.0 1004.8 20955.8 21565.6 21836.0 21939.7 21955.2 913.9 977.2 985.0 1022.8 1030.9 10724.4 11542.1 11557.2 11563.4 11567.9 678774.6 685037.0 689730.0 691631.0 692311.0 136029.0 137611.0 138569.0 142463.0 143195.0 449.2 467.8 468.4 468.5 468.6 9870.5 11033.8 11127.4 11591.2 11676.8 53570.5 54126.0 55629.0 57073.3 60867.7 87563.0 89008.0 89345.7 89768.1 91090.0 8260.1 8316.7 8427.6 8492.7 8570.3 7346.2 9509.8 10558.7 12858.4 13907.8 9131.5 10175.7 10328.8 10913.9 11349.0 10008.6 10628.4 10752.4 10778.6 10945.8 11368.5 11397.6 11422.0 11432.1 11886.0 7969.7 8131.5 8243.7 8439.6 8541.6 10359.6 11158.9 11167.2 11447.7 11556.6 09:38:08 INFO - PROCESS | 29859 | 09:38:08 INFO - PROCESS | 29859 | [#3] mootools.html Cycles:180 Average:5790.82 Median:4826.09 stddev:3267.61 (67.7%) stddev-sans-first:3261.09 09:38:08 INFO - PROCESS | 29859 | Values: 1530.2 1558.1 1783.0 1937.9 1952.1 8642.3 9174.0 9178.3 9181.4 9190.1 8035.5 8279.2 8679.1 8872.2 8946.5 2401.9 2421.3 2433.6 2434.1 2435.2 2398.7 2408.0 2440.0 2443.5 2443.5 2421.2 2427.5 2439.8 2442.3 2473.6 2056.3 2390.0 2412.3 2415.0 2419.9 2399.4 2410.2 2413.1 2416.9 2418.2 8986.7 9041.9 9101.8 9113.0 9125.3 5436.7 5597.5 5597.7 5609.5 5613.9 3548.7 3642.2 3656.3 3718.0 3719.6 1084.7 1087.6 1090.4 1101.2 1112.3 11831.4 11881.2 11999.0 12000.0 12004.4 4523.2 4581.4 4763.5 4766.5 4773.7 9465.1 9466.7 9467.3 9468.3 9471.8 5422.1 5437.0 5440.1 5441.8 5454.6 4584.2 4747.6 4878.5 5004.2 5101.2 3871.6 3886.2 3993.8 3996.8 3999.9 1183.0 1191.5 1194.1 1201.7 1206.2 813.7 890.8 910.3 917.5 947.3 5700.3 5811.5 6045.2 6064.5 6110.2 434.9 447.2 453.3 458.9 466.6 3872.9 3968.7 3996.6 4065.2 4086.8 10559.0 11047.2 11060.9 11076.0 11083.2 8695.5 10570.0 11037.7 11068.8 11070.1 8355.2 8397.0 8458.0 8552.1 8571.1 5727.1 5952.4 5997.6 6000.7 6044.4 9999.6 10219.5 10238.5 10280.5 10300.3 10314.7 10419.5 10474.4 10576.0 10581.9 7198.6 7255.4 7257.7 7296.4 7316.0 8423.6 8503.2 8505.3 8507.7 8516.7 7610.0 7763.7 7804.3 7889.7 7893.4 7515.6 7625.8 7634.7 7664.5 7674.5 7091.6 7205.2 7215.6 7220.9 7231.4 4880.1 4954.3 5010.9 5080.7 5249.2 4277.4 4927.8 4954.4 5062.5 5097.5 09:38:08 INFO - PROCESS | 29859 | 09:38:08 INFO - PROCESS | 29859 | [#4] prototype.html Cycles:180 Average:4529.02 Median:5069.46 stddev:1427.98 (28.2%) stddev-sans-first:1396.38 09:38:08 INFO - PROCESS | 29859 | Values: 306.5 312.6 315.6 324.3 325.9 4460.4 5178.0 5328.7 5344.4 5420.5 4536.8 5176.6 5257.3 5289.0 5301.1 3337.5 3462.4 4076.7 4081.4 4089.4 3349.0 3651.7 3804.7 3836.8 4090.4 3177.4 3942.4 4050.0 4074.6 4113.6 3387.5 4013.1 4048.5 4059.1 4076.3 3524.8 3530.3 3534.1 3535.8 3557.8 3861.0 5240.2 5257.8 5307.9 5318.1 3941.9 4679.2 4699.6 4706.6 4751.1 4997.9 5151.9 5702.4 5730.4 5743.5 3733.1 3855.5 3893.4 3932.5 3937.5 5423.3 5955.0 5978.3 5992.1 6009.6 3557.7 3927.9 3931.8 3955.3 3970.7 3099.9 3694.5 3744.6 4037.5 4052.2 4643.6 4646.9 4651.9 4658.2 4663.7 4715.0 5036.9 5118.9 5713.6 5752.4 1164.9 1229.6 1283.3 1330.6 1338.8 750.5 821.7 897.5 920.1 920.7 5217.7 5219.9 5223.7 5253.6 5270.3 4791.6 4982.6 5747.0 5786.2 5795.3 4414.1 4823.8 5047.4 5188.5 5209.8 2365.5 2514.2 2850.1 3053.6 3057.0 4740.1 4939.7 5325.0 6039.6 6151.0 4998.5 5171.3 5686.3 5992.4 5999.7 5513.5 5782.5 5969.3 6022.7 6050.8 5823.8 5826.7 5837.1 5848.4 5870.5 4592.3 5226.9 5552.9 5720.2 5896.7 5037.6 6119.6 6143.0 6151.6 6153.7 3361.6 3712.4 3980.8 4010.4 4017.2 5538.1 5625.6 5856.9 5882.2 5887.5 5604.6 5654.7 5792.0 5794.6 5801.2 4542.6 4787.6 5091.5 5551.4 5739.5 4619.7 4670.2 5461.5 5643.6 5672.5 5439.5 5700.9 5765.0 5769.7 5790.8 4919.9 5154.2 5621.6 5640.6 5812.5 09:38:08 INFO - PROCESS | 29859 | 09:38:08 INFO - PROCESS | 29859 | [#5] yui.html Cycles:180 Average:25213.56 Median:3688.49 stddev:40911.01 (1109.2%) stddev-sans-first:40984.31 09:38:08 INFO - PROCESS | 29859 | Values: 683.3 712.9 735.8 797.7 839.4 15721.8 16795.2 16810.3 16816.0 16822.1 14723.0 14803.5 14843.5 14848.8 14883.4 712.0 734.5 738.9 885.6 891.5 902.7 903.3 919.1 919.7 922.3 988.8 989.0 990.8 990.9 991.2 973.8 976.7 977.6 977.9 978.9 732.7 732.7 732.8 733.3 734.7 15857.6 16184.3 16281.8 16327.0 16342.2 13569.5 13726.5 15191.5 15300.9 15306.5 11173.8 11745.6 12139.3 13418.9 13447.3 3742.2 4024.6 4076.0 4160.5 4164.2 119626.0 120685.8 121300.0 121525.4 122739.4 11001.7 11499.4 11605.2 11702.6 11774.6 23026.9 23097.9 23098.3 23138.4 23334.0 7884.9 8062.0 8071.8 8138.0 8249.8 4517.6 4532.9 4638.4 4764.5 4765.0 3641.7 3735.3 3786.7 3787.3 3796.1 680.1 685.1 685.9 692.3 694.9 591.9 679.9 696.1 705.5 713.2 9774.1 10037.1 10299.1 10299.2 10434.8 561.8 633.0 712.6 713.9 715.2 4188.3 4591.4 4611.7 4617.4 4630.4 128939.4 154881.0 160630.0 162286.0 166001.0 131598.3 133658.0 137943.2 142046.0 142575.9 73926.9 76721.6 79701.0 79936.6 119356.4 8775.9 8830.2 8885.8 9030.2 9042.8 59487.1 61398.4 62476.0 63172.7 64968.1 97280.0 100557.5 103599.0 104216.5 104895.4 11851.6 11886.5 12060.3 12303.2 12398.0 13102.6 13198.4 13274.1 13937.9 14354.5 12471.3 12642.6 12668.9 13049.9 13070.4 12018.6 12605.5 12733.9 12790.4 13122.7 10805.8 12184.5 12228.6 12341.2 12628.4 9274.4 9326.4 10685.0 10838.2 10940.9 9069.9 9734.2 10452.3 10467.8 10884.2 09:38:08 INFO - PROCESS | 29859 | -------- Summary: end -------- 09:38:08 INFO - PROCESS | 29859 | 09:38:09 INFO - TEST-INFO | 29859: exit 0 09:38:09 INFO - TEST-OK | dromaeo_css | took 1115110ms 09:38:09 INFO - TEST-START | kraken 09:38:09 INFO - operating with platform_type : mac_ 09:38:09 INFO - Initialising browser for kraken test... 09:38:09 INFO - TEST-INFO | started process 29863 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/tmphwzZNm/profile http://localhost:52623/getInfo.html) 09:38:11 INFO - PROCESS | 29863 | __metrics Screen width/height:1600/1200 09:38:11 INFO - PROCESS | 29863 | colorDepth:24 09:38:11 INFO - PROCESS | 29863 | Browser inner width/height: 1024/689 09:38:11 INFO - PROCESS | 29863 | __metrics 09:38:11 INFO - PROCESS | 29863 | 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" 09:38:11 INFO - PROCESS | 29863 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:38:12 INFO - TEST-INFO | 29863: exit 0 09:38:12 INFO - Browser initialized. 09:38:12 INFO - Running cycle 1/1 for kraken test... 09:38:12 INFO - TEST-INFO | started process 29865 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/tmphwzZNm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:38:24 INFO - PROCESS | 29865 | RSS: Main: 168628224 09:38:24 INFO - PROCESS | 29865 | 09:38:27 INFO - PROCESS | 29865 | Cycle 1(1): loaded http://localhost:52623/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52623/tests/kraken/driver.html?testName=audio-beat-detection) 09:38:28 INFO - PROCESS | 29865 | RSS: Main: 219586560 09:38:28 INFO - PROCESS | 29865 | 09:38:30 INFO - PROCESS | 29865 | Cycle 1(1): loaded http://localhost:52623/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52623/tests/kraken/driver.html?testName=audio-dft) 09:38:31 INFO - PROCESS | 29865 | RSS: Main: 234221568 09:38:31 INFO - PROCESS | 29865 | 09:38:34 INFO - PROCESS | 29865 | Cycle 1(1): loaded http://localhost:52623/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52623/tests/kraken/driver.html?testName=audio-fft) 09:38:34 INFO - PROCESS | 29865 | RSS: Main: 328675328 09:38:34 INFO - PROCESS | 29865 | 09:38:36 INFO - PROCESS | 29865 | Cycle 1(1): loaded http://localhost:52623/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52623/tests/kraken/driver.html?testName=audio-oscillator) 09:38:37 INFO - PROCESS | 29865 | RSS: Main: 229249024 09:38:37 INFO - PROCESS | 29865 | 09:38:39 INFO - PROCESS | 29865 | Cycle 1(1): loaded http://localhost:52623/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52623/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:38:40 INFO - PROCESS | 29865 | RSS: Main: 229306368 09:38:40 INFO - PROCESS | 29865 | 09:38:42 INFO - PROCESS | 29865 | Cycle 1(1): loaded http://localhost:52623/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52623/tests/kraken/driver.html?testName=imaging-darkroom) 09:38:43 INFO - PROCESS | 29865 | RSS: Main: 264830976 09:38:43 INFO - PROCESS | 29865 | 09:38:46 INFO - PROCESS | 29865 | Cycle 1(1): loaded http://localhost:52623/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52623/tests/kraken/driver.html?testName=imaging-desaturate) 09:38:46 INFO - PROCESS | 29865 | RSS: Main: 268333056 09:38:46 INFO - PROCESS | 29865 | 09:38:49 INFO - PROCESS | 29865 | Cycle 1(1): loaded http://localhost:52623/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52623/tests/kraken/driver.html?testName=json-parse-financial) 09:38:50 INFO - PROCESS | 29865 | RSS: Main: 264269824 09:38:50 INFO - PROCESS | 29865 | 09:38:51 INFO - PROCESS | 29865 | Cycle 1(1): loaded http://localhost:52623/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52623/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:38:52 INFO - PROCESS | 29865 | RSS: Main: 239382528 09:38:52 INFO - PROCESS | 29865 | 09:38:54 INFO - PROCESS | 29865 | Cycle 1(1): loaded http://localhost:52623/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52623/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:38:54 INFO - PROCESS | 29865 | RSS: Main: 244719616 09:38:54 INFO - PROCESS | 29865 | 09:38:56 INFO - PROCESS | 29865 | Cycle 1(1): loaded http://localhost:52623/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52623/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:38:57 INFO - PROCESS | 29865 | RSS: Main: 251224064 09:38:57 INFO - PROCESS | 29865 | 09:39:00 INFO - PROCESS | 29865 | Cycle 1(1): loaded http://localhost:52623/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52623/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:39:01 INFO - PROCESS | 29865 | RSS: Main: 257638400 09:39:01 INFO - PROCESS | 29865 | 09:39:03 INFO - PROCESS | 29865 | Cycle 1(1): loaded http://localhost:52623/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52623/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:39:04 INFO - PROCESS | 29865 | RSS: Main: 258469888 09:39:04 INFO - PROCESS | 29865 | 09:39:06 INFO - PROCESS | 29865 | Cycle 1(1): loaded http://localhost:52623/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52623/tests/kraken/driver.html?testName=ai-astar) 09:39:06 INFO - PROCESS | 29865 | RSS: Main: 302628864 09:39:06 INFO - PROCESS | 29865 | 09:39:06 INFO - PROCESS | 29865 | __start_tp_report 09:39:06 INFO - PROCESS | 29865 | _x_x_mozilla_page_load 09:39:06 INFO - PROCESS | 29865 | _x_x_mozilla_page_load_details 09:39:06 INFO - PROCESS | 29865 | |i|pagename|runs| 09:39:06 INFO - PROCESS | 29865 | |0;ai-astar;120;168;155;114;113;113;114;114;112;114 09:39:06 INFO - PROCESS | 29865 | |1;audio-beat-detection;147;108;106;143;107;108;106;107;137;107 09:39:06 INFO - PROCESS | 29865 | |2;audio-dft;185;186;185;184;183;185;185;185;183;184 09:39:06 INFO - PROCESS | 29865 | |3;audio-fft;82;58;60;89;70;80;82;78;82;57 09:39:06 INFO - PROCESS | 29865 | |4;audio-oscillator;87;70;93;70;67;69;92;67;68;88 09:39:06 INFO - PROCESS | 29865 | |5;imaging-gaussian-blur;88;84;88;84;87;83;101;129;119;83 09:39:06 INFO - PROCESS | 29865 | |6;imaging-darkroom;98;96;97;96;97;97;98;97;98;96 09:39:06 INFO - PROCESS | 29865 | |7;imaging-desaturate;85;86;85;86;87;85;86;86;83;89 09:39:06 INFO - PROCESS | 29865 | |8;json-parse-financial;56;52;51;51;55;58;58;58;58;57 09:39:06 INFO - PROCESS | 29865 | |9;json-stringify-tinderbox;72;65;75;75;71;70;70;71;70;73 09:39:06 INFO - PROCESS | 29865 | |10;stanford-crypto-aes;83;83;84;82;85;85;87;89;126;82 09:39:06 INFO - PROCESS | 29865 | |11;stanford-crypto-ccm;135;138;136;136;134;135;133;138;150;137 09:39:06 INFO - PROCESS | 29865 | |12;stanford-crypto-pbkdf2;164;159;158;159;161;160;162;161;158;158 09:39:06 INFO - PROCESS | 29865 | |13;stanford-crypto-sha256-iterative;66;66;65;79;84;82;82;64;64;67 09:39:06 INFO - PROCESS | 29865 | __end_tp_report 09:39:06 INFO - PROCESS | 29865 | __start_cc_report 09:39:06 INFO - PROCESS | 29865 | _x_x_mozilla_cycle_collect,1813 09:39:06 INFO - PROCESS | 29865 | __end_cc_report 09:39:06 INFO - PROCESS | 29865 | __startTimestamp1483551546407__endTimestamp 09:39:06 INFO - PROCESS | 29865 | 09:39:06 INFO - PROCESS | 29865 | ------- Summary: start ------- 09:39:06 INFO - PROCESS | 29865 | Number of tests: 14 09:39:06 INFO - PROCESS | 29865 | 09:39:06 INFO - PROCESS | 29865 | [#0] ai-astar Cycles:10 Average:123.70 Median:114.00 stddev:20.27 (17.8%) stddev-sans-first:21.46 09:39:06 INFO - PROCESS | 29865 | Values: 120.0 168.0 155.0 114.0 113.0 113.0 114.0 114.0 112.0 114.0 09:39:06 INFO - PROCESS | 29865 | 09:39:06 INFO - PROCESS | 29865 | [#1] audio-beat-detection Cycles:10 Average:117.60 Median:108.00 stddev:17.24 (16.0%) stddev-sans-first:14.65 09:39:06 INFO - PROCESS | 29865 | Values: 147.0 108.0 106.0 143.0 107.0 108.0 106.0 107.0 137.0 107.0 09:39:06 INFO - PROCESS | 29865 | 09:39:06 INFO - PROCESS | 29865 | [#2] audio-dft Cycles:10 Average:184.50 Median:185.00 stddev:0.97 (0.5%) stddev-sans-first:1.01 09:39:06 INFO - PROCESS | 29865 | Values: 185.0 186.0 185.0 184.0 183.0 185.0 185.0 185.0 183.0 184.0 09:39:06 INFO - PROCESS | 29865 | 09:39:06 INFO - PROCESS | 29865 | [#3] audio-fft Cycles:10 Average:73.80 Median:81.00 stddev:11.67 (14.4%) stddev-sans-first:11.99 09:39:06 INFO - PROCESS | 29865 | Values: 82.0 58.0 60.0 89.0 70.0 80.0 82.0 78.0 82.0 57.0 09:39:06 INFO - PROCESS | 29865 | 09:39:06 INFO - PROCESS | 29865 | [#4] audio-oscillator Cycles:10 Average:77.10 Median:78.50 stddev:11.28 (14.4%) stddev-sans-first:11.38 09:39:06 INFO - PROCESS | 29865 | Values: 87.0 70.0 93.0 70.0 67.0 69.0 92.0 67.0 68.0 88.0 09:39:06 INFO - PROCESS | 29865 | 09:39:06 INFO - PROCESS | 29865 | [#5] imaging-gaussian-blur Cycles:10 Average:94.60 Median:84.00 stddev:16.53 (19.7%) stddev-sans-first:17.36 09:39:06 INFO - PROCESS | 29865 | Values: 88.0 84.0 88.0 84.0 87.0 83.0 101.0 129.0 119.0 83.0 09:39:06 INFO - PROCESS | 29865 | 09:39:06 INFO - PROCESS | 29865 | [#6] imaging-darkroom Cycles:10 Average:97.00 Median:97.00 stddev:0.82 (0.8%) stddev-sans-first:0.78 09:39:06 INFO - PROCESS | 29865 | Values: 98.0 96.0 97.0 96.0 97.0 97.0 98.0 97.0 98.0 96.0 09:39:06 INFO - PROCESS | 29865 | 09:39:06 INFO - PROCESS | 29865 | [#7] imaging-desaturate Cycles:10 Average:85.80 Median:86.00 stddev:1.55 (1.8%) stddev-sans-first:1.62 09:39:06 INFO - PROCESS | 29865 | Values: 85.0 86.0 85.0 86.0 87.0 85.0 86.0 86.0 83.0 89.0 09:39:06 INFO - PROCESS | 29865 | 09:39:06 INFO - PROCESS | 29865 | [#8] json-parse-financial Cycles:10 Average:55.40 Median:57.50 stddev:2.99 (5.2%) stddev-sans-first:3.16 09:39:06 INFO - PROCESS | 29865 | Values: 56.0 52.0 51.0 51.0 55.0 58.0 58.0 58.0 58.0 57.0 09:39:06 INFO - PROCESS | 29865 | 09:39:06 INFO - PROCESS | 29865 | [#9] json-stringify-tinderbox Cycles:10 Average:71.20 Median:71.50 stddev:2.90 (4.1%) stddev-sans-first:3.06 09:39:06 INFO - PROCESS | 29865 | Values: 72.0 65.0 75.0 75.0 71.0 70.0 70.0 71.0 70.0 73.0 09:39:06 INFO - PROCESS | 29865 | 09:39:06 INFO - PROCESS | 29865 | [#10] stanford-crypto-aes Cycles:10 Average:88.60 Median:84.50 stddev:13.33 (15.8%) stddev-sans-first:13.98 09:39:06 INFO - PROCESS | 29865 | Values: 83.0 83.0 84.0 82.0 85.0 85.0 87.0 89.0 126.0 82.0 09:39:06 INFO - PROCESS | 29865 | 09:39:06 INFO - PROCESS | 29865 | [#11] stanford-crypto-ccm Cycles:10 Average:137.20 Median:136.50 stddev:4.78 (3.5%) stddev-sans-first:5.00 09:39:06 INFO - PROCESS | 29865 | Values: 135.0 138.0 136.0 136.0 134.0 135.0 133.0 138.0 150.0 137.0 09:39:06 INFO - PROCESS | 29865 | 09:39:06 INFO - PROCESS | 29865 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.00 Median:160.50 stddev:2.00 (1.2%) stddev-sans-first:1.51 09:39:06 INFO - PROCESS | 29865 | Values: 164.0 159.0 158.0 159.0 161.0 160.0 162.0 161.0 158.0 158.0 09:39:06 INFO - PROCESS | 29865 | 09:39:06 INFO - PROCESS | 29865 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.90 Median:73.00 stddev:8.61 (11.8%) stddev-sans-first:8.86 09:39:06 INFO - PROCESS | 29865 | Values: 66.0 66.0 65.0 79.0 84.0 82.0 82.0 64.0 64.0 67.0 09:39:06 INFO - PROCESS | 29865 | -------- Summary: end -------- 09:39:06 INFO - PROCESS | 29865 | 09:39:07 INFO - TEST-INFO | 29865: exit 0 09:39:07 INFO - TEST-OK | kraken | took 57804ms 09:39:07 INFO - SUITE-END | took 1172s 09:39:07 INFO - Completed test suite (00:19:33) 09:39:07 INFO - javascript benchmark 09:39:07 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3365.2259980204553, 3378.375000624884, 3385.4414021686407, 3416.743744219184, 3432.897013089608, 5669.0, 5747.741351639186, 5754.913676294848, 5755.942440575593, 5757.856053598657, 5729.197912292272, 5795.101759227316, 5815.912761308584, 5822.155787410823, 5830.708464576775, 5185.481451854813, 5257.369115706101, 5267.55225805807, 5288.418273989858, 5323.574114070884, 5183.714895680736, 5186.351706036746, 5193.0, 5329.706866122362, 5341.893162136755, 5249.553787928031, 5257.211418287249, 5259.974305010524, 5260.605454590902, 5265.526102650761, 5244.344456942882, 5262.631615786877, 5320.654157479751, 5320.893582128336, 5330.813421530228, 5125.974370128163, 5188.533032027136, 5259.368875734898, 5285.233641122054, 5291.3385826771655, 5689.943100569024, 5697.430256974311, 5706.315242170925, 5732.254806875121, 5780.479756821906, 6177.62934223948, 6220.626762394226, 6233.781817636406, 6256.468200202989, 6291.402316779899, 6247.156633854417, 6300.905486417661, 6302.338254483305, 6302.621842689453, 6313.842153946142, 5695.060315048054, 5748.511376532958, 5809.7095145242565, 5908.14331921869, 5913.349531551526, 6260.24877014752, 6276.372362763687, 6295.055741638791, 6310.495160387158, 6315.842103947346, 6205.503559715302, 6207.751689932352, 6227.221597300338, 6228.719707613168, 6232.626042437469, 6117.675163990694, 6119.258838874149, 6212.751489940442, 6238.906416403667, 6282.434580887651, 6262.3111457739615, 6270.467010304175, 6288.245410550763, 6291.056341548713, 6301.6534090625455, 6229.813105606839, 6246.875062498815, 6289.182406287154, 6312.747490100436, 6317.020861766434, 4865.197242455026, 4906.975465122651, 4919.729414882216, 4975.154223781966, 5023.246513023076, 4455.933161002587, 4511.887202819956, 4515.841945531891, 4519.638428925678, 4567.132244873464, 5672.290963629546, 5681.176229446707, 5694.743736531866, 5695.0, 5703.17303990919, 6122.112293717475, 6288.339724328879, 6296.464800491918, 6309.053641953744, 6310.52671049664, 5587.385387607441, 5594.440555944373, 5640.492355688008, 5642.069058605366, 5671.971640141773, 5404.567634589223, 5425.674459532441, 5432.348118225838, 5436.10304299794, 5455.072637651609, 6329.651869147241, 6329.841753956096, 6336.651484168415, 6339.366063393623, 6339.809805705836, 6128.136482154469, 6136.886723215932, 6180.227471566054, 6238.968805155945, 6312.873742525032, 6285.308616052139, 6290.779822706367, 6310.968445157929, 6319.9052014218905, 6335.841603959753, 6228.190335256388, 6237.719302631302, 6243.219597550306, 6243.8126856194385, 6263.937360626335, 6113.537117903944, 6177.907331389943, 6209.689515524115, 6256.311805701278, 6281.685915704288, 5988.520918326436, 6080.331163571915, 6164.599301045418, 6170.10533472653, 6193.287771906288, 6173.660448675366, 6177.4749146323065, 6183.876322473615, 6186.783462578788, 6189.319174890848, 5833.891560603472, 5855.94144058571, 6004.919621338132, 6058.303295121117, 6061.181740464981, 5191.169412893919, 6045.21412216409, 6105.752712533616, 6113.150045066789, 6133.233345831771, 5976.252968378953, 6020.795840831764, 6024.186734790747, 6024.819255422344, 6032.849178770566], "value": 5732.922861689948, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [491.9016196760646, 509.93880734311875, 511.87970826855684, 528.3659608469833, 539.8704310965367, 31800.522992155107, 42034.36948445772, 43123.13753724928, 43140.78429607848, 45688.54311456884, 44471.555284447146, 44823.55176448235, 44884.775576122156, 44957.0, 45270.094598108015, 10053.949730251357, 10246.38521688701, 10246.692599221999, 10257.846132308021, 10258.948705256464, 9259.398139120936, 9510.144087032166, 12209.572664956728, 12498.500059997588, 12502.374881255946, 12386.752264954695, 12492.625221243332, 12493.750624937478, 12496.437660305308, 12501.0, 10512.947435262851, 12447.813282800766, 12493.750124997448, 12532.874671253261, 12564.183328083736, 12258.0, 12359.0, 12364.876351236553, 12373.381330933418, 12376.752464950741, 41714.748557543324, 42041.73874783761, 42140.94647633803, 42159.7892010538, 42226.0, 3305.0, 3338.9499157512655, 3416.0, 3649.3613617617075, 3688.815559222055, 30648.387032259452, 31937.041888743373, 31938.840305798323, 32418.189545261557, 32656.69373225092, 3099.5505651680605, 3170.318381547955, 3297.653746356646, 3336.0, 3340.5657264555693, 480515.0, 544330.0, 548838.0, 550534.2473287648, 550821.0, 34958.82520587432, 64830.351696483376, 65071.67464162743, 65297.0, 65421.67289163524, 35957.820210898775, 37329.25341493155, 37384.81307593499, 37427.62572374296, 37444.625553744656, 15920.363185472452, 16036.957597756109, 16042.679146417006, 16078.276477558538, 16093.195340232942, 12352.25886446816, 12502.249865008129, 13465.596032119052, 13561.525346612822, 13587.932060339832, 6704.564203326768, 7127.536710113826, 8189.385796065199, 8194.54929978845, 8264.380171487162, 3357.5635167428077, 3381.3406385755034, 3388.678075582816, 3402.5236466894653, 3405.0806282304134, 988.6984469736799, 989.4014121456559, 1004.8794144702682, 1014.325473560089, 1076.962306319275, 29865.253368665522, 30837.38325233483, 31185.220369490944, 31237.0, 31639.841800790848, 1098.6154845804065, 1100.8899110088928, 1114.0864491117206, 1120.843081968525, 1142.8285757136496, 13652.65868353299, 13991.860081399056, 15675.608109797346, 16212.189390530426, 16347.937384069997, 728417.0, 761702.0, 763299.0, 764749.0, 767696.0, 60976.390236097955, 61339.0, 61429.0, 61436.69281653563, 61502.69248653817, 1295.1452041652465, 1332.3072002558615, 1413.5264686330195, 1443.2927865345905, 1470.5000299898086, 30267.848660756554, 31628.841855791496, 32716.50925236171, 32756.34487310288, 33425.33149337048, 50776.0, 51538.0, 51672.0, 51692.74153629358, 51713.48286517087, 589628.0, 594116.0, 595033.0, 595869.0, 596540.0, 24658.753412465645, 25100.372490687147, 27347.042853500032, 27815.582766258118, 27970.0, 48435.5156448431, 48491.27263091127, 49021.0, 49456.763580909326, 49610.0, 39444.60555394409, 39744.2051158981, 39979.800605981865, 40025.0, 41731.791341044314, 35651.82174089113, 38022.61977380191, 39609.80195099006, 40267.99330016773, 41487.377689334084, 38912.41631375588, 39284.410733839584, 39607.60392396039, 39872.60127398689, 39984.600153998086, 32120.109190172996, 34081.97754067382, 35263.0, 35424.096913666384, 36003.63996360003, 25165.74834251634, 26330.73669263283, 26478.205653830417, 26519.939202431688, 26881.059162929203], "value": 19817.180635548862, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [336.99743263790225, 386.3065796894574, 397.46143974914, 406.0863058119232, 417.8537511870846, 19119.71320430195, 21376.57246855062, 21670.674939875877, 22344.106235750573, 22664.206752763657, 20563.588728225426, 21205.57588848226, 21443.67834482484, 21575.1369945202, 21997.67003494949, 5310.283111779918, 5602.355729091166, 5676.205331253628, 5683.3464151622475, 5688.516476099516, 4117.732347397409, 4158.064435502003, 4163.042500224935, 5582.637128586649, 5691.004074287004, 6023.849403764919, 6259.687015649222, 6304.401081897236, 6349.365063493637, 6352.428281454668, 6088.604240724361, 6268.5298602604535, 6328.462080723098, 6331.746730130789, 6341.619502829845, 5925.111233315038, 6169.969150154266, 6195.628262304276, 6196.163517925068, 6201.9689901550655, 13439.66400839977, 13704.0, 13708.108972916829, 13718.38267277975, 15485.380584776596, 2192.440927563461, 2215.490437199453, 2259.469024779192, 2652.9786032377674, 2852.671942726592, 10440.32137911041, 10493.632722854663, 10586.894131058667, 10715.785684286271, 14734.336954837057, 1606.1567676969566, 1883.8116188381189, 1890.6124244529976, 1949.3567122849427, 1964.9214031438726, 101229.0, 141838.0, 142353.0, 143729.5627043737, 144074.0, 11617.53529858813, 11714.121440891968, 11772.823407648892, 11775.470103845348, 11993.700157496132, 12622.684432889251, 15220.771688424682, 15224.619384515476, 15258.237088145548, 15324.923375383052, 8571.271441927505, 8705.828453049735, 8746.956265218632, 8792.824143517093, 8912.465252084896, 8598.398112132216, 8626.654933802578, 8629.626852615456, 8709.956450217709, 8880.37837351392, 4562.019165879352, 4617.145828021827, 4618.330342100444, 4630.6063984561015, 4699.2481203007355, 1793.5336812428861, 1840.8029692301575, 1921.5964647424198, 1966.2823069579501, 1989.383291179739, 815.4210510537584, 908.0873721909438, 920.8480600700809, 978.9608415663436, 1004.8492726091145, 20955.790442095687, 21565.56868862614, 21836.0, 21939.67090493644, 21955.2315668954, 913.9405938613969, 977.154761131616, 985.0494273026563, 1022.805666923297, 1030.9278350515392, 10724.41015744126, 11542.13433992454, 11557.190996630155, 11563.364014979257, 11567.942160289145, 678774.6061269662, 685037.0, 689730.0, 691631.0, 692311.0, 136029.0, 137611.0, 138569.0, 142463.0, 143195.0, 449.17576247586044, 467.7637792914624, 468.3910915809502, 468.51274674338987, 468.63212378283566, 9870.457124858201, 11033.83449248278, 11127.443627818739, 11591.18861679708, 11676.824847627462, 53570.46429535655, 54126.0, 55629.0, 57073.28780136602, 60867.69566152141, 87563.0, 89008.0, 89345.65981510152, 89768.10231897859, 91090.0, 8260.091389947222, 8316.6673333066, 8427.620757065824, 8492.683634036734, 8570.271526920282, 7346.191918888811, 9509.809803804024, 10558.736031599272, 12858.357082145669, 13907.791383129059, 9131.452112873249, 10175.72803399575, 10328.845067324146, 10913.945430272797, 11349.035331996542, 10008.599656013968, 10628.41543715103, 10752.354858708502, 10778.568857245622, 10945.83581246298, 11368.54525818991, 11397.601083962021, 11422.029127524254, 11432.08543316516, 11886.049116070866, 7969.681212751425, 8131.471454355448, 8243.670253189804, 8439.620217090369, 8541.572921353783, 10359.585616575252, 11158.944205278922, 11167.218294719292, 11447.713807154887, 11556.59551915679], "value": 9311.657759585194, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1530.1737061986523, 1558.080732367903, 1782.9732554011691, 1937.8740381875168, 1952.0825212150294, 8642.308615310776, 9174.0, 9178.265738740893, 9181.357304988645, 9190.126937940902, 8035.477693949903, 8279.172082791718, 8679.132086791318, 8872.157145071207, 8946.507942063185, 2401.9071322548243, 2421.2736179146186, 2433.6471211674298, 2434.1115492845074, 2435.232901635979, 2398.688170537828, 2408.036785285882, 2439.9996001639242, 2443.4624382635793, 2443.5479436304254, 2421.1767998880377, 2427.526632306692, 2439.8048156147465, 2442.255112190781, 2473.6042233242683, 2056.290579749991, 2390.0, 2412.300432874464, 2414.987925060372, 2419.903203871843, 2399.3761621978238, 2410.156445244168, 2413.1312727418117, 2416.867072311022, 2418.1899063813644, 8986.68546600866, 9041.909580904172, 9101.772455688595, 9113.043130471338, 9125.315601329861, 5436.673799572039, 5597.496225339698, 5597.6641401516035, 5609.495145436889, 5613.859653508654, 3548.6983606393487, 3642.1987162824134, 3656.323580137683, 3717.981410092932, 3719.6280371962857, 1084.7017070305728, 1087.5595383869465, 1090.4275255490852, 1101.1796211822164, 1112.327042139502, 11831.408429578487, 11881.168318217728, 11998.96017676997, 12000.0, 12004.399780011052, 4523.185826551186, 4581.411502501076, 4763.476017638057, 4766.451858036301, 4773.71357718538, 9465.100815422524, 9466.715998520056, 9467.337286390024, 9468.28987825902, 9471.810563788824, 5422.105352616774, 5437.0, 5440.075187218183, 5441.782328706887, 5454.61817672767, 4584.1977653910435, 4747.643926705511, 4878.463369029404, 5004.224345226496, 5101.158308879068, 3871.6321949415324, 3886.1839013806853, 3993.84024639017, 3996.84012639497, 3999.92000160001, 1182.9645110646695, 1191.4578866615668, 1194.056695210791, 1201.6635342104225, 1206.240068756695, 813.6745301879178, 890.7819529371947, 910.3172620534599, 917.5045475443186, 947.303731757158, 5700.3444603871085, 5811.476967072899, 6045.244344456943, 6064.545159112996, 6110.205673262536, 434.86084452974745, 447.16603534408745, 453.28381157770644, 458.86692859070496, 466.59406316504857, 3872.8644497442456, 3968.6825053995613, 3996.620321069494, 4065.166640838621, 4086.7752273625238, 10559.0, 11047.226694131494, 11060.944695276634, 11076.0, 11083.224174307721, 8695.478271303742, 10570.048695617277, 11037.668869933754, 11068.778624427627, 11070.114390848712, 8355.248027677539, 8396.958015209884, 8457.957710211409, 8552.059273479912, 8571.100034496412, 5727.11229759388, 5952.375000624872, 5997.610155339889, 6000.729967151401, 6044.425779550936, 9999.55002024896, 10219.48902554884, 10238.539265733209, 10280.485975701036, 10300.330478518872, 10314.730759232956, 10419.479026048515, 10474.371537707762, 10575.995280448346, 10581.947090264499, 7198.640067996684, 7255.419566434567, 7257.673404696907, 7296.379807716404, 7316.0489136411925, 8423.620937057725, 8503.1921967413, 8505.277051450696, 8507.702230421906, 8516.659333626834, 7609.961950190213, 7763.650635721519, 7804.2585954334245, 7889.684412623431, 7893.42131573676, 7515.624218788929, 7625.809354765954, 7634.656440460081, 7664.540127592362, 7674.53952762836, 7091.60996145217, 7205.171405288459, 7215.60314182725, 7220.855582888418, 7231.4214862809795, 4880.145974454527, 4954.256861470664, 5010.874728131826, 5080.7205603692155, 5249.238860365149, 4277.401163837003, 4927.802887884444, 4954.355933728592, 5062.519060689228, 5097.541221290102], "value": 4569.68428821161, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [306.4896946583938, 312.58738465225895, 315.56767228896416, 324.34482345661763, 325.90171123314434, 4460.375547423363, 5177.974110129444, 5328.653637513559, 5344.412114667383, 5420.539254163401, 4536.773161341928, 5176.58587313015, 5257.319876086735, 5288.973555132219, 5301.1253143231415, 3337.4826901830133, 3462.3767721810063, 4076.673866090706, 4081.3877918312196, 4089.427480152781, 3348.961821835239, 3651.726120540957, 3804.706399824059, 3836.769793812366, 4090.406891000803, 3177.380410819891, 3942.4086387041884, 4049.959500404988, 4074.6129117733917, 4113.56807535209, 3387.491876218575, 4013.097053163044, 4048.473698419187, 4059.147579008412, 4076.266272071026, 3524.8237588120746, 3530.3468858261303, 3534.1164708822794, 3535.7701749386465, 3557.790351280551, 3860.9806950965344, 5240.240165176028, 5257.764425360076, 5307.946920530784, 5318.095923692981, 3941.881743547698, 4679.22792739201, 4699.647526435531, 4706.623470122382, 4751.097291514636, 4997.875053123665, 5151.871203219912, 5702.401247868997, 5730.398308177623, 5743.540516758691, 3733.099192510117, 3855.5373355197557, 3893.357595996657, 3932.508436445444, 3937.5471820740695, 5423.2949716537, 5954.970225148846, 5978.3260687007705, 5992.063888694508, 6009.579329446897, 3557.7153827693724, 3927.9410808837893, 3931.8427262909736, 3955.268275369066, 3970.7021973352116, 3099.9225019374694, 3694.4827724118645, 3744.588095309514, 4037.454943582579, 4052.230076285496, 4643.558861908114, 4646.907061858744, 4651.906961860744, 4658.161530924398, 4663.743494107789, 4715.0, 5036.917062831509, 5118.872028199325, 5713.5714821388565, 5752.395998420106, 1164.8835116488283, 1229.624964385871, 1283.345493798151, 1330.5808670269028, 1338.785794272931, 750.5496701978769, 821.7370441458676, 897.5056530876018, 920.1488623023677, 920.6788258848574, 5217.660852044605, 5219.869503262449, 5223.686578805284, 5253.553447956967, 5270.288511051036, 4791.6406269529925, 4982.60139188864, 5747.0, 5786.189933409326, 5795.290389335156, 4414.146058655372, 4823.831165909176, 5047.394312682502, 5188.507091826271, 5209.765560549784, 2365.474269096423, 2514.245726282108, 2850.1307101333878, 3053.5724998500227, 3056.984715076455, 4740.146773580788, 4939.678920870132, 5325.0148722486465, 6039.553980637848, 6151.016756872913, 4998.450170481244, 5171.3277273954145, 5686.2607860977805, 5992.370801065913, 5999.730012149464, 5513.5037846593195, 5782.508486778671, 5969.253843269591, 6022.69886505673, 6050.788222412194, 5823.777006828444, 5826.659868230246, 5837.1244313351635, 5848.385919478394, 5870.53035757147, 4592.280252995085, 5226.928479661737, 5552.861178470571, 5720.227769251264, 5896.6756828374855, 5037.596992240685, 6119.602225855305, 6142.969285153546, 6151.630902145886, 6153.692315384303, 3361.596608407007, 3712.424574191005, 3980.8009599520487, 4010.3984402339884, 4017.216642754635, 5538.113901775697, 5625.634333768456, 5856.916470452979, 5882.176495290748, 5887.499562537232, 5604.607677462538, 5654.6889921054735, 5792.0, 5794.62334948227, 5801.1878337033695, 4542.613877820422, 4787.61699064067, 5091.516305950929, 5551.361593416808, 5739.483446489836, 4619.69971951822, 4670.206064969031, 5461.481159289861, 5643.633163844337, 5672.5461963042035, 5439.48324909133, 5700.862176683743, 5765.0, 5769.711514424178, 5790.768369265351, 4919.926201106915, 5154.196031388984, 5621.550275977994, 5640.633358831663, 5812.476877081083], "value": 4077.275751114851, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [683.2825533190152, 712.9108861392326, 735.7829440315106, 797.7247849491927, 839.366278459763, 15721.842781572195, 16795.244214010367, 16810.32758689651, 16816.0, 16822.074785886773, 14723.0, 14803.481878134267, 14843.480478183266, 14848.777268340984, 14883.404663813435, 711.9822004449904, 734.456502188382, 738.8854727517244, 885.59705334073, 891.5230351761809, 902.6524787956652, 903.2864037410438, 919.0946917286467, 919.6873063158524, 922.299052719931, 988.8269552828226, 989.0060489208336, 990.8365119755268, 990.8563258327538, 991.1575161113033, 973.8198433289864, 976.7069879036261, 977.6236149082619, 977.8826540815077, 978.862959185711, 732.6886073418775, 732.7362149626131, 732.7984804178893, 733.339994005394, 734.7208060936863, 15857.60355991098, 16184.271707773178, 16281.837181628269, 16327.0, 16342.182890855529, 13569.52506662262, 13726.45094196231, 15191.505953630727, 15300.911945133632, 15306.464273750365, 11173.83239251412, 11745.58890438839, 12139.332336721476, 13418.93290533541, 13447.32763361828, 3742.2328422673286, 4024.6176613221696, 4076.001379662002, 4160.54234034256, 4164.229617520768, 119626.0, 120685.79314206833, 121300.0, 121525.39237303757, 122739.38630306881, 11001.724956876142, 11499.367534785668, 11605.187636865507, 11702.648920532398, 11774.587889423829, 23026.884865575565, 23097.88451057734, 23098.307050788168, 23138.421539461313, 23334.0, 7884.921150788534, 8061.959690201512, 8071.838563228703, 8137.98275215598, 8249.79375515617, 4517.638588912879, 4532.864014079583, 4638.350630911675, 4764.523547645208, 4764.951710623657, 3641.7268704847243, 3735.2529494101286, 3786.659200671953, 3787.3372159872465, 3796.0699628591174, 680.0954730208811, 685.1059367525427, 685.8628274345151, 692.3388164303078, 694.9027136200936, 591.899377105893, 679.8708245433352, 696.1472196559275, 705.4990956420999, 713.2403989750899, 9774.067779666071, 10037.141583717188, 10299.124574411258, 10299.17606591471, 10434.791304173874, 561.7584438691321, 632.9556232216787, 712.6401167410528, 713.8893471511924, 715.2454160860239, 4188.308929026676, 4591.357209990604, 4611.654125940501, 4617.376654151646, 4630.351750754897, 128939.35530322476, 154881.0, 160630.0, 162286.0, 166001.0, 131598.34200829125, 133658.0, 137943.24113517674, 142046.0, 142575.86136207965, 73926.8910966336, 76721.61639191768, 79701.0, 79936.6003169992, 119356.40321798161, 8775.912240877766, 8830.205281524693, 8885.777855553662, 9030.187283144549, 9042.773930651787, 59487.1076933855, 61398.386016141056, 62476.0, 63172.684136580865, 64968.05095847132, 97280.0, 100557.49163762695, 103599.0, 104216.47891760492, 104895.4265686, 11851.585194518151, 11886.524539018343, 12060.336681482602, 12303.200291980993, 12398.0, 13102.606921792361, 13198.406071726604, 13274.137181083199, 13937.860621393656, 14354.49759258421, 12471.251724896536, 12642.620721378373, 12668.936655316664, 13049.869501304865, 13070.411831467796, 12018.639440816789, 12605.49578016869, 12733.93633031866, 12790.36048197605, 13122.671933201746, 10805.837912431163, 12184.51261949512, 12228.571999979958, 12341.197822141532, 12628.43172057278, 9274.397164184307, 9326.36289788043, 10684.984926431976, 10838.241323107306, 10940.890591093987, 9069.863952040592, 9734.221262299141, 10452.268341216346, 10467.842982355118, 10884.183686223407], "value": 7944.876642649669, "unit": "score"}], "name": "dromaeo_css", "value": 7341.852711527317, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 168.0, 155.0, 114.0, 113.0, 113.0, 114.0, 114.0, 112.0, 114.0], "value": 123.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 108.0, 106.0, 143.0, 107.0, 108.0, 106.0, 107.0, 137.0, 107.0], "value": 117.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 186.0, 185.0, 184.0, 183.0, 185.0, 185.0, 185.0, 183.0, 184.0], "value": 184.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 58.0, 60.0, 89.0, 70.0, 80.0, 82.0, 78.0, 82.0, 57.0], "value": 73.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 70.0, 93.0, 70.0, 67.0, 69.0, 92.0, 67.0, 68.0, 88.0], "value": 77.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 84.0, 88.0, 84.0, 87.0, 83.0, 101.0, 129.0, 119.0, 83.0], "value": 94.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 96.0, 97.0, 96.0, 97.0, 97.0, 98.0, 97.0, 98.0, 96.0], "value": 97.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 85.0, 86.0, 87.0, 85.0, 86.0, 86.0, 83.0, 89.0], "value": 85.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 52.0, 51.0, 51.0, 55.0, 58.0, 58.0, 58.0, 58.0, 57.0], "value": 55.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 65.0, 75.0, 75.0, 71.0, 70.0, 70.0, 71.0, 70.0, 73.0], "value": 71.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 84.0, 82.0, 85.0, 85.0, 87.0, 89.0, 126.0, 82.0], "value": 88.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 138.0, 136.0, 136.0, 134.0, 135.0, 133.0, 138.0, 150.0, 137.0], "value": 137.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 159.0, 158.0, 159.0, 161.0, 160.0, 162.0, 161.0, 158.0, 158.0], "value": 160.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 65.0, 79.0, 84.0, 82.0, 82.0, 64.0, 64.0, 67.0], "value": 71.9, "unit": "score"}], "name": "kraken", "value": 1438.4, "alertThreshold": 2.0}]} 09:39:07 INFO - Return code: 0 09:39:07 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:39:07 INFO - # TBPL SUCCESS # 09:39:07 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:39:07 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:39:07 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:39:07 INFO - 2017-01-04 09:39:07.763 screenresolution[29869:284140] starting screenresolution argv=screenresolution get 09:39:07 INFO - 2017-01-04 09:39:07.766 screenresolution[29869:284140] Display 0: 1600x1200x32@60 09:39:07 INFO - 2017-01-04 09:39:07.772 screenresolution[29870:284143] starting screenresolution argv=screenresolution list 09:39:07 INFO - Available Modes on Display 0 09:39:07 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:39:07 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:39:07 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:39:07 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:39:07 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:39:07 INFO - Intel Iris: 09:39:07 INFO - Chipset Model: Intel Iris 09:39:07 INFO - Type: GPU 09:39:08 INFO - Bus: Built-In 09:39:08 INFO - VRAM (Dynamic, Max): 1536 MB 09:39:08 INFO - Vendor: Intel (0x8086) 09:39:08 INFO - Device ID: 0x0a2e 09:39:08 INFO - Revision ID: 0x0009 09:39:08 INFO - Displays: 09:39:08 INFO - Display: 09:39:08 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:39:08 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:39:08 INFO - Display Serial Number: 1600x1200 60 09:39:08 INFO - Main Display: Yes 09:39:08 INFO - Mirror: Off 09:39:08 INFO - Online: Yes 09:39:08 INFO - Rotation: Supported 09:39:08 INFO - Return code: 0 09:39:08 INFO - Running post-action listener: _resource_record_post_action 09:39:08 INFO - [mozharness: 2017-01-04 17:39:08.005763Z] Finished run-tests step (success) 09:39:08 INFO - Running post-run listener: _resource_record_post_run 09:39:08 INFO - Total resource usage - Wall time: 1195s; CPU: 53.0%; Read bytes: 1613824; Write bytes: 494618112; Read time: 10; Write time: 1559 09:39:08 INFO - TinderboxPrint: CPU usage
53.3% 09:39:08 INFO - TinderboxPrint: I/O read bytes / time
1,613,824 / 10 09:39:08 INFO - TinderboxPrint: I/O write bytes / time
494,618,112 / 1,559 09:39:08 INFO - TinderboxPrint: CPU idle
2,231.6 (46.7%) 09:39:08 INFO - TinderboxPrint: CPU system
955.0 (20.0%) 09:39:08 INFO - TinderboxPrint: CPU user
1,595.0 (33.4%) 09:39:08 INFO - TinderboxPrint: Swap in / out
196,435,968 / 0 09:39:08 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 196178432; Write bytes: 198682624; Read time: 17918; Write time: 446 09:39:08 INFO - run-tests - Wall time: 1174s; CPU: 53.0%; Read bytes: 696320; Write bytes: 294776320; Read time: 5; Write time: 1106 09:39:08 INFO - Running post-run listener: _upload_blobber_files 09:39:08 INFO - Blob upload gear active. 09:39:08 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:39:08 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 09:39:08 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'] 09:39:08 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 09:39:08 INFO - (blobuploader) - INFO - Open directory for files ... 09:39:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:39:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:39:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:39:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:39:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:39:09 INFO - (blobuploader) - INFO - Done attempting. 09:39:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:39:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:39:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:39:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:39:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:39:10 INFO - (blobuploader) - INFO - Done attempting. 09:39:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:39:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:39:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:39:13 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:39:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:39:13 INFO - (blobuploader) - INFO - Done attempting. 09:39:13 INFO - (blobuploader) - INFO - Iteration through files over. 09:39:13 INFO - Return code: 0 09:39:13 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:39:13 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:39:13 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/74b4a273a2e3d701976275ad9e2bcc104c45f2c39b5c7a63ddd569b4cf1f28b5d3eeaad6a631aa7b309f4de865f8b8e87ef5235e42add331249839da929e4344", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/bc0cce18dbbad1e9006e9f3fcb8387838caf4504749e5c24100f98dc33c60d52052042ca8ba7d514ae2c4214082f89b89dafb3afe3bde648ea4b5ca7ca1d114f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/73b803254625d13dbb66d52b83724358e667199a3b647ab88c9da14c3b5f32e57e54862994fabf8a4d1a7e32931ddb79ad3dbd4062998a10e5a3c14de2555102"} 09:39:13 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:39:13 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:39:13 INFO - Contents: 09:39:13 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/74b4a273a2e3d701976275ad9e2bcc104c45f2c39b5c7a63ddd569b4cf1f28b5d3eeaad6a631aa7b309f4de865f8b8e87ef5235e42add331249839da929e4344", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/bc0cce18dbbad1e9006e9f3fcb8387838caf4504749e5c24100f98dc33c60d52052042ca8ba7d514ae2c4214082f89b89dafb3afe3bde648ea4b5ca7ca1d114f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/73b803254625d13dbb66d52b83724358e667199a3b647ab88c9da14c3b5f32e57e54862994fabf8a4d1a7e32931ddb79ad3dbd4062998a10e5a3c14de2555102"} 09:39:13 INFO - Running post-run listener: copy_logs_to_upload_dir 09:39:13 INFO - Copying logs to upload dir... 09:39:13 INFO - mkdir: /builds/slave/test/build/upload/logs 09:39:13 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1253.183261 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2017-01-04 09:39:13.352193) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-04 09:39:13.355399) ========= 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.UisKHEU7VB/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.msKkbAvfu1/Listeners TMPDIR=/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/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/74b4a273a2e3d701976275ad9e2bcc104c45f2c39b5c7a63ddd569b4cf1f28b5d3eeaad6a631aa7b309f4de865f8b8e87ef5235e42add331249839da929e4344", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/bc0cce18dbbad1e9006e9f3fcb8387838caf4504749e5c24100f98dc33c60d52052042ca8ba7d514ae2c4214082f89b89dafb3afe3bde648ea4b5ca7ca1d114f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/73b803254625d13dbb66d52b83724358e667199a3b647ab88c9da14c3b5f32e57e54862994fabf8a4d1a7e32931ddb79ad3dbd4062998a10e5a3c14de2555102"} build_url:https://queue.taskcluster.net/v1/task/HCQJgrRxSjmD8wBQfUivxQ/artifacts/public/build/firefox-51.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011458 build_url: 'https://queue.taskcluster.net/v1/task/HCQJgrRxSjmD8wBQfUivxQ/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/74b4a273a2e3d701976275ad9e2bcc104c45f2c39b5c7a63ddd569b4cf1f28b5d3eeaad6a631aa7b309f4de865f8b8e87ef5235e42add331249839da929e4344", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/bc0cce18dbbad1e9006e9f3fcb8387838caf4504749e5c24100f98dc33c60d52052042ca8ba7d514ae2c4214082f89b89dafb3afe3bde648ea4b5ca7ca1d114f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/73b803254625d13dbb66d52b83724358e667199a3b647ab88c9da14c3b5f32e57e54862994fabf8a4d1a7e32931ddb79ad3dbd4062998a10e5a3c14de2555102"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-04 09:39:13.389627) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-04 09:39:13.389926) ========= 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.UisKHEU7VB/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.msKkbAvfu1/Listeners TMPDIR=/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/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.004809 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-04 09:39:13.437922) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-04 09:39:13.438248) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-04 09:39:13.438559) ========= ========= Total master_lag: 0.19 =========