builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0188 starttime: 1484003119.05 results: success (0) buildid: 20170109135208 builduid: 60e49a35e6b4492fa6fe2eb51b01b718 revision: adb88a603efb0efe74e23cd87066317bea2c82f7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-09 15:05:19.055165) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-09 15:05:19.055594) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-09 15:05:19.055876) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-09 15:05:19.081977) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-09 15:05:19.082249) ========= 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.8NJK9w26zb/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.OEBvZDg494/Listeners TMPDIR=/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/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-09 15:05:19-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 18.0M=0.001s 2017-01-09 15:05:19 (18.0 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.136048 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-09 15:05:19.242072) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-09 15:05:19.242383) ========= 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.8NJK9w26zb/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.OEBvZDg494/Listeners TMPDIR=/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/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.027140 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-09 15:05:19.290882) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-09 15:05:19.291193) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev adb88a603efb0efe74e23cd87066317bea2c82f7 --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 adb88a603efb0efe74e23cd87066317bea2c82f7 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.8NJK9w26zb/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.OEBvZDg494/Listeners TMPDIR=/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/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-09 15:05:19,385 truncating revision to first 12 chars 2017-01-09 15:05:19,385 Setting DEBUG logging. 2017-01-09 15:05:19,385 attempt 1/10 2017-01-09 15:05:19,385 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/adb88a603efb?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-09 15:05:20,881 unpacking tar archive at: mozilla-beta-adb88a603efb/testing/mozharness/ program finished with exit code 0 elapsedTime=1.775636 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-09 15:05:21.090110) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-09 15:05:21.090440) ========= script_repo_revision: adb88a603efb0efe74e23cd87066317bea2c82f7 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-09 15:05:21.090836) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-09 15:05:21.091102) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-09 15:05:21.111475) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2017-01-09 15:05:21.111888) ========= /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.8NJK9w26zb/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.OEBvZDg494/Listeners TMPDIR=/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/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 15:05:21 INFO - MultiFileLogger online at 20170109 15:05:21 in /builds/slave/test 15:05:21 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 15:05:21 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:05:21 INFO - {'append_to_log': False, 15:05:21 INFO - 'base_work_dir': '/builds/slave/test', 15:05:21 INFO - 'blob_upload_branch': 'Mozilla-Beta', 15:05:21 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:05:21 INFO - 'branch': 'Mozilla-Beta', 15:05:21 INFO - 'buildbot_json_path': 'buildprops.json', 15:05:21 INFO - 'config_files': ('talos/mac_config.py',), 15:05:21 INFO - 'default_actions': ('clobber', 15:05:21 INFO - 'read-buildbot-config', 15:05:21 INFO - 'download-and-extract', 15:05:21 INFO - 'populate-webroot', 15:05:21 INFO - 'create-virtualenv', 15:05:21 INFO - 'install', 15:05:21 INFO - 'run-tests'), 15:05:21 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:05:21 INFO - 'download_minidump_stackwalk': True, 15:05:21 INFO - 'download_symbols': 'ondemand', 15:05:21 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:05:21 INFO - 'tooltool.py': '/tools/tooltool.py', 15:05:21 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:05:21 INFO - '/tools/misc-python/virtualenv.py')}, 15:05:21 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:05:21 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:05:21 INFO - 'installer_path': 'installer.exe', 15:05:21 INFO - 'log_level': 'info', 15:05:21 INFO - 'log_name': 'talos', 15:05:21 INFO - 'log_to_console': True, 15:05:21 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 15:05:21 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 15:05:21 INFO - 'opt_config_files': (), 15:05:21 INFO - 'pip_index': False, 15:05:21 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:05:21 INFO - 'cmd': ('bash', 15:05:21 INFO - '-c', 15:05:21 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:05:21 INFO - 'enabled': True, 15:05:21 INFO - 'halt_on_failure': False, 15:05:21 INFO - 'name': 'check_screen_resolution'},), 15:05:21 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:05:21 INFO - 'cmd': ('bash', 15:05:21 INFO - '-c', 15:05:21 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:05:21 INFO - 'enabled': True, 15:05:21 INFO - 'halt_on_failure': False, 15:05:21 INFO - 'name': 'check_screen_resolution'},), 15:05:21 INFO - 'run_cmd_checks_enabled': True, 15:05:21 INFO - 'sps_profile': False, 15:05:21 INFO - 'sps_profile_interval': 0, 15:05:21 INFO - 'suite': 'dromaeojs', 15:05:21 INFO - 'system_bits': '32', 15:05:21 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:05:21 INFO - 'title': 't-yosemite-r7-0188', 15:05:21 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:05:21 INFO - 'use_talos_json': True, 15:05:21 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:05:21 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:05:21 INFO - 'work_dir': 'build'} 15:05:21 INFO - [mozharness: 2017-01-09 23:05:21.312877Z] Running clobber step. 15:05:21 INFO - Running pre-action listener: _resource_record_pre_action 15:05:21 INFO - Running main action method: clobber 15:05:21 INFO - rmtree: /builds/slave/test/build 15:05:21 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:05:23 INFO - Running post-action listener: _resource_record_post_action 15:05:23 INFO - [mozharness: 2017-01-09 23:05:23.830849Z] Finished clobber step (success) 15:05:23 INFO - [mozharness: 2017-01-09 23:05:23.830981Z] Running read-buildbot-config step. 15:05:23 INFO - Running pre-action listener: _resource_record_pre_action 15:05:23 INFO - Running main action method: read_buildbot_config 15:05:23 INFO - Using buildbot properties: 15:05:23 INFO - { 15:05:23 INFO - "project": "", 15:05:23 INFO - "product": "firefox", 15:05:23 INFO - "script_repo_revision": "production", 15:05:23 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 15:05:23 INFO - "repository": "", 15:05:23 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 15:05:23 INFO - "buildid": "20170109135208", 15:05:23 INFO - "pgo_build": "False", 15:05:23 INFO - "basedir": "/builds/slave/test", 15:05:23 INFO - "buildnumber": 0, 15:05:23 INFO - "slavename": "t-yosemite-r7-0188", 15:05:23 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 15:05:23 INFO - "platform": "yosemite_r7", 15:05:23 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 15:05:23 INFO - "branch": "mozilla-beta", 15:05:23 INFO - "repo_path": "releases/mozilla-beta", 15:05:23 INFO - "revision": "adb88a603efb0efe74e23cd87066317bea2c82f7", 15:05:23 INFO - "stage_platform": "macosx64", 15:05:23 INFO - "builduid": "60e49a35e6b4492fa6fe2eb51b01b718", 15:05:23 INFO - "slavebuilddir": "test" 15:05:23 INFO - } 15:05:23 INFO - Found installer url https://queue.taskcluster.net/v1/task/Wl-xMYITSXKUCQXPkTssxw/artifacts/public/build/firefox-51.0.en-US.mac.dmg. 15:05:23 INFO - Running post-action listener: _resource_record_post_action 15:05:23 INFO - [mozharness: 2017-01-09 23:05:23.834276Z] Finished read-buildbot-config step (success) 15:05:23 INFO - [mozharness: 2017-01-09 23:05:23.834404Z] Running download-and-extract step. 15:05:23 INFO - Running pre-action listener: _resource_record_pre_action 15:05:23 INFO - Running main action method: download_and_extract 15:05:23 INFO - mkdir: /builds/slave/test/build/tests 15:05:23 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')]} 15:05:23 INFO - trying https://queue.taskcluster.net/v1/task/Wl-xMYITSXKUCQXPkTssxw/artifacts/public/build/firefox-51.0.en-US.mac.test_packages.json 15:05:23 INFO - Downloading https://queue.taskcluster.net/v1/task/Wl-xMYITSXKUCQXPkTssxw/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 15:05:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Wl-xMYITSXKUCQXPkTssxw/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 15:05:24 INFO - Downloaded 1165 bytes. 15:05:24 INFO - Reading from file /builds/slave/test/build/firefox-51.0.en-US.mac.test_packages.json 15:05:24 INFO - Using the following test package requirements: 15:05:24 INFO - {u'common': [u'firefox-51.0.en-US.mac.common.tests.zip'], 15:05:24 INFO - u'cppunittest': [u'firefox-51.0.en-US.mac.common.tests.zip', 15:05:24 INFO - u'firefox-51.0.en-US.mac.cppunittest.tests.zip'], 15:05:24 INFO - u'gtest': [u'firefox-51.0.en-US.mac.common.tests.zip', 15:05:24 INFO - u'firefox-51.0.en-US.mac.gtest.tests.zip'], 15:05:24 INFO - u'jittest': [u'firefox-51.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 15:05:24 INFO - u'mochitest': [u'firefox-51.0.en-US.mac.common.tests.zip', 15:05:24 INFO - u'firefox-51.0.en-US.mac.mochitest.tests.zip'], 15:05:24 INFO - u'mozbase': [u'firefox-51.0.en-US.mac.common.tests.zip'], 15:05:24 INFO - u'reftest': [u'firefox-51.0.en-US.mac.common.tests.zip', 15:05:24 INFO - u'firefox-51.0.en-US.mac.reftest.tests.zip'], 15:05:24 INFO - u'talos': [u'firefox-51.0.en-US.mac.common.tests.zip', 15:05:24 INFO - u'firefox-51.0.en-US.mac.talos.tests.zip'], 15:05:24 INFO - u'web-platform': [u'firefox-51.0.en-US.mac.common.tests.zip', 15:05:24 INFO - u'firefox-51.0.en-US.mac.web-platform.tests.zip'], 15:05:24 INFO - u'xpcshell': [u'firefox-51.0.en-US.mac.common.tests.zip', 15:05:24 INFO - u'firefox-51.0.en-US.mac.xpcshell.tests.zip']} 15:05:24 INFO - Downloading packages: [u'firefox-51.0.en-US.mac.common.tests.zip'] for test suite category: common 15:05:24 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Wl-xMYITSXKUCQXPkTssxw/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip 15:05:24 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Wl-xMYITSXKUCQXPkTssxw/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip'}, attempt #1 15:05:24 INFO - Fetch https://queue.taskcluster.net/v1/task/Wl-xMYITSXKUCQXPkTssxw/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip into memory 15:05:25 INFO - Expected file size: 16234510 15:05:32 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 15:05:32 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Wl-xMYITSXKUCQXPkTssxw/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip 15:05:32 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Wl-xMYITSXKUCQXPkTssxw/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip'}, attempt #1 15:05:32 INFO - Fetch https://queue.taskcluster.net/v1/task/Wl-xMYITSXKUCQXPkTssxw/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip into memory 15:05:32 INFO - Expected file size: 16234510 15:05:39 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Wl-xMYITSXKUCQXPkTssxw/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip 15:05:39 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Wl-xMYITSXKUCQXPkTssxw/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip'}, attempt #1 15:05:39 INFO - Fetch https://queue.taskcluster.net/v1/task/Wl-xMYITSXKUCQXPkTssxw/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip into memory 15:05:40 INFO - Expected file size: 14414089 15:05:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:05:40 INFO - trying https://queue.taskcluster.net/v1/task/Wl-xMYITSXKUCQXPkTssxw/artifacts/public/build/firefox-51.0.en-US.mac.dmg 15:05:40 INFO - Downloading https://queue.taskcluster.net/v1/task/Wl-xMYITSXKUCQXPkTssxw/artifacts/public/build/firefox-51.0.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0.en-US.mac.dmg 15:05:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Wl-xMYITSXKUCQXPkTssxw/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 15:05:43 INFO - Downloaded 86148282 bytes. 15:05:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Wl-xMYITSXKUCQXPkTssxw/artifacts/public/build/firefox-51.0.en-US.mac.dmg 15:05:43 INFO - mkdir: /builds/slave/test/properties 15:05:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:05:43 INFO - Writing to file /builds/slave/test/properties/build_url 15:05:43 INFO - Contents: 15:05:43 INFO - build_url:https://queue.taskcluster.net/v1/task/Wl-xMYITSXKUCQXPkTssxw/artifacts/public/build/firefox-51.0.en-US.mac.dmg 15:05:44 INFO - Running post-action listener: _resource_record_post_action 15:05:44 INFO - Running post-action listener: set_extra_try_arguments 15:05:44 INFO - [mozharness: 2017-01-09 23:05:44.108724Z] Finished download-and-extract step (success) 15:05:44 INFO - [mozharness: 2017-01-09 23:05:44.108842Z] Running populate-webroot step. 15:05:44 INFO - Running pre-action listener: _resource_record_pre_action 15:05:44 INFO - Running main action method: populate_webroot 15:05:44 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:05:44 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:05:44 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:05:44 INFO - '--tppagecycles', 15:05:44 INFO - '7'], 15:05:44 INFO - 'tests': ['tsvgm']}}, 15:05:44 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:05:44 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:05:44 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:05:44 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:05:44 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:05:44 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:05:44 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:05:44 INFO - 'talos_options': ['--disable-e10s'], 15:05:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:05:44 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:05:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:05:44 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:05:44 INFO - 'talos_options': ['--disable-e10s'], 15:05:44 INFO - 'tests': ['damp', 'tps']}, 15:05:44 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:05:44 INFO - 'tests': ['damp', 'tps']}, 15:05:44 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:05:44 INFO - 'tests': ['dromaeo_dom']}, 15:05:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:05:44 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:05:44 INFO - 'tests': ['basic_compositor_video']}, 15:05:44 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:05:44 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:05:44 INFO - 'tests': ['a11yr', 15:05:44 INFO - 'ts_paint', 15:05:44 INFO - 'tpaint', 15:05:44 INFO - 'sessionrestore', 15:05:44 INFO - 'sessionrestore_no_auto_restore', 15:05:44 INFO - 'tabpaint']}, 15:05:44 INFO - 'other-e10s': {'tests': ['a11yr', 15:05:44 INFO - 'ts_paint', 15:05:44 INFO - 'tpaint', 15:05:44 INFO - 'sessionrestore', 15:05:44 INFO - 'sessionrestore_no_auto_restore', 15:05:44 INFO - 'tabpaint']}, 15:05:44 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:05:44 INFO - 'ts_paint', 15:05:44 INFO - 'tpaint', 15:05:44 INFO - 'sessionrestore', 15:05:44 INFO - 'sessionrestore_no_auto_restore', 15:05:44 INFO - 'tabpaint']}, 15:05:44 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:05:44 INFO - 'ts_paint', 15:05:44 INFO - 'tpaint', 15:05:44 INFO - 'sessionrestore', 15:05:44 INFO - 'sessionrestore_no_auto_restore', 15:05:44 INFO - 'tabpaint']}, 15:05:44 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:05:44 INFO - 'tests': ['a11yr', 15:05:44 INFO - 'ts_paint', 15:05:44 INFO - 'tpaint', 15:05:44 INFO - 'sessionrestore', 15:05:44 INFO - 'sessionrestore_no_auto_restore', 15:05:44 INFO - 'tabpaint']}, 15:05:44 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:05:44 INFO - 'tests': ['a11yr', 15:05:44 INFO - 'ts_paint', 15:05:44 INFO - 'tpaint', 15:05:44 INFO - 'sessionrestore', 15:05:44 INFO - 'sessionrestore_no_auto_restore', 15:05:44 INFO - 'tabpaint']}, 15:05:44 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:05:44 INFO - 'tests': ['tsvgx', 15:05:44 INFO - 'tsvgr_opacity', 15:05:44 INFO - 'tart', 15:05:44 INFO - 'tscrollx', 15:05:44 INFO - 'cart']}, 15:05:44 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:05:44 INFO - 'tsvgr_opacity', 15:05:44 INFO - 'tart', 15:05:44 INFO - 'tscrollx', 15:05:44 INFO - 'cart']}, 15:05:44 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:05:44 INFO - 'talos_options': ['--disable-e10s'], 15:05:44 INFO - 'tests': ['tp5o']}, 15:05:44 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:05:44 INFO - 'tests': ['tp5o']}, 15:05:44 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:05:44 INFO - 'talos_options': ['--disable-e10s', 15:05:44 INFO - '--xperf_path', 15:05:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:05:44 INFO - 'tests': ['tp5n']}, 15:05:44 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:05:44 INFO - 'talos_options': ['--xperf_path', 15:05:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:05:44 INFO - 'tests': ['tp5n']}}, 15:05:44 INFO - 'talos.zip': {'path': '', 15:05:44 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:05:44 INFO - Running post-action listener: _resource_record_post_action 15:05:44 INFO - [mozharness: 2017-01-09 23:05:44.126234Z] Finished populate-webroot step (success) 15:05:44 INFO - [mozharness: 2017-01-09 23:05:44.126331Z] Running create-virtualenv step. 15:05:44 INFO - Running pre-action listener: _resource_record_pre_action 15:05:44 INFO - Running main action method: create_virtualenv 15:05:44 INFO - Creating virtualenv /builds/slave/test/build/venv 15:05:44 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 15:05:44 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:05:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:05:44 INFO - Using real prefix '/tools/python27' 15:05:44 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:05:44 INFO - Installing distribute.............................................................................................................................................................................................done. 15:05:47 INFO - Installing pip.................done. 15:05:47 INFO - Return code: 0 15:05:47 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:05:47 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')]} 15:05:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:05:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:05:47 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')]} 15:05:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:05:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:05:47 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 0x10fd77490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fced570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95bad7df20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fb8bd30>, '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 0x10f9f1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fb83b20>, '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.8NJK9w26zb/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.OEBvZDg494/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/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 15:05:47 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 15:05:47 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 15:05:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8NJK9w26zb/Render', 15:05:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:05:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:05:47 INFO - 'HOME': '/Users/cltbld', 15:05:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:05:47 INFO - 'LOGNAME': 'cltbld', 15:05:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:05:47 INFO - 'MOZ_NO_REMOTE': '1', 15:05:47 INFO - 'NO_EM_RESTART': '1', 15:05:47 INFO - 'PAGER': '/bin/cat', 15:05:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:05:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:05:47 INFO - 'PWD': '/builds/slave/test', 15:05:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:05:47 INFO - 'SHELL': '/bin/bash', 15:05:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OEBvZDg494/Listeners', 15:05:47 INFO - 'TMPDIR': '/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/', 15:05:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:05:47 INFO - 'USER': 'cltbld', 15:05:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:05:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:05:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:05:47 INFO - 'XPC_FLAGS': '0x0', 15:05:47 INFO - 'XPC_SERVICE_NAME': '0', 15:05:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:05:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:05:48 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 15:05:48 INFO - Cleaning up... 15:05:48 INFO - Return code: 0 15:05:48 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:05: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')]} 15:05:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:05:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:05: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')]} 15:05:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:05:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:05: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', '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 0x10fd77490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fced570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95bad7df20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fb8bd30>, '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 0x10f9f1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fb83b20>, '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.8NJK9w26zb/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.OEBvZDg494/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/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 15:05: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', 'psutil>=3.1.1'] in /builds/slave/test/build 15:05: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 psutil>=3.1.1 15:05:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8NJK9w26zb/Render', 15:05:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:05:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:05:48 INFO - 'HOME': '/Users/cltbld', 15:05:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:05:48 INFO - 'LOGNAME': 'cltbld', 15:05:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:05:48 INFO - 'MOZ_NO_REMOTE': '1', 15:05:48 INFO - 'NO_EM_RESTART': '1', 15:05:48 INFO - 'PAGER': '/bin/cat', 15:05:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:05:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:05:48 INFO - 'PWD': '/builds/slave/test', 15:05:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:05:48 INFO - 'SHELL': '/bin/bash', 15:05:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OEBvZDg494/Listeners', 15:05:48 INFO - 'TMPDIR': '/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/', 15:05:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:05:48 INFO - 'USER': 'cltbld', 15:05:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:05:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:05:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:05:48 INFO - 'XPC_FLAGS': '0x0', 15:05:48 INFO - 'XPC_SERVICE_NAME': '0', 15:05:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:05:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:05:48 INFO - Downloading/unpacking psutil>=3.1.1 15:05:48 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 15:05:48 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 15:05:48 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 15:05:48 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 15:05:48 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 15:05:48 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 15:05:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:05:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:05:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:05:51 INFO - Installing collected packages: psutil 15:05:51 INFO - Running setup.py install for psutil 15:05:51 INFO - building 'psutil._psutil_osx' extension 15:05:51 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 15:05:52 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 15:05:52 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 15:05:52 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 15:05:52 INFO - building 'psutil._psutil_posix' extension 15:05:52 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 15:05:52 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 15:05:52 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 15:05:52 INFO - ^ 15:05:52 INFO - 1 warning generated. 15:05:52 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 15:05:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:05:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:05:52 INFO - Successfully installed psutil 15:05:52 INFO - Cleaning up... 15:05:53 INFO - Return code: 0 15:05:53 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:05:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:05:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:05:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:05:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:05:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:05:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:05:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10fd77490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fced570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95bad7df20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fb8bd30>, '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 0x10f9f1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fb83b20>, '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.8NJK9w26zb/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.OEBvZDg494/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/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 15:05:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 15:05:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 15:05:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8NJK9w26zb/Render', 15:05:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:05:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:05:53 INFO - 'HOME': '/Users/cltbld', 15:05:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:05:53 INFO - 'LOGNAME': 'cltbld', 15:05:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:05:53 INFO - 'MOZ_NO_REMOTE': '1', 15:05:53 INFO - 'NO_EM_RESTART': '1', 15:05:53 INFO - 'PAGER': '/bin/cat', 15:05:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:05:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:05:53 INFO - 'PWD': '/builds/slave/test', 15:05:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:05:53 INFO - 'SHELL': '/bin/bash', 15:05:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OEBvZDg494/Listeners', 15:05:53 INFO - 'TMPDIR': '/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/', 15:05:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:05:53 INFO - 'USER': 'cltbld', 15:05:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:05:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:05:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:05:53 INFO - 'XPC_FLAGS': '0x0', 15:05:53 INFO - 'XPC_SERVICE_NAME': '0', 15:05:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:05:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:05:53 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:05:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:05:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:05:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:05:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:05:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:05:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:05:55 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:05:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:05:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:05:55 INFO - Installing collected packages: mozsystemmonitor 15:05:55 INFO - Running setup.py install for mozsystemmonitor 15:05:56 INFO - Successfully installed mozsystemmonitor 15:05:56 INFO - Cleaning up... 15:05:56 INFO - Return code: 0 15:05:56 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:05: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')]} 15:05:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:05:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:05: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')]} 15:05:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:05:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:05: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', '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 0x10fd77490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fced570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95bad7df20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fb8bd30>, '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 0x10f9f1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fb83b20>, '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.8NJK9w26zb/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.OEBvZDg494/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/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 15:05: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 15:05: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 jsonschema==2.5.1 15:05:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8NJK9w26zb/Render', 15:05:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:05:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:05:56 INFO - 'HOME': '/Users/cltbld', 15:05:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:05:56 INFO - 'LOGNAME': 'cltbld', 15:05:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:05:56 INFO - 'MOZ_NO_REMOTE': '1', 15:05:56 INFO - 'NO_EM_RESTART': '1', 15:05:56 INFO - 'PAGER': '/bin/cat', 15:05:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:05:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:05:56 INFO - 'PWD': '/builds/slave/test', 15:05:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:05:56 INFO - 'SHELL': '/bin/bash', 15:05:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OEBvZDg494/Listeners', 15:05:56 INFO - 'TMPDIR': '/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/', 15:05:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:05:56 INFO - 'USER': 'cltbld', 15:05:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:05:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:05:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:05:56 INFO - 'XPC_FLAGS': '0x0', 15:05:56 INFO - 'XPC_SERVICE_NAME': '0', 15:05:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:05:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:05:56 INFO - Downloading/unpacking jsonschema==2.5.1 15:05: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 15:05: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 15:05: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 15:05: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 15:05: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 15:05: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 15:05:59 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:05:59 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:05: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 15:05: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 15:05: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 15:05: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 15:05: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 15:05: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 15:05:59 INFO - Downloading functools32-3.2.3-2.tar.gz 15:05:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:05:59 INFO - warning: no files found matching '*.txt' 15:05:59 INFO - no previously-included directories found matching 'build' 15:05:59 INFO - no previously-included directories found matching 'dist' 15:05:59 INFO - no previously-included directories found matching '.git*' 15:05:59 INFO - Installing collected packages: jsonschema, functools32 15:05:59 INFO - Running setup.py install for functools32 15:05:59 INFO - warning: no files found matching '*.txt' 15:05:59 INFO - no previously-included directories found matching 'build' 15:05:59 INFO - no previously-included directories found matching 'dist' 15:05:59 INFO - no previously-included directories found matching '.git*' 15:05:59 INFO - Successfully installed jsonschema functools32 15:05:59 INFO - Cleaning up... 15:05:59 INFO - Return code: 0 15:05:59 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:05:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:05:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:05:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:05:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:05:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:05:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:05:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10fd77490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fced570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95bad7df20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fb8bd30>, '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 0x10f9f1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fb83b20>, '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.8NJK9w26zb/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.OEBvZDg494/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/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 15:05:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 15:05:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 15:05:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8NJK9w26zb/Render', 15:05:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:05:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:05:59 INFO - 'HOME': '/Users/cltbld', 15:05:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:05:59 INFO - 'LOGNAME': 'cltbld', 15:05:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:05:59 INFO - 'MOZ_NO_REMOTE': '1', 15:05:59 INFO - 'NO_EM_RESTART': '1', 15:05:59 INFO - 'PAGER': '/bin/cat', 15:05:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:05:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:05:59 INFO - 'PWD': '/builds/slave/test', 15:05:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:05:59 INFO - 'SHELL': '/bin/bash', 15:05:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OEBvZDg494/Listeners', 15:05:59 INFO - 'TMPDIR': '/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/', 15:05:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:05:59 INFO - 'USER': 'cltbld', 15:05:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:05:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:05:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:05:59 INFO - 'XPC_FLAGS': '0x0', 15:05:59 INFO - 'XPC_SERVICE_NAME': '0', 15:05:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:06:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:06:00 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:06:00 INFO - Cleaning up... 15:06:00 INFO - Return code: 0 15:06:00 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:06:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:06:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:06:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:06:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:06:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:06:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:06:00 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 0x10fd77490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fced570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95bad7df20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fb8bd30>, '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 0x10f9f1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fb83b20>, '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.8NJK9w26zb/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.OEBvZDg494/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/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 15:06:00 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 15:06:00 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 15:06:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8NJK9w26zb/Render', 15:06:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:06:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:06:00 INFO - 'HOME': '/Users/cltbld', 15:06:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:06:00 INFO - 'LOGNAME': 'cltbld', 15:06:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:06:00 INFO - 'MOZ_NO_REMOTE': '1', 15:06:00 INFO - 'NO_EM_RESTART': '1', 15:06:00 INFO - 'PAGER': '/bin/cat', 15:06:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:06:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:06:00 INFO - 'PWD': '/builds/slave/test', 15:06:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:06:00 INFO - 'SHELL': '/bin/bash', 15:06:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OEBvZDg494/Listeners', 15:06:00 INFO - 'TMPDIR': '/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/', 15:06:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:06:00 INFO - 'USER': 'cltbld', 15:06:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:06:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:06:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:06:00 INFO - 'XPC_FLAGS': '0x0', 15:06:00 INFO - 'XPC_SERVICE_NAME': '0', 15:06:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:06:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:06:00 INFO - Downloading/unpacking blobuploader==1.2.4 15:06:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:06:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:06:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:06:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:06:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:06:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:06:03 INFO - Downloading blobuploader-1.2.4.tar.gz 15:06:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:06:03 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:06:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:06:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:06:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:06:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:06:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:06:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:06:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:06:03 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:06:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:06:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:06:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:06:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:06:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:06:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:06:04 INFO - Downloading docopt-0.6.1.tar.gz 15:06:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:06:04 INFO - Installing collected packages: blobuploader, requests, docopt 15:06:04 INFO - Running setup.py install for blobuploader 15:06:04 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:06:04 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:06:04 INFO - Running setup.py install for requests 15:06:05 INFO - Running setup.py install for docopt 15:06:05 INFO - Successfully installed blobuploader requests docopt 15:06:05 INFO - Cleaning up... 15:06:05 INFO - Return code: 0 15:06:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:06: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')]} 15:06:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:06:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:06: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')]} 15:06:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:06:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:06:05 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 0x10fd77490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fced570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95bad7df20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fb8bd30>, '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 0x10f9f1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fb83b20>, '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.8NJK9w26zb/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.OEBvZDg494/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/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 15:06:05 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 15:06:05 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 15:06:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8NJK9w26zb/Render', 15:06:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:06:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:06:05 INFO - 'HOME': '/Users/cltbld', 15:06:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:06:05 INFO - 'LOGNAME': 'cltbld', 15:06:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:06:05 INFO - 'MOZ_NO_REMOTE': '1', 15:06:05 INFO - 'NO_EM_RESTART': '1', 15:06:05 INFO - 'PAGER': '/bin/cat', 15:06:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:06:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:06:05 INFO - 'PWD': '/builds/slave/test', 15:06:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:06:05 INFO - 'SHELL': '/bin/bash', 15:06:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OEBvZDg494/Listeners', 15:06:05 INFO - 'TMPDIR': '/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/', 15:06:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:06:05 INFO - 'USER': 'cltbld', 15:06:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:06:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:06:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:06:05 INFO - 'XPC_FLAGS': '0x0', 15:06:05 INFO - 'XPC_SERVICE_NAME': '0', 15:06:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:06:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:06:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:06:05 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-jDc4Tf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:06:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:06:05 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-0YRaDG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:06:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:06:05 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-3DYY5d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:06:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:06:05 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-XP7rGe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:06:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:06:06 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-3KXLya-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:06:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:06:06 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-aa7u5u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:06:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:06:06 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-yIqVgp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:06:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:06:06 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-8V3uhU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:06:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:06:06 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-m4kpyH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:06:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:06:06 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-CZkkWH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:06:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:06:06 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-eK_bUn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:06:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:06:06 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-0CY6dq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:06:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:06:06 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-sj04EH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:06:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:06:07 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-VhABPQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:06:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:06:07 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-fQYDVZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:06:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:06:07 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-mkwbS5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:06:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:06:07 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-bcUJi9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:06:07 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:06:07 INFO - Running setup.py install for manifestparser 15:06:07 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:06:07 INFO - Running setup.py install for mozcrash 15:06:07 INFO - Running setup.py install for mozdebug 15:06:07 INFO - Running setup.py install for mozdevice 15:06:08 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:06:08 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:06:08 INFO - Running setup.py install for mozfile 15:06:08 INFO - Running setup.py install for mozhttpd 15:06:08 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:06:08 INFO - Running setup.py install for mozinfo 15:06:08 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:06:08 INFO - Running setup.py install for mozInstall 15:06:08 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:06:08 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:06:08 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:06:08 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:06:08 INFO - Running setup.py install for mozleak 15:06:08 INFO - Running setup.py install for mozlog 15:06:08 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:06:08 INFO - Running setup.py install for moznetwork 15:06:09 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:06:09 INFO - Running setup.py install for mozprocess 15:06:09 INFO - Running setup.py install for mozprofile 15:06:09 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:06:09 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:06:09 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:06:09 INFO - Running setup.py install for mozrunner 15:06:09 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:06:09 INFO - Running setup.py install for mozscreenshot 15:06:09 INFO - Running setup.py install for moztest 15:06:09 INFO - Running setup.py install for mozversion 15:06:09 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:06:09 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:06:09 INFO - Cleaning up... 15:06:09 INFO - Return code: 0 15:06:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:06:09 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')]} 15:06:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:06:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:06:09 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')]} 15:06:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:06:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:06:09 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 0x10fd77490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fced570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95bad7df20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fb8bd30>, '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 0x10f9f1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fb83b20>, '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.8NJK9w26zb/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.OEBvZDg494/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/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 15:06:09 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 15:06:09 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 15:06:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8NJK9w26zb/Render', 15:06:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:06:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:06:09 INFO - 'HOME': '/Users/cltbld', 15:06:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:06:09 INFO - 'LOGNAME': 'cltbld', 15:06:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:06:09 INFO - 'MOZ_NO_REMOTE': '1', 15:06:09 INFO - 'NO_EM_RESTART': '1', 15:06:09 INFO - 'PAGER': '/bin/cat', 15:06:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:06:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:06:09 INFO - 'PWD': '/builds/slave/test', 15:06:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:06:09 INFO - 'SHELL': '/bin/bash', 15:06:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OEBvZDg494/Listeners', 15:06:09 INFO - 'TMPDIR': '/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/', 15:06:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:06:09 INFO - 'USER': 'cltbld', 15:06:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:06:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:06:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:06:09 INFO - 'XPC_FLAGS': '0x0', 15:06:09 INFO - 'XPC_SERVICE_NAME': '0', 15:06:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:06:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:06:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:06:10 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-lS2sMv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:06:10 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)) 15:06:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:06:10 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-5M2Y8s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:06:10 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)) 15:06:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:06:10 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-5tKAm6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:06:10 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)) 15:06:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:06:10 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-ExBGBR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:06:10 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)) 15:06:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:06:10 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-IWdcmO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:06:10 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)) 15:06:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:06:10 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-MkbwcI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:06:10 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)) 15:06:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:06:10 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-pd0W1m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:06:10 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)) 15:06:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:06:10 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-7KCT4h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:06:11 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)) 15:06:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:06:11 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-QrCIJO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:06:11 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)) 15:06:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:06:11 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-JpZNJj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:06:11 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)) 15:06:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:06:11 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-ThfpH8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:06:11 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)) 15:06:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:06:11 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-dUEiiD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:06:11 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)) 15:06:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:06:11 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-uVoqK9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:06:11 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)) 15:06:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:06:11 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-8GBo2l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:06:11 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)) 15:06:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:06:11 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-mbkOm4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:06:11 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)) 15:06:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:06:11 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-GAMbvq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:06:11 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)) 15:06:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:06:11 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-0YrbTL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:06:12 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)) 15:06:12 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)) 15:06:12 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)) 15:06:12 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)) 15:06:12 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)) 15:06:12 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)) 15:06:12 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:06:12 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 15:06:12 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 15:06:12 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 15:06:12 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 15:06:12 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 15:06:12 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 15:06:14 INFO - Downloading blessings-1.6.tar.gz 15:06:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:06:14 INFO - Installing collected packages: blessings 15:06:14 INFO - Running setup.py install for blessings 15:06:14 INFO - Successfully installed blessings 15:06:14 INFO - Cleaning up... 15:06:15 INFO - Return code: 0 15:06:15 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:06:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:06:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:06:15 INFO - Reading from file tmpfile_stdout 15:06:15 INFO - Current package versions: 15:06:15 INFO - blessings == 1.6 15:06:15 INFO - blobuploader == 1.2.4 15:06:15 INFO - docopt == 0.6.1 15:06:15 INFO - functools32 == 3.2.3-2 15:06:15 INFO - jsonschema == 2.5.1 15:06:15 INFO - manifestparser == 1.1 15:06:15 INFO - mozInstall == 1.12 15:06:15 INFO - mozcrash == 0.17 15:06:15 INFO - mozdebug == 0.1 15:06:15 INFO - mozdevice == 0.48 15:06:15 INFO - mozfile == 1.2 15:06:15 INFO - mozhttpd == 0.7 15:06:15 INFO - mozinfo == 0.9 15:06:15 INFO - mozleak == 0.1 15:06:15 INFO - mozlog == 3.4 15:06:15 INFO - moznetwork == 0.27 15:06:15 INFO - mozprocess == 0.23 15:06:15 INFO - mozprofile == 0.28 15:06:15 INFO - mozrunner == 6.12 15:06:15 INFO - mozscreenshot == 0.1 15:06:15 INFO - mozsystemmonitor == 0.3 15:06:15 INFO - moztest == 0.7 15:06:15 INFO - mozversion == 1.4 15:06:15 INFO - psutil == 3.1.1 15:06:15 INFO - requests == 1.2.3 15:06:15 INFO - wsgiref == 0.1.2 15:06:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:06:15 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')]} 15:06:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:06:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:06:15 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')]} 15:06:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:06:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:06:15 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 0x10fd77490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fced570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95bad7df20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fb8bd30>, '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 0x10f9f1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fb83b20>, '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.8NJK9w26zb/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.OEBvZDg494/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/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 15:06:15 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 15:06:15 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 15:06:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8NJK9w26zb/Render', 15:06:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:06:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:06:15 INFO - 'HOME': '/Users/cltbld', 15:06:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:06:15 INFO - 'LOGNAME': 'cltbld', 15:06:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:06:15 INFO - 'MOZ_NO_REMOTE': '1', 15:06:15 INFO - 'NO_EM_RESTART': '1', 15:06:15 INFO - 'PAGER': '/bin/cat', 15:06:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:06:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:06:15 INFO - 'PWD': '/builds/slave/test', 15:06:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:06:15 INFO - 'SHELL': '/bin/bash', 15:06:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OEBvZDg494/Listeners', 15:06:15 INFO - 'TMPDIR': '/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/', 15:06:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:06:15 INFO - 'USER': 'cltbld', 15:06:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:06:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:06:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:06:15 INFO - 'XPC_FLAGS': '0x0', 15:06:15 INFO - 'XPC_SERVICE_NAME': '0', 15:06:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:06:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:06:15 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)) 15:06:15 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)) 15:06:15 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)) 15:06:15 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)) 15:06:15 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)) 15:06:15 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)) 15:06:15 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)) 15:06:15 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)) 15:06:15 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)) 15:06:15 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)) 15:06:15 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)) 15:06:15 INFO - Cleaning up... 15:06:15 INFO - Return code: 0 15:06:15 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:06:15 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')]} 15:06:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:06:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:06:15 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')]} 15:06:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:06:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:06:15 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 0x10fd77490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fced570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95bad7df20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fb8bd30>, '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 0x10f9f1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fb83b20>, '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.8NJK9w26zb/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.OEBvZDg494/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/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 15:06:15 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 15:06:15 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 15:06:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8NJK9w26zb/Render', 15:06:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:06:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:06:15 INFO - 'HOME': '/Users/cltbld', 15:06:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:06:15 INFO - 'LOGNAME': 'cltbld', 15:06:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:06:15 INFO - 'MOZ_NO_REMOTE': '1', 15:06:15 INFO - 'NO_EM_RESTART': '1', 15:06:15 INFO - 'PAGER': '/bin/cat', 15:06:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:06:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:06:15 INFO - 'PWD': '/builds/slave/test', 15:06:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:06:15 INFO - 'SHELL': '/bin/bash', 15:06:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OEBvZDg494/Listeners', 15:06:15 INFO - 'TMPDIR': '/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/', 15:06:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:06:15 INFO - 'USER': 'cltbld', 15:06:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:06:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:06:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:06:15 INFO - 'XPC_FLAGS': '0x0', 15:06:15 INFO - 'XPC_SERVICE_NAME': '0', 15:06:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:06:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:06:16 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:06:16 INFO - Cleaning up... 15:06:16 INFO - Return code: 0 15:06:16 INFO - Running post-action listener: _resource_record_post_action 15:06:16 INFO - Running post-action listener: _start_resource_monitoring 15:06:16 INFO - Starting resource monitoring. 15:06:16 INFO - [mozharness: 2017-01-09 23:06:16.246649Z] Finished create-virtualenv step (success) 15:06:16 INFO - [mozharness: 2017-01-09 23:06:16.247638Z] Running install step. 15:06:16 INFO - Running pre-action listener: _resource_record_pre_action 15:06:16 INFO - Running main action method: install 15:06:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:06:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:06:16 INFO - Reading from file tmpfile_stdout 15:06:16 INFO - Detecting whether we're running mozinstall >=1.0... 15:06:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:06:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:06:16 INFO - Reading from file tmpfile_stdout 15:06:16 INFO - Output received: 15:06:16 INFO - Usage: mozinstall [options] installer 15:06:16 INFO - Options: 15:06:16 INFO - -h, --help show this help message and exit 15:06:16 INFO - -d DEST, --destination=DEST 15:06:16 INFO - Directory to install application into. [default: 15:06:16 INFO - "/builds/slave/test"] 15:06:16 INFO - --app=APP Application being installed. [default: firefox] 15:06:16 INFO - mkdir: /builds/slave/test/build/application 15:06:16 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'] 15:06:16 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 15:06:38 INFO - Reading from file tmpfile_stdout 15:06:38 INFO - Output received: 15:06:38 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 15:06:38 INFO - Running post-action listener: _resource_record_post_action 15:06:38 INFO - [mozharness: 2017-01-09 23:06:38.557558Z] Finished install step (success) 15:06:38 INFO - [mozharness: 2017-01-09 23:06:38.557711Z] Running run-tests step. 15:06:38 INFO - Running pre-action listener: _resource_record_pre_action 15:06:38 INFO - Running main action method: run_tests 15:06:38 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:06:38 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:06:38 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:06:38 INFO - 2017-01-09 15:06:38.572 screenresolution[1621:7483] starting screenresolution argv=screenresolution get 15:06:38 INFO - 2017-01-09 15:06:38.574 screenresolution[1621:7483] Display 0: 1600x1200x32@60 15:06:38 INFO - 2017-01-09 15:06:38.580 screenresolution[1622:7486] starting screenresolution argv=screenresolution list 15:06:38 INFO - Available Modes on Display 0 15:06:38 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:06:38 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:06:38 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:06:38 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:06:38 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:06:38 INFO - Intel Iris: 15:06:38 INFO - Chipset Model: Intel Iris 15:06:38 INFO - Type: GPU 15:06:38 INFO - Bus: Built-In 15:06:38 INFO - VRAM (Dynamic, Max): 1536 MB 15:06:38 INFO - Vendor: Intel (0x8086) 15:06:38 INFO - Device ID: 0x0a2e 15:06:38 INFO - Revision ID: 0x0009 15:06:38 INFO - Displays: 15:06:38 INFO - Display: 15:06:38 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:06:38 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:06:38 INFO - Display Serial Number: 1600x1200 60 15:06:38 INFO - Main Display: Yes 15:06:38 INFO - Mirror: Off 15:06:38 INFO - Online: Yes 15:06:38 INFO - Rotation: Supported 15:06:38 INFO - Return code: 0 15:06:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:06:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:06:38 INFO - Python 2.7.3 15:06:38 INFO - Return code: 0 15:06:38 INFO - grabbing minidump binary from tooltool 15:06:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:06:38 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 0x10fb8bd30>, '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 0x10f9f1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fb83b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:06:38 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 15:06:38 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 15:06:38 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 15:06:38 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:06:38 INFO - Return code: 0 15:06:38 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 15:06:38 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:06:38 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:06:38 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 15:06:38 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:06:38 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/Wl-xMYITSXKUCQXPkTssxw/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0188', '--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 15:06:38 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/Wl-xMYITSXKUCQXPkTssxw/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0188 --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 15:06:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8NJK9w26zb/Render', 15:06:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:06:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:06:38 INFO - 'HOME': '/Users/cltbld', 15:06:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:06:38 INFO - 'LOGNAME': 'cltbld', 15:06:38 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:06:38 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 15:06:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:06:38 INFO - 'MOZ_NO_REMOTE': '1', 15:06:38 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:06:38 INFO - 'NO_EM_RESTART': '1', 15:06:38 INFO - 'PAGER': '/bin/cat', 15:06:38 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:06:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:06:38 INFO - 'PWD': '/builds/slave/test', 15:06:38 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:06:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:06:38 INFO - 'SHELL': '/bin/bash', 15:06:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OEBvZDg494/Listeners', 15:06:38 INFO - 'TMPDIR': '/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/', 15:06:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:06:38 INFO - 'USER': 'cltbld', 15:06:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:06:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:06:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:06:38 INFO - 'XPC_FLAGS': '0x0', 15:06:38 INFO - 'XPC_SERVICE_NAME': '0', 15:06:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:06:38 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/Wl-xMYITSXKUCQXPkTssxw/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0188', '--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 15:06:39 INFO - mozversion application_buildid: 20170109135208 15:06:39 INFO - mozversion application_changeset: adb88a603efb0efe74e23cd87066317bea2c82f7 15:06:39 INFO - mozversion application_display_name: Firefox 15:06:39 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:06:39 INFO - mozversion application_name: Firefox 15:06:39 INFO - mozversion application_remotingname: firefox 15:06:39 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 15:06:39 INFO - mozversion application_vendor: Mozilla 15:06:39 INFO - mozversion application_version: 51.0 15:06:39 INFO - mozversion platform_buildid: 20170109135208 15:06:39 INFO - mozversion platform_changeset: adb88a603efb0efe74e23cd87066317bea2c82f7 15:06:39 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 15:06:39 INFO - mozversion platform_version: 51.0 15:06:39 INFO - using testdate: 1484003199 15:06:39 INFO - actual date: 1484003199 15:06:39 INFO - starting webserver on 'localhost:49241' 15:06:39 INFO - SUITE-START | Running 2 tests 15:06:39 INFO - TEST-START | dromaeo_css 15:06:39 INFO - operating with platform_type : mac_ 15:06:39 INFO - Initialising browser for dromaeo_css test... 15:06:39 INFO - TEST-INFO | started process 1632 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/tmpOGoIKL/profile http://localhost:49241/getInfo.html) 15:06:41 INFO - PROCESS | 1632 | __metrics Screen width/height:1600/1200 15:06:41 INFO - PROCESS | 1632 | colorDepth:24 15:06:41 INFO - PROCESS | 1632 | Browser inner width/height: 1024/689 15:06:41 INFO - PROCESS | 1632 | __metrics 15:06:41 INFO - PROCESS | 1632 | 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" 15:06:41 INFO - PROCESS | 1632 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:06:42 INFO - TEST-INFO | 1632: exit 0 15:06:42 INFO - Browser initialized. 15:06:42 INFO - Running cycle 1/1 for dromaeo_css test... 15:06:42 INFO - TEST-INFO | started process 1635 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/tmpOGoIKL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:06:54 INFO - PROCESS | 1635 | RSS: Main: 169070592 15:06:54 INFO - PROCESS | 1635 | 15:07:45 INFO - PROCESS | 1635 | 1484003265924 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] 15:09:55 INFO - PROCESS | 1635 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49241/tests/dromaeo/cssquery-ext.html) 15:09:57 INFO - PROCESS | 1635 | RSS: Main: 322445312 15:09:57 INFO - PROCESS | 1635 | 15:13:00 INFO - PROCESS | 1635 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-ext.html (next: http://localhost:49241/tests/dromaeo/cssquery-jquery.html) 15:13:00 INFO - PROCESS | 1635 | RSS: Main: 304099328 15:13:00 INFO - PROCESS | 1635 | 15:16:03 INFO - PROCESS | 1635 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49241/tests/dromaeo/cssquery-mootools.html) 15:16:03 INFO - PROCESS | 1635 | RSS: Main: 303882240 15:16:03 INFO - PROCESS | 1635 | 15:19:05 INFO - PROCESS | 1635 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49241/tests/dromaeo/cssquery-prototype.html) 15:19:06 INFO - PROCESS | 1635 | RSS: Main: 274919424 15:19:06 INFO - PROCESS | 1635 | 15:22:09 INFO - PROCESS | 1635 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49241/tests/dromaeo/cssquery-yui.html) 15:22:10 INFO - PROCESS | 1635 | RSS: Main: 262823936 15:22:10 INFO - PROCESS | 1635 | 15:25:12 INFO - PROCESS | 1635 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-yui.html (next: http://localhost:49241/tests/dromaeo/cssquery-dojo.html) 15:25:13 INFO - PROCESS | 1635 | RSS: Main: 479903744 15:25:13 INFO - PROCESS | 1635 | 15:25:13 INFO - PROCESS | 1635 | __start_tp_report 15:25:13 INFO - PROCESS | 1635 | _x_x_mozilla_page_load 15:25:13 INFO - PROCESS | 1635 | _x_x_mozilla_page_load_details 15:25:13 INFO - PROCESS | 1635 | |i|pagename|runs| 15:25:13 INFO - PROCESS | 1635 | |0;dojo.html;3399.728021758259;3402.2515046689723;3434.433318502447;3442.58688957325;3476.72186225102;5558.360788509322;5648.406917273689;5650.773969041234;5655.5475561955045;5665.830025099249;5605.990921634115;5658.547316214704;5689.544836413087;5695.060315048012;5703.77184912604;5107.668001579904;5125.513076257749;5141.82003629873;5158.252053452247;5184.662996905189;5050.595952323805;5061.620378471611;5065.834857982666;5236.31927849379;5286.814961476349;5112.769925353368;5128.512791284822;5194.92207616886;5200.713960732158;5203.609729270301;5132.127538318495;5208.218767184915;5208.5312321891215;5210.478952104797;5213.973930130363;5076.416212135615;5114.335136432277;5135.589152867761;5150.407703114152;5197.402298735656;5490;5533.3083364579425;5557.888842223133;5580.497755202011;5609.607327487078;6035.034394496904;6038;6162.044883043135;6173.197484327054;6189.659568723719;6191.659458729768;6231.719572619243;6234.594751341194;6256.998880179195;6257.87484250317;5535.640183388067;5588.385277619459;5600.8319750407145;5604.41153678866;5647.29408823897;6295.748170073238;6320.462760665303;6333.303336632966;6333.873322533524;6347.333529979285;6009.248843894513;6013.30846952606;6013.819585412444;6015.488683461955;6025.487833534111;5983.102534619842;6040.516758659297;6047.758089676364;6064.575479716377;6177.104319873593;5889.646621202742;6019.458248757545;6021.307549631849;6067.938110830587;6106.603070800384;6088.014439713239;6137.8979746733885;6149.692515374213;6163.476104531075;6176.413240742122;4747.62019038483;4834.057358814997;4903.803847846046;4913.582345500601;4930.482299358588;4354.782260886943;4360.236958532244;4408.030233348658;4431.734095954189;4507.2112380333965;5677.14842773579;5678.77284908599;5680.261565996394;5701.2588363513305;5701.344345400249;6212.099245609361;6226.40849119333;6235.937640623626;6240.719167637467;6247.96876015617;5509.724513774296;5532;5544.445555444504;5619.381867994517;5636.436356364331;5372.059889519319;5372.194170874322;5391.919121213185;5401.4868587484125;5413.323334583177;6363.3000369958345;6366.9681651591445;6369.777057802955;6370.490360771035;6380.617162970237;6005.039193728982;6043.8186854394435;6059.545534084873;6225.252969643671;6255.093011513396;6281.089242059785;6350.90473642905;6355.237371515263;6372.171617689856;6380;6088.543359247986;6132.6627035513475;6139.386061393825;6148.723307451086;6158.076288556752;5914.467697907209;6187.907181392193;6219.844503887439;6231.594946328474;6263.279722831932;5801.245838041028;5853.560982926212;5866.3547009828035;5904.940950590611;6014.458698717136;5973;5974.342822289632;5979.701014949148;5984.970075149597;5986.790462333972;5603;5804.912926306024;5805.593608447368;5830.387809279964;5831.212786273968;5785.884282314414;5826.912596310974;5920.644761314335;5922.703864806656;5960.552958528041;5886.205362276038;5893.764249429974;5899.056151015817;5899.557533185114;5927.9703601481715 15:25:13 INFO - PROCESS | 1635 | |1;ext.html;480.2747850745375;543.8042304770281;544.6704743630104;554.1770470850784;558.9212819258829;33025.834870825645;33874.32251354974;35175.12062198443;35230.64769352306;43577;45517.54482455175;46110.76944615272;46138;46152.07695846081;46169.538304616945;9938.652147174833;10015.349002314826;10049.64826231082;10115.039071288253;10180.287379883412;9239.122283383067;9531.285153613471;9833.704988850346;9963.800723985516;9965.35225210359;9746.756331091708;12581.993440524737;12613.243205407705;12746.362681865916;12748.681282967907;12438.81341779874;12503.874961250453;12506.999440044865;12509.499620015189;12515.999999999955;11960.043196544255;12030.69923251917;12032.639020829301;12036.277823330629;12042.578509752204;42708;43019.70940871779;43072.56927430717;43099.569004310186;43131.56868431307;3383.2895092030703;3442.345954268706;3600.837962291703;3636.5090712753704;4102.630763231324;31906.042818715243;32571.185720356945;32587;32812.6718732812;33111.50332745011;3248.902532924016;3326.7342492464277;3368.781029233092;3467;3493.12671832042;435189;436628;438895;438912;439799;63172.736545269756;63527;63609.72780544363;63657.36342636514;63825.680871595345;36271.818640906626;36842.447363289575;36941.445878311846;38201.61798381981;38270.234595307935;17922.462326130237;18116;18124.275028998956;18144;18159.546011349823;13630.250336231404;13720.588382348546;13748.243846588333;13784;13790.793138102936;17925;18247.54381140482;20393.286234981704;20437.182512699623;20707.689384659243;7157.606331651705;7953.6818527258265;8051.919480805234;8071.717489887943;8104.351651867836;870.8911386076741;994.3238597753597;1030.9742256443649;1033.617561502249;1057.9259451838452;30963.225919351746;31108.688913110578;31472;31479.550862211163;31680.36639267248;1062.1449732964884;1095.4905968724581;1129.7288650723767;1144.7481554058095;1207.2575366149931;16142.75785863213;16470.176491175393;16472.25874835635;16656.485440847242;16772.832271677373;723114;729181;730420;731151;731376;62980;63366.36633633697;63438;63567.36432635707;63793.68103159455;1407.422956587794;1415.5611760354323;1446.0817380963165;1449.0074299105147;1450.166154461189;27009.45981080328;29880.103596892128;30643.846780765954;30978.521718262033;31761;54834.72582637061;55139.44860551343;55191.72404137954;55210.723946380014;55301;635234;635917;637007;637304;637462;24751;26531;28202.71797282001;28306.009289674763;28603.9988600398;49579.50420495893;49634.75182624064;50409.74795126001;50465.74767126141;50779.74610126926;36439.45340819943;40222.99442513961;40267.84870329255;41104.58895411008;43379.78310108429;41699.58300416957;41838;41987.1602567953;43029;43122;39790.403143953445;40156;40264.194716104925;40265;40689.59310406858;34827.477587835696;35972.877710735534;36389.09027274339;36507.634923650425;36535.63464365429;26537.33656658599;26648.20055398341;26839.73160268372;26859.731402685724;27410.5888411678 15:25:13 INFO - PROCESS | 1635 | |2;jquery.html;367.75728019507113;387.6317498376542;389.9509636663188;395.4858683711176;415.03504352380725;14340;20116.497087572818;21477.9595938386;21502.89248553755;21505.569888602236;16631.251593678284;19010.42968710941;20974.37076887692;21232.726036437787;21479.140834366644;5934.732937017845;6271.996480563111;6277.435030847223;6280.497560195174;6286.874262514747;6021.668808215546;6169.691515424233;6201.627902325852;6297.370262973689;6364.936350636481;6363.649999250039;6375.904361434582;6388.233411990567;6392.744290228408;6394.040893865934;6068.059450785136;6206.317305096459;6269.62382257066;6276.874462510724;6284.4344009039405;5833.300003999547;6027.005544085221;6066.302375226817;6077.544184186204;6175.042868355412;11179.217454778169;11304.717382065432;19449.02754862251;20743.481412964797;26391.94432222709;2089.1643342662906;2276.4195130241847;2287.79409853114;2736.7263273672675;2796.3708165662765;10029.348092373972;10127.987201279886;10308.175345972304;10662;10756.031957123818;1773.8403543681002;1880.1445342369188;1892.0728842866897;1937.1766999025358;1986.2849374225268;122222.388888055;125283;126687.49843761754;131145;134266.32866835702;9541.952290238643;9826.459544725109;11538.480768365444;11547.4803633835;11765.764684706259;14976.026558273677;14988.925055374653;14991.775123373158;14999;15028.849711502746;6831.351021652935;7969.681212751541;8396.07643159252;8535.274501667427;8547.658093676184;7447.515911465737;8579.914200858037;8940.910590894138;9104.954475227581;9113.088691130833;4524.072565124142;4592;4601.700889442175;4609.976950115228;4697.060587882437;1772.6337646357483;1797.2182100785938;1819.1789485125737;1903.8762480438727;1936.7288579598867;859.2009431228892;896.8609865470862;902.2105657549644;949.1457688080644;1010.9241806864515;20373.898130509253;20613.484662883548;20762.48093797637;21111.894440528005;21370;910.7905181808088;966.8066386722543;969.5540051576213;986.5412583148727;994.9403035817874;10717.410542420086;11093.394646739842;11125.777484450266;11196.832047519294;11201.495932683049;633585;645314.7734261298;647021.7648911725;647297.7635111795;650912;116161;130939.34530327478;134301;157945;158346.2082689579;1001.5893483671659;1029.1149611334247;1041.4116024446164;1047.2930771729052;1049.3494033699003;18319.450416487525;18911.243550257837;19488.512787179865;19583.60832783365;19614;58493.4150658505;58729.82540349255;59804.9068282608;60454.39545604488;60841;86334.56832715796;86970;89070.55464722635;90695;90992;8104.79738006531;8194.38542109356;8346.207110324509;8356.247937685637;8382.958085209535;12027.639170824888;12806.975441964434;12972;13018.218906865619;13466.730665386833;10976;11129.83305250438;11148.888511114785;11351;11499.770004600028;9507.334486585873;9625.32622716403;10656.520456579317;10850.945745271223;11214.55141794319;9145.634174633205;11356.148288878201;11422.428878555873;11554.537818487166;11556.479958401724;8138.796530086795;8286.83426331482;8357.038940521674;8383.622736976973;8414.495130292202;9474.621015159317;11014.39420831862;11141.441915406796;11524.596639117926;11595.304281743123 15:25:13 INFO - PROCESS | 1635 | |3;mootools.html;1229.3115855121139;1552.9689406211874;1578.2818817438063;1778.1020584604773;1927.1424216223786;8004.119546849849;8532.018817835951;8928.955355223223;9272.582733776979;9276.58255378508;9157.313201509896;9255.583498742555;9259.907400926006;9298.442093474396;9315.534223288825;2440.10936008357;2470.6170543565777;2472.8269021168526;2473.492933948536;2474.40614252579;2400.135951057618;2462.1259452894233;2462.569050416179;2463.4457247119435;2463.963040554393;2411.963820542693;2437.902483900642;2459.3359792855917;2461.4461746107163;2465.3097132802754;2397.328153492435;2423.1761201191593;2425.866577338246;2441.182203961675;2441.9511609767883;2343.683602713646;2413.915512957038;2416.275117464771;2422.733499315074;2424.818138639609;8251.876221856677;8509.659613615448;9195.816083678355;9196;9318.30112741547;5365.919511207335;5557.249771280865;5560.805371811967;5607.214989901417;5627.71861406928;3650.5254316938626;3655.3603119453987;3695;3739.2521495700967;3742.045778326509;1129.4691494997421;1131.095123900876;1134.8014097532898;1142.691473302212;1153.544349981761;12492.875071249262;12571.811422828665;12591.874081259253;12619.621411357673;12637.43131559082;4830.2513110467935;4870.756462176877;4918.803247870045;5010.398752149766;5043.823466178666;10448;10453.21600879937;10466.790664186827;10471.738206544896;10519.631812886666;5598.272224610774;5601.7759289628775;5612.775488980476;5614.775408983676;5626.409227031103;5005.099082165245;5081.5426611605135;5109.770060347293;5129.410117836496;5138.486151384832;4080.367543030835;4083.1017176221185;4128.566500517462;4184.309588917795;4184.8744537663915;1147.977040459203;1296.4360503180958;1318.4660212613908;1323.589687196972;1345.2735522817763;918.875951746519;920.5708734962345;933.6498812945146;946.5551190940247;979.6669132494986;5809.477147056785;5915.497182739429;5964.31410387811;6182.578007058401;6247.875042499125;448.97306161630405;457.8832397738555;459.21474278982646;465.5367908930568;472.02291257098165;3908.5309762828642;3921.941170882439;4003.8999025024023;4032.5160980681917;4073.5538883695863;10524.473776311153;11238.269512481662;11378.260413073123;11400;11453;11149.690203238764;11198.552057917592;11333.716657083638;11351.091912646969;11383.430828458544;8422.915770842214;8633.136686331442;8635.272945410943;8648.1784230498;8657.783555411039;5738.282714660668;5761.251037365116;5875.441833025856;5930.28836539618;5959.791407300723;10307.484625768531;10329.967003299911;10391.428471434143;10468;10512.316699414514;10032.297739158188;10411.11505522039;10429.322094063862;10627.202959777893;10631.936806319307;7778.727744528915;7927.643256053607;7950.761477155695;7959.323457506177;7964;8389.706360277361;8447.281981031681;8538.44500107491;8538.487690738575;8587.699430519902;7539.962300188464;7692.115406728298;7792.649330780242;7833.060032795873;7840.333571646246;7529.736459223901;7588.582627955516;7594.6202689866395;7633.427492937941;7641.7707468776025;7043.964780176067;7126.608036557832;7225.988361629271;7228.63856807168;7253.165885923187;4953.529414705597;4963.454020057863;4992.475790041994;5024.4473107957365;5042;4759.5240475953515;4954.900901981868;5100.69395836251;5132.695809658419;5177.042247184283 15:25:13 INFO - PROCESS | 1635 | |4;prototype.html;295.5124045325213;307.60011984420237;313.0670601607211;315.76633291364385;320.2410287618345;4690.077068401952;4994.875128121799;5221.556167725743;5311.760970756315;5365.302510673617;4720.362751028611;4770.990460016977;4961.5286547778;5088.592912566995;5112.8977420451565;3484.4250698634696;3808.2954653389074;3996.3215449511276;4014.7791871447057;4041.3533834586474;3465.6187819339852;3494.650534946498;3947.151362457071;3995.7802320872343;4001.9199616007663;3525.0389672674946;3733.589305176442;3890.280298144838;3971.5035620547433;3989.404238304672;3464.834478450968;3500.877469288588;4001.679865610744;4002;4019.7387169834014;3501.632328605511;3513.2095278562374;3524.7708898921487;3553.928921421583;3564.679178873888;4747.762611869427;5112.082968886668;5126.948730512684;5175.938932518825;5184.481551844823;4427.756473393962;4568.588827005552;4604.424446944132;4617.330487079388;4631.698939568917;4577.29051996941;4698.577128058491;5197.194434862565;5477.917831232495;5527.010276300529;3863.600031971847;3885.708571857122;3887.844486220548;3904.9219015619815;3923.901902452433;5180.870478238036;5494.587905907033;5728.081092833906;5794.913076303858;5854.941450585482;3942.940855887164;3966.662833659171;3970.662493688011;3971.543272523639;3971.6028397160053;3504.7546671732734;3917.7257591968287;3956.872291396938;4039.6970227233073;4068.816903239361;3696.0205545530457;3870.9225815483533;4434.046679963823;4615.200191800557;4637.976810115928;4760.85761407368;5315.554844771371;5526.281583394133;5526.364468086141;5578.553715702734;1145.9598914038136;1367.2138520350838;1367.6444124527695;1373.3064802274787;1374.3952660829202;756.5385115079797;770.3144201660526;873.7116751471999;873.9861760358082;942.8067246214509;4645.607512131255;4775.689580177277;5220.295260139908;5250.606204534675;5280.709560974106;5422.580596813585;5430.185472179126;5549.809893530359;5643.939961913954;5741.540676745851;4426.402435671143;4487.4839393470165;5197.7401129943355;5204.7099276318295;5212.661177023557;2688.5832695932163;2899.1302609217573;2928.8974885878893;2943.543750718642;2944.455275773989;5044.974775126101;5401.4868587484125;5450.618456707993;5609.467100625434;5817.418258174149;4490.528494508095;4627.930581041287;5724.284464441945;5736.62711923732;5776.133579963039;4626.606738427271;5532.514515854986;5579.856129493444;5716.742746576414;5730.512906402919;5030.270610761492;5042.722650254272;5087.745612719275;5215.635914834986;5580.665160090408;5011.974940125276;5383.973080134574;5497.780088796403;5513.566472717042;5513.972430137824;5001.1495746574;5765.91351129725;5777.9133313001175;5783.595148339744;5794.275715535558;3156.2267244525237;3281.52417899408;3729.68297694699;3879.6314350137823;3896.4350169224736;4872;5070.290159377616;5575.832725018256;5582.784997326992;5671.517920976763;4753.5008824072975;4871.561559459524;5290.232916227049;5366.443731317874;5441.29263195782;5107.514786095315;5264.814787053931;5489.945100548944;5629.324481062299;5660.85847853807;5216.582673386044;5398.811041613525;5529.815722789556;5542.944570554404;5546.528545073553;4695.671303008757;5401.864953376197;5631.380548139619;5644.9435505644415;5661.377248502744;5516.531094856821;5521.585881058856;5534.335879694462;5548.528375088163;5549.528290095225 15:25:13 INFO - PROCESS | 1635 | |5;yui.html;732.5824280160307;794.5987276425404;820.712750537312;827.1480375213529;866.3675516872687;15272.770908436383;15364.769528457082;15479.922600386997;16219.270132844036;16377.590560236;15209.92395038026;15319.463818766346;15353.462628807994;15364.539063828075;15373.69252614947;742.3838214282133;760.0878945265704;900.3022657440487;904.5386852705102;920.558132096594;919.3794188922484;937.5499760115115;942.0673533202149;944.6127087893965;944.6646440513622;987.7431867714411;988.9615903301541;989.8317286061387;991.192178374626;998.6205242008027;978.2516374973151;979.9167070798991;982.9973427104385;984.1732944326764;988.6440881282697;732.143392231091;733.4792297468804;734.0200831889434;736.282124928196;736.977890663281;15421.614459638598;15884.602884927854;16007.27967241477;16067;16071.116088615121;13450.394732237073;13493.730125397436;13555.661108472366;13968.022238443313;15161.848381516154;11806.586769463114;12887.291198984052;13459.798103028463;13663.248521331323;13906.235157066358;3931.6264954829244;4052.49343832021;4112.629863312316;4604.033153037866;4713.811447542094;106988;107000.92999069988;109902.45048774785;110023.44988275088;113979;11128.38793866345;11263.831042534368;11383.943080284545;11400.48697808584;11419.371934543513;22716.772832271796;22718.772812271996;22745.431364216027;22777.544449110927;23167.3049808506;8075.838483230303;8139.95930020358;8208.348098644012;8223.629936652866;8240.62917168729;4335.67482438812;4388.692791504564;4575.931361029588;4659.976700116477;4666.533346665374;3599.2441587266967;3727.5713292971654;3760.6615404613717;3762.2099359134886;3762.3039737648073;671.4762485261504;674.6727836999052;676.2966514824626;682.576802382526;698.6436917172279;613.4601550635413;674.9898751518731;675.2133764164693;680.5134328954821;684.2302409788988;8850.690225842065;9528.285378596633;9534.332596718303;9716.61133554664;9862.802743945082;607.7933502609134;662.4170729757782;675.9087523184307;684.1209046375384;698.3679769808332;4489.506154323022;4498.8425405110665;4667;4690.530946905282;4703.795637073423;114967;151835.48164518212;162480;166985;167387.1630641839;127536;127835;130235.34882325717;134975;138569.3071534656;76210.61894690491;101997.49001254946;102271.4886425578;104530.95469045364;104545.54544545485;8882.467051976902;8940.46357218569;8942.37403381757;8996.86504702443;8998.14517620825;66560.33439665541;66691.33271668052;67021.3297867015;68533.31466685269;68969.65515172391;66337.33662663311;70815.64592177006;97957.06128816147;102346.97653023375;104121;11177.385243811668;11343.886561134283;11442.42787860587;11568.942155289169;11585.6524304271;12811.359432028175;12918.741625167631;13060.732655815103;13163.276019819003;13960.952928530198;12063.276203427822;12523;13064.869351306364;13202.669933251746;13215.933920330337;12419.93790031044;12599.559015434415;12840.101192916407;12945.09384343087;13131.60605181846;11596.188266821579;11794.882051179378;11852.288862668267;12131.090168237593;12573.622791316275;10302.278840481094;10389.584416623553;10501.9474902625;10844.295120817122;11268.718282042686;7730.497517661334;10195.949020254851;11035.282706624044;11063.391513466515;11104.944475277573 15:25:13 INFO - PROCESS | 1635 | __end_tp_report 15:25:13 INFO - PROCESS | 1635 | __start_cc_report 15:25:13 INFO - PROCESS | 1635 | _x_x_mozilla_cycle_collect,1416 15:25:13 INFO - PROCESS | 1635 | __end_cc_report 15:25:13 INFO - PROCESS | 1635 | __startTimestamp1484004313245__endTimestamp 15:25:13 INFO - PROCESS | 1635 | 15:25:13 INFO - PROCESS | 1635 | ------- Summary: start ------- 15:25:13 INFO - PROCESS | 1635 | Number of tests: 6 15:25:13 INFO - PROCESS | 1635 | 15:25:13 INFO - PROCESS | 1635 | [#0] dojo.html Cycles:165 Average:5676.02 Median:5831.21 stddev:617.69 (10.6%) stddev-sans-first:593.22 15:25:13 INFO - PROCESS | 1635 | Values: 3399.7 3402.3 3434.4 3442.6 3476.7 5558.4 5648.4 5650.8 5655.5 5665.8 5606.0 5658.5 5689.5 5695.1 5703.8 5107.7 5125.5 5141.8 5158.3 5184.7 5050.6 5061.6 5065.8 5236.3 5286.8 5112.8 5128.5 5194.9 5200.7 5203.6 5132.1 5208.2 5208.5 5210.5 5214.0 5076.4 5114.3 5135.6 5150.4 5197.4 5490.0 5533.3 5557.9 5580.5 5609.6 6035.0 6038.0 6162.0 6173.2 6189.7 6191.7 6231.7 6234.6 6257.0 6257.9 5535.6 5588.4 5600.8 5604.4 5647.3 6295.7 6320.5 6333.3 6333.9 6347.3 6009.2 6013.3 6013.8 6015.5 6025.5 5983.1 6040.5 6047.8 6064.6 6177.1 5889.6 6019.5 6021.3 6067.9 6106.6 6088.0 6137.9 6149.7 6163.5 6176.4 4747.6 4834.1 4903.8 4913.6 4930.5 4354.8 4360.2 4408.0 4431.7 4507.2 5677.1 5678.8 5680.3 5701.3 5701.3 6212.1 6226.4 6235.9 6240.7 6248.0 5509.7 5532.0 5544.4 5619.4 5636.4 5372.1 5372.2 5391.9 5401.5 5413.3 6363.3 6367.0 6369.8 6370.5 6380.6 6005.0 6043.8 6059.5 6225.3 6255.1 6281.1 6350.9 6355.2 6372.2 6380.0 6088.5 6132.7 6139.4 6148.7 6158.1 5914.5 6187.9 6219.8 6231.6 6263.3 5801.2 5853.6 5866.4 5904.9 6014.5 5973.0 5974.3 5979.7 5985.0 5986.8 5603.0 5804.9 5805.6 5830.4 5831.2 5785.9 5826.9 5920.6 5922.7 5960.6 5886.2 5893.8 5899.1 5899.6 5928.0 15:25:13 INFO - PROCESS | 1635 | 15:25:13 INFO - PROCESS | 1635 | [#1] ext.html Cycles:180 Average:73571.37 Median:19954.16 stddev:164318.18 (823.5%) stddev-sans-first:164687.50 15:25:13 INFO - PROCESS | 1635 | Values: 480.3 543.8 544.7 554.2 558.9 33025.8 33874.3 35175.1 35230.6 43577.0 45517.5 46110.8 46138.0 46152.1 46169.5 9938.7 10015.3 10049.6 10115.0 10180.3 9239.1 9531.3 9833.7 9963.8 9965.4 9746.8 12582.0 12613.2 12746.4 12748.7 12438.8 12503.9 12507.0 12509.5 12516.0 11960.0 12030.7 12032.6 12036.3 12042.6 42708.0 43019.7 43072.6 43099.6 43131.6 3383.3 3442.3 3600.8 3636.5 4102.6 31906.0 32571.2 32587.0 32812.7 33111.5 3248.9 3326.7 3368.8 3467.0 3493.1 435189.0 436628.0 438895.0 438912.0 439799.0 63172.7 63527.0 63609.7 63657.4 63825.7 36271.8 36842.4 36941.4 38201.6 38270.2 17922.5 18116.0 18124.3 18144.0 18159.5 13630.3 13720.6 13748.2 13784.0 13790.8 17925.0 18247.5 20393.3 20437.2 20707.7 7157.6 7953.7 8051.9 8071.7 8104.4 870.9 994.3 1031.0 1033.6 1057.9 30963.2 31108.7 31472.0 31479.6 31680.4 1062.1 1095.5 1129.7 1144.7 1207.3 16142.8 16470.2 16472.3 16656.5 16772.8 723114.0 729181.0 730420.0 731151.0 731376.0 62980.0 63366.4 63438.0 63567.4 63793.7 1407.4 1415.6 1446.1 1449.0 1450.2 27009.5 29880.1 30643.8 30978.5 31761.0 54834.7 55139.4 55191.7 55210.7 55301.0 635234.0 635917.0 637007.0 637304.0 637462.0 24751.0 26531.0 28202.7 28306.0 28604.0 49579.5 49634.8 50409.7 50465.7 50779.7 36439.5 40223.0 40267.8 41104.6 43379.8 41699.6 41838.0 41987.2 43029.0 43122.0 39790.4 40156.0 40264.2 40265.0 40689.6 34827.5 35972.9 36389.1 36507.6 36535.6 26537.3 26648.2 26839.7 26859.7 27410.6 15:25:13 INFO - PROCESS | 1635 | 15:25:13 INFO - PROCESS | 1635 | [#2] jquery.html Cycles:180 Average:37233.23 Median:2282.11 stddev:107949.08 (4730.2%) stddev-sans-first:108216.41 15:25:13 INFO - PROCESS | 1635 | Values: 367.8 387.6 390.0 395.5 415.0 14340.0 20116.5 21478.0 21502.9 21505.6 16631.3 19010.4 20974.4 21232.7 21479.1 5934.7 6272.0 6277.4 6280.5 6286.9 6021.7 6169.7 6201.6 6297.4 6364.9 6363.6 6375.9 6388.2 6392.7 6394.0 6068.1 6206.3 6269.6 6276.9 6284.4 5833.3 6027.0 6066.3 6077.5 6175.0 11179.2 11304.7 19449.0 20743.5 26391.9 2089.2 2276.4 2287.8 2736.7 2796.4 10029.3 10128.0 10308.2 10662.0 10756.0 1773.8 1880.1 1892.1 1937.2 1986.3 122222.4 125283.0 126687.5 131145.0 134266.3 9542.0 9826.5 11538.5 11547.5 11765.8 14976.0 14988.9 14991.8 14999.0 15028.8 6831.4 7969.7 8396.1 8535.3 8547.7 7447.5 8579.9 8940.9 9105.0 9113.1 4524.1 4592.0 4601.7 4610.0 4697.1 1772.6 1797.2 1819.2 1903.9 1936.7 859.2 896.9 902.2 949.1 1010.9 20373.9 20613.5 20762.5 21111.9 21370.0 910.8 966.8 969.6 986.5 994.9 10717.4 11093.4 11125.8 11196.8 11201.5 633585.0 645314.8 647021.8 647297.8 650912.0 116161.0 130939.3 134301.0 157945.0 158346.2 1001.6 1029.1 1041.4 1047.3 1049.3 18319.5 18911.2 19488.5 19583.6 19614.0 58493.4 58729.8 59804.9 60454.4 60841.0 86334.6 86970.0 89070.6 90695.0 90992.0 8104.8 8194.4 8346.2 8356.2 8383.0 12027.6 12807.0 12972.0 13018.2 13466.7 10976.0 11129.8 11148.9 11351.0 11499.8 9507.3 9625.3 10656.5 10850.9 11214.6 9145.6 11356.1 11422.4 11554.5 11556.5 8138.8 8286.8 8357.0 8383.6 8414.5 9474.6 11014.4 11141.4 11524.6 11595.3 15:25:13 INFO - PROCESS | 1635 | 15:25:13 INFO - PROCESS | 1635 | [#3] mootools.html Cycles:180 Average:5927.14 Median:4794.89 stddev:3385.26 (70.6%) stddev-sans-first:3376.34 15:25:13 INFO - PROCESS | 1635 | Values: 1229.3 1553.0 1578.3 1778.1 1927.1 8004.1 8532.0 8929.0 9272.6 9276.6 9157.3 9255.6 9259.9 9298.4 9315.5 2440.1 2470.6 2472.8 2473.5 2474.4 2400.1 2462.1 2462.6 2463.4 2464.0 2412.0 2437.9 2459.3 2461.4 2465.3 2397.3 2423.2 2425.9 2441.2 2442.0 2343.7 2413.9 2416.3 2422.7 2424.8 8251.9 8509.7 9195.8 9196.0 9318.3 5365.9 5557.2 5560.8 5607.2 5627.7 3650.5 3655.4 3695.0 3739.3 3742.0 1129.5 1131.1 1134.8 1142.7 1153.5 12492.9 12571.8 12591.9 12619.6 12637.4 4830.3 4870.8 4918.8 5010.4 5043.8 10448.0 10453.2 10466.8 10471.7 10519.6 5598.3 5601.8 5612.8 5614.8 5626.4 5005.1 5081.5 5109.8 5129.4 5138.5 4080.4 4083.1 4128.6 4184.3 4184.9 1148.0 1296.4 1318.5 1323.6 1345.3 918.9 920.6 933.6 946.6 979.7 5809.5 5915.5 5964.3 6182.6 6247.9 449.0 457.9 459.2 465.5 472.0 3908.5 3921.9 4003.9 4032.5 4073.6 10524.5 11238.3 11378.3 11400.0 11453.0 11149.7 11198.6 11333.7 11351.1 11383.4 8422.9 8633.1 8635.3 8648.2 8657.8 5738.3 5761.3 5875.4 5930.3 5959.8 10307.5 10330.0 10391.4 10468.0 10512.3 10032.3 10411.1 10429.3 10627.2 10631.9 7778.7 7927.6 7950.8 7959.3 7964.0 8389.7 8447.3 8538.4 8538.5 8587.7 7540.0 7692.1 7792.6 7833.1 7840.3 7529.7 7588.6 7594.6 7633.4 7641.8 7044.0 7126.6 7226.0 7228.6 7253.2 4953.5 4963.5 4992.5 5024.4 5042.0 4759.5 4954.9 5100.7 5132.7 5177.0 15:25:13 INFO - PROCESS | 1635 | 15:25:13 INFO - PROCESS | 1635 | [#4] prototype.html Cycles:180 Average:4435.58 Median:5006.56 stddev:1347.15 (26.9%) stddev-sans-first:1314.60 15:25:13 INFO - PROCESS | 1635 | Values: 295.5 307.6 313.1 315.8 320.2 4690.1 4994.9 5221.6 5311.8 5365.3 4720.4 4771.0 4961.5 5088.6 5112.9 3484.4 3808.3 3996.3 4014.8 4041.4 3465.6 3494.7 3947.2 3995.8 4001.9 3525.0 3733.6 3890.3 3971.5 3989.4 3464.8 3500.9 4001.7 4002.0 4019.7 3501.6 3513.2 3524.8 3553.9 3564.7 4747.8 5112.1 5126.9 5175.9 5184.5 4427.8 4568.6 4604.4 4617.3 4631.7 4577.3 4698.6 5197.2 5477.9 5527.0 3863.6 3885.7 3887.8 3904.9 3923.9 5180.9 5494.6 5728.1 5794.9 5854.9 3942.9 3966.7 3970.7 3971.5 3971.6 3504.8 3917.7 3956.9 4039.7 4068.8 3696.0 3870.9 4434.0 4615.2 4638.0 4760.9 5315.6 5526.3 5526.4 5578.6 1146.0 1367.2 1367.6 1373.3 1374.4 756.5 770.3 873.7 874.0 942.8 4645.6 4775.7 5220.3 5250.6 5280.7 5422.6 5430.2 5549.8 5643.9 5741.5 4426.4 4487.5 5197.7 5204.7 5212.7 2688.6 2899.1 2928.9 2943.5 2944.5 5045.0 5401.5 5450.6 5609.5 5817.4 4490.5 4627.9 5724.3 5736.6 5776.1 4626.6 5532.5 5579.9 5716.7 5730.5 5030.3 5042.7 5087.7 5215.6 5580.7 5012.0 5384.0 5497.8 5513.6 5514.0 5001.1 5765.9 5777.9 5783.6 5794.3 3156.2 3281.5 3729.7 3879.6 3896.4 4872.0 5070.3 5575.8 5582.8 5671.5 4753.5 4871.6 5290.2 5366.4 5441.3 5107.5 5264.8 5489.9 5629.3 5660.9 5216.6 5398.8 5529.8 5542.9 5546.5 4695.7 5401.9 5631.4 5644.9 5661.4 5516.5 5521.6 5534.3 5548.5 5549.5 15:25:13 INFO - PROCESS | 1635 | 15:25:13 INFO - PROCESS | 1635 | [#5] yui.html Cycles:180 Average:24729.45 Median:3663.41 stddev:39731.16 (1084.5%) stddev-sans-first:39801.76 15:25:13 INFO - PROCESS | 1635 | Values: 732.6 794.6 820.7 827.1 866.4 15272.8 15364.8 15479.9 16219.3 16377.6 15209.9 15319.5 15353.5 15364.5 15373.7 742.4 760.1 900.3 904.5 920.6 919.4 937.5 942.1 944.6 944.7 987.7 989.0 989.8 991.2 998.6 978.3 979.9 983.0 984.2 988.6 732.1 733.5 734.0 736.3 737.0 15421.6 15884.6 16007.3 16067.0 16071.1 13450.4 13493.7 13555.7 13968.0 15161.8 11806.6 12887.3 13459.8 13663.2 13906.2 3931.6 4052.5 4112.6 4604.0 4713.8 106988.0 107000.9 109902.5 110023.4 113979.0 11128.4 11263.8 11383.9 11400.5 11419.4 22716.8 22718.8 22745.4 22777.5 23167.3 8075.8 8140.0 8208.3 8223.6 8240.6 4335.7 4388.7 4575.9 4660.0 4666.5 3599.2 3727.6 3760.7 3762.2 3762.3 671.5 674.7 676.3 682.6 698.6 613.5 675.0 675.2 680.5 684.2 8850.7 9528.3 9534.3 9716.6 9862.8 607.8 662.4 675.9 684.1 698.4 4489.5 4498.8 4667.0 4690.5 4703.8 114967.0 151835.5 162480.0 166985.0 167387.2 127536.0 127835.0 130235.3 134975.0 138569.3 76210.6 101997.5 102271.5 104531.0 104545.5 8882.5 8940.5 8942.4 8996.9 8998.1 66560.3 66691.3 67021.3 68533.3 68969.7 66337.3 70815.6 97957.1 102347.0 104121.0 11177.4 11343.9 11442.4 11568.9 11585.7 12811.4 12918.7 13060.7 13163.3 13961.0 12063.3 12523.0 13064.9 13202.7 13215.9 12419.9 12599.6 12840.1 12945.1 13131.6 11596.2 11794.9 11852.3 12131.1 12573.6 10302.3 10389.6 10501.9 10844.3 11268.7 7730.5 10195.9 11035.3 11063.4 11104.9 15:25:13 INFO - PROCESS | 1635 | -------- Summary: end -------- 15:25:13 INFO - PROCESS | 1635 | 15:25:13 INFO - TEST-INFO | 1635: exit 0 15:25:13 INFO - TEST-OK | dromaeo_css | took 1114752ms 15:25:13 INFO - TEST-START | kraken 15:25:13 INFO - operating with platform_type : mac_ 15:25:13 INFO - Initialising browser for kraken test... 15:25:13 INFO - TEST-INFO | started process 1644 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/tmpGOROOo/profile http://localhost:49241/getInfo.html) 15:25:16 INFO - PROCESS | 1644 | __metrics Screen width/height:1600/1200 15:25:16 INFO - PROCESS | 1644 | colorDepth:24 15:25:16 INFO - PROCESS | 1644 | Browser inner width/height: 1024/689 15:25:16 INFO - PROCESS | 1644 | __metrics 15:25:16 INFO - PROCESS | 1644 | 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" 15:25:16 INFO - PROCESS | 1644 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:25:16 INFO - TEST-INFO | 1644: exit 0 15:25:16 INFO - Browser initialized. 15:25:16 INFO - Running cycle 1/1 for kraken test... 15:25:16 INFO - TEST-INFO | started process 1646 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/tmpGOROOo/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:25:28 INFO - PROCESS | 1646 | RSS: Main: 169197568 15:25:28 INFO - PROCESS | 1646 | 15:25:31 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection) 15:25:32 INFO - PROCESS | 1646 | RSS: Main: 218423296 15:25:32 INFO - PROCESS | 1646 | 15:25:34 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-dft) 15:25:35 INFO - PROCESS | 1646 | RSS: Main: 232214528 15:25:35 INFO - PROCESS | 1646 | 15:25:38 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-fft) 15:25:39 INFO - PROCESS | 1646 | RSS: Main: 328564736 15:25:39 INFO - PROCESS | 1646 | 15:25:41 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator) 15:25:41 INFO - PROCESS | 1646 | RSS: Main: 229396480 15:25:41 INFO - PROCESS | 1646 | 15:25:43 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:25:44 INFO - PROCESS | 1646 | RSS: Main: 229797888 15:25:44 INFO - PROCESS | 1646 | 15:25:47 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom) 15:25:47 INFO - PROCESS | 1646 | RSS: Main: 267657216 15:25:47 INFO - PROCESS | 1646 | 15:25:50 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate) 15:25:51 INFO - PROCESS | 1646 | RSS: Main: 269062144 15:25:51 INFO - PROCESS | 1646 | 15:25:54 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial) 15:25:54 INFO - PROCESS | 1646 | RSS: Main: 267370496 15:25:54 INFO - PROCESS | 1646 | 15:25:56 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:25:56 INFO - PROCESS | 1646 | RSS: Main: 240431104 15:25:56 INFO - PROCESS | 1646 | 15:25:58 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:25:59 INFO - PROCESS | 1646 | RSS: Main: 244441088 15:25:59 INFO - PROCESS | 1646 | 15:26:01 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:26:02 INFO - PROCESS | 1646 | RSS: Main: 250040320 15:26:02 INFO - PROCESS | 1646 | 15:26:04 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:26:05 INFO - PROCESS | 1646 | RSS: Main: 260718592 15:26:05 INFO - PROCESS | 1646 | 15:26:08 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:26:08 INFO - PROCESS | 1646 | RSS: Main: 261558272 15:26:08 INFO - PROCESS | 1646 | 15:26:10 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49241/tests/kraken/driver.html?testName=ai-astar) 15:26:10 INFO - PROCESS | 1646 | RSS: Main: 305127424 15:26:10 INFO - PROCESS | 1646 | 15:26:10 INFO - PROCESS | 1646 | __start_tp_report 15:26:10 INFO - PROCESS | 1646 | _x_x_mozilla_page_load 15:26:10 INFO - PROCESS | 1646 | _x_x_mozilla_page_load_details 15:26:10 INFO - PROCESS | 1646 | |i|pagename|runs| 15:26:10 INFO - PROCESS | 1646 | |0;ai-astar;157;167;147;114;114;114;113;113;115;113 15:26:10 INFO - PROCESS | 1646 | |1;audio-beat-detection;144;107;106;142;109;108;107;109;137;109 15:26:10 INFO - PROCESS | 1646 | |2;audio-dft;184;182;183;190;182;181;183;183;183;183 15:26:10 INFO - PROCESS | 1646 | |3;audio-fft;80;58;58;90;75;76;58;57;80;56 15:26:10 INFO - PROCESS | 1646 | |4;audio-oscillator;89;68;114;101;97;100;94;67;68;89 15:26:10 INFO - PROCESS | 1646 | |5;imaging-gaussian-blur;88;87;135;88;87;84;88;84;87;84 15:26:10 INFO - PROCESS | 1646 | |6;imaging-darkroom;92;92;91;93;93;92;93;92;92;92 15:26:10 INFO - PROCESS | 1646 | |7;imaging-desaturate;84;85;85;84;87;84;99;133;130;84 15:26:10 INFO - PROCESS | 1646 | |8;json-parse-financial;54;51;53;52;55;58;58;57;56;55 15:26:10 INFO - PROCESS | 1646 | |9;json-stringify-tinderbox;64;78;73;74;71;67;69;69;69;69 15:26:10 INFO - PROCESS | 1646 | |10;stanford-crypto-aes;82;81;81;81;81;82;77;88;85;87 15:26:10 INFO - PROCESS | 1646 | |11;stanford-crypto-ccm;138;133;136;136;135;136;137;136;168;145 15:26:10 INFO - PROCESS | 1646 | |12;stanford-crypto-pbkdf2;158;160;159;164;158;159;160;159;158;161 15:26:10 INFO - PROCESS | 1646 | |13;stanford-crypto-sha256-iterative;65;66;65;66;65;64;76;57;64;64 15:26:10 INFO - PROCESS | 1646 | __end_tp_report 15:26:10 INFO - PROCESS | 1646 | __start_cc_report 15:26:10 INFO - PROCESS | 1646 | _x_x_mozilla_cycle_collect,1911 15:26:10 INFO - PROCESS | 1646 | __end_cc_report 15:26:10 INFO - PROCESS | 1646 | __startTimestamp1484004370794__endTimestamp 15:26:10 INFO - PROCESS | 1646 | 15:26:10 INFO - PROCESS | 1646 | ------- Summary: start ------- 15:26:10 INFO - PROCESS | 1646 | Number of tests: 14 15:26:10 INFO - PROCESS | 1646 | 15:26:10 INFO - PROCESS | 1646 | [#0] ai-astar Cycles:10 Average:126.70 Median:114.50 stddev:21.44 (18.7%) stddev-sans-first:19.74 15:26:10 INFO - PROCESS | 1646 | Values: 157.0 167.0 147.0 114.0 114.0 114.0 113.0 113.0 115.0 113.0 15:26:10 INFO - PROCESS | 1646 | 15:26:10 INFO - PROCESS | 1646 | [#1] audio-beat-detection Cycles:10 Average:117.80 Median:109.00 stddev:16.13 (14.8%) stddev-sans-first:14.05 15:26:10 INFO - PROCESS | 1646 | Values: 144.0 107.0 106.0 142.0 109.0 108.0 107.0 109.0 137.0 109.0 15:26:10 INFO - PROCESS | 1646 | 15:26:10 INFO - PROCESS | 1646 | [#2] audio-dft Cycles:10 Average:183.40 Median:183.00 stddev:2.46 (1.3%) stddev-sans-first:2.60 15:26:10 INFO - PROCESS | 1646 | Values: 184.0 182.0 183.0 190.0 182.0 181.0 183.0 183.0 183.0 183.0 15:26:10 INFO - PROCESS | 1646 | 15:26:10 INFO - PROCESS | 1646 | [#3] audio-fft Cycles:10 Average:68.80 Median:75.50 stddev:12.66 (16.8%) stddev-sans-first:12.77 15:26:10 INFO - PROCESS | 1646 | Values: 80.0 58.0 58.0 90.0 75.0 76.0 58.0 57.0 80.0 56.0 15:26:10 INFO - PROCESS | 1646 | 15:26:10 INFO - PROCESS | 1646 | [#4] audio-oscillator Cycles:10 Average:88.70 Median:78.50 stddev:16.14 (20.6%) stddev-sans-first:17.12 15:26:10 INFO - PROCESS | 1646 | Values: 89.0 68.0 114.0 101.0 97.0 100.0 94.0 67.0 68.0 89.0 15:26:10 INFO - PROCESS | 1646 | 15:26:10 INFO - PROCESS | 1646 | [#5] imaging-gaussian-blur Cycles:10 Average:91.20 Median:87.00 stddev:15.48 (17.8%) stddev-sans-first:16.38 15:26:10 INFO - PROCESS | 1646 | Values: 88.0 87.0 135.0 88.0 87.0 84.0 88.0 84.0 87.0 84.0 15:26:10 INFO - PROCESS | 1646 | 15:26:10 INFO - PROCESS | 1646 | [#6] imaging-darkroom Cycles:10 Average:92.20 Median:92.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 15:26:10 INFO - PROCESS | 1646 | Values: 92.0 92.0 91.0 93.0 93.0 92.0 93.0 92.0 92.0 92.0 15:26:10 INFO - PROCESS | 1646 | 15:26:10 INFO - PROCESS | 1646 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:84.50 stddev:19.52 (23.1%) stddev-sans-first:20.26 15:26:10 INFO - PROCESS | 1646 | Values: 84.0 85.0 85.0 84.0 87.0 84.0 99.0 133.0 130.0 84.0 15:26:10 INFO - PROCESS | 1646 | 15:26:10 INFO - PROCESS | 1646 | [#8] json-parse-financial Cycles:10 Average:54.90 Median:55.50 stddev:2.42 (4.4%) stddev-sans-first:2.55 15:26:10 INFO - PROCESS | 1646 | Values: 54.0 51.0 53.0 52.0 55.0 58.0 58.0 57.0 56.0 55.0 15:26:10 INFO - PROCESS | 1646 | 15:26:10 INFO - PROCESS | 1646 | [#9] json-stringify-tinderbox Cycles:10 Average:70.30 Median:70.00 stddev:3.92 (5.6%) stddev-sans-first:3.43 15:26:10 INFO - PROCESS | 1646 | Values: 64.0 78.0 73.0 74.0 71.0 67.0 69.0 69.0 69.0 69.0 15:26:10 INFO - PROCESS | 1646 | 15:26:10 INFO - PROCESS | 1646 | [#10] stanford-crypto-aes Cycles:10 Average:82.50 Median:82.00 stddev:3.27 (4.0%) stddev-sans-first:3.47 15:26:10 INFO - PROCESS | 1646 | Values: 82.0 81.0 81.0 81.0 81.0 82.0 77.0 88.0 85.0 87.0 15:26:10 INFO - PROCESS | 1646 | 15:26:10 INFO - PROCESS | 1646 | [#11] stanford-crypto-ccm Cycles:10 Average:140.00 Median:136.50 stddev:10.33 (7.6%) stddev-sans-first:10.93 15:26:10 INFO - PROCESS | 1646 | Values: 138.0 133.0 136.0 136.0 135.0 136.0 137.0 136.0 168.0 145.0 15:26:10 INFO - PROCESS | 1646 | 15:26:10 INFO - PROCESS | 1646 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.60 Median:159.50 stddev:1.84 (1.2%) stddev-sans-first:1.86 15:26:10 INFO - PROCESS | 1646 | Values: 158.0 160.0 159.0 164.0 158.0 159.0 160.0 159.0 158.0 161.0 15:26:10 INFO - PROCESS | 1646 | 15:26:10 INFO - PROCESS | 1646 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.20 Median:65.00 stddev:4.59 (7.1%) stddev-sans-first:4.87 15:26:10 INFO - PROCESS | 1646 | Values: 65.0 66.0 65.0 66.0 65.0 64.0 76.0 57.0 64.0 64.0 15:26:10 INFO - PROCESS | 1646 | -------- Summary: end -------- 15:26:10 INFO - PROCESS | 1646 | 15:26:11 INFO - TEST-INFO | 1646: exit 0 15:26:11 INFO - TEST-OK | kraken | took 57676ms 15:26:11 INFO - SUITE-END | took 1172s 15:26:11 INFO - Completed test suite (00:19:32) 15:26:11 INFO - javascript benchmark 15:26:12 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3399.728021758259, 3402.2515046689723, 3434.433318502447, 3442.58688957325, 3476.72186225102, 5558.360788509322, 5648.406917273689, 5650.773969041234, 5655.5475561955045, 5665.830025099249, 5605.990921634115, 5658.547316214704, 5689.544836413087, 5695.060315048012, 5703.77184912604, 5107.668001579904, 5125.513076257749, 5141.82003629873, 5158.252053452247, 5184.662996905189, 5050.595952323805, 5061.620378471611, 5065.834857982666, 5236.31927849379, 5286.814961476349, 5112.769925353368, 5128.512791284822, 5194.92207616886, 5200.713960732158, 5203.609729270301, 5132.127538318495, 5208.218767184915, 5208.5312321891215, 5210.478952104797, 5213.973930130363, 5076.416212135615, 5114.335136432277, 5135.589152867761, 5150.407703114152, 5197.402298735656, 5490.0, 5533.3083364579425, 5557.888842223133, 5580.497755202011, 5609.607327487078, 6035.034394496904, 6038.0, 6162.044883043135, 6173.197484327054, 6189.659568723719, 6191.659458729768, 6231.719572619243, 6234.594751341194, 6256.998880179195, 6257.87484250317, 5535.640183388067, 5588.385277619459, 5600.8319750407145, 5604.41153678866, 5647.29408823897, 6295.748170073238, 6320.462760665303, 6333.303336632966, 6333.873322533524, 6347.333529979285, 6009.248843894513, 6013.30846952606, 6013.819585412444, 6015.488683461955, 6025.487833534111, 5983.102534619842, 6040.516758659297, 6047.758089676364, 6064.575479716377, 6177.104319873593, 5889.646621202742, 6019.458248757545, 6021.307549631849, 6067.938110830587, 6106.603070800384, 6088.014439713239, 6137.8979746733885, 6149.692515374213, 6163.476104531075, 6176.413240742122, 4747.62019038483, 4834.057358814997, 4903.803847846046, 4913.582345500601, 4930.482299358588, 4354.782260886943, 4360.236958532244, 4408.030233348658, 4431.734095954189, 4507.2112380333965, 5677.14842773579, 5678.77284908599, 5680.261565996394, 5701.2588363513305, 5701.344345400249, 6212.099245609361, 6226.40849119333, 6235.937640623626, 6240.719167637467, 6247.96876015617, 5509.724513774296, 5532.0, 5544.445555444504, 5619.381867994517, 5636.436356364331, 5372.059889519319, 5372.194170874322, 5391.919121213185, 5401.4868587484125, 5413.323334583177, 6363.3000369958345, 6366.9681651591445, 6369.777057802955, 6370.490360771035, 6380.617162970237, 6005.039193728982, 6043.8186854394435, 6059.545534084873, 6225.252969643671, 6255.093011513396, 6281.089242059785, 6350.90473642905, 6355.237371515263, 6372.171617689856, 6380.0, 6088.543359247986, 6132.6627035513475, 6139.386061393825, 6148.723307451086, 6158.076288556752, 5914.467697907209, 6187.907181392193, 6219.844503887439, 6231.594946328474, 6263.279722831932, 5801.245838041028, 5853.560982926212, 5866.3547009828035, 5904.940950590611, 6014.458698717136, 5973.0, 5974.342822289632, 5979.701014949148, 5984.970075149597, 5986.790462333972, 5603.0, 5804.912926306024, 5805.593608447368, 5830.387809279964, 5831.212786273968, 5785.884282314414, 5826.912596310974, 5920.644761314335, 5922.703864806656, 5960.552958528041, 5886.205362276038, 5893.764249429974, 5899.056151015817, 5899.557533185114, 5927.9703601481715], "value": 5637.2752319984265, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [480.2747850745375, 543.8042304770281, 544.6704743630104, 554.1770470850784, 558.9212819258829, 33025.834870825645, 33874.32251354974, 35175.12062198443, 35230.64769352306, 43577.0, 45517.54482455175, 46110.76944615272, 46138.0, 46152.07695846081, 46169.538304616945, 9938.652147174833, 10015.349002314826, 10049.64826231082, 10115.039071288253, 10180.287379883412, 9239.122283383067, 9531.285153613471, 9833.704988850346, 9963.800723985516, 9965.35225210359, 9746.756331091708, 12581.993440524737, 12613.243205407705, 12746.362681865916, 12748.681282967907, 12438.81341779874, 12503.874961250453, 12506.999440044865, 12509.499620015189, 12515.999999999955, 11960.043196544255, 12030.69923251917, 12032.639020829301, 12036.277823330629, 12042.578509752204, 42708.0, 43019.70940871779, 43072.56927430717, 43099.569004310186, 43131.56868431307, 3383.2895092030703, 3442.345954268706, 3600.837962291703, 3636.5090712753704, 4102.630763231324, 31906.042818715243, 32571.185720356945, 32587.0, 32812.6718732812, 33111.50332745011, 3248.902532924016, 3326.7342492464277, 3368.781029233092, 3467.0, 3493.12671832042, 435189.0, 436628.0, 438895.0, 438912.0, 439799.0, 63172.736545269756, 63527.0, 63609.72780544363, 63657.36342636514, 63825.680871595345, 36271.818640906626, 36842.447363289575, 36941.445878311846, 38201.61798381981, 38270.234595307935, 17922.462326130237, 18116.0, 18124.275028998956, 18144.0, 18159.546011349823, 13630.250336231404, 13720.588382348546, 13748.243846588333, 13784.0, 13790.793138102936, 17925.0, 18247.54381140482, 20393.286234981704, 20437.182512699623, 20707.689384659243, 7157.606331651705, 7953.6818527258265, 8051.919480805234, 8071.717489887943, 8104.351651867836, 870.8911386076741, 994.3238597753597, 1030.9742256443649, 1033.617561502249, 1057.9259451838452, 30963.225919351746, 31108.688913110578, 31472.0, 31479.550862211163, 31680.36639267248, 1062.1449732964884, 1095.4905968724581, 1129.7288650723767, 1144.7481554058095, 1207.2575366149931, 16142.75785863213, 16470.176491175393, 16472.25874835635, 16656.485440847242, 16772.832271677373, 723114.0, 729181.0, 730420.0, 731151.0, 731376.0, 62980.0, 63366.36633633697, 63438.0, 63567.36432635707, 63793.68103159455, 1407.422956587794, 1415.5611760354323, 1446.0817380963165, 1449.0074299105147, 1450.166154461189, 27009.45981080328, 29880.103596892128, 30643.846780765954, 30978.521718262033, 31761.0, 54834.72582637061, 55139.44860551343, 55191.72404137954, 55210.723946380014, 55301.0, 635234.0, 635917.0, 637007.0, 637304.0, 637462.0, 24751.0, 26531.0, 28202.71797282001, 28306.009289674763, 28603.9988600398, 49579.50420495893, 49634.75182624064, 50409.74795126001, 50465.74767126141, 50779.74610126926, 36439.45340819943, 40222.99442513961, 40267.84870329255, 41104.58895411008, 43379.78310108429, 41699.58300416957, 41838.0, 41987.1602567953, 43029.0, 43122.0, 39790.403143953445, 40156.0, 40264.194716104925, 40265.0, 40689.59310406858, 34827.477587835696, 35972.877710735534, 36389.09027274339, 36507.634923650425, 36535.63464365429, 26537.33656658599, 26648.20055398341, 26839.73160268372, 26859.731402685724, 27410.5888411678], "value": 21005.7419586203, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [367.75728019507113, 387.6317498376542, 389.9509636663188, 395.4858683711176, 415.03504352380725, 14340.0, 20116.497087572818, 21477.9595938386, 21502.89248553755, 21505.569888602236, 16631.251593678284, 19010.42968710941, 20974.37076887692, 21232.726036437787, 21479.140834366644, 5934.732937017845, 6271.996480563111, 6277.435030847223, 6280.497560195174, 6286.874262514747, 6021.668808215546, 6169.691515424233, 6201.627902325852, 6297.370262973689, 6364.936350636481, 6363.649999250039, 6375.904361434582, 6388.233411990567, 6392.744290228408, 6394.040893865934, 6068.059450785136, 6206.317305096459, 6269.62382257066, 6276.874462510724, 6284.4344009039405, 5833.300003999547, 6027.005544085221, 6066.302375226817, 6077.544184186204, 6175.042868355412, 11179.217454778169, 11304.717382065432, 19449.02754862251, 20743.481412964797, 26391.94432222709, 2089.1643342662906, 2276.4195130241847, 2287.79409853114, 2736.7263273672675, 2796.3708165662765, 10029.348092373972, 10127.987201279886, 10308.175345972304, 10662.0, 10756.031957123818, 1773.8403543681002, 1880.1445342369188, 1892.0728842866897, 1937.1766999025358, 1986.2849374225268, 122222.388888055, 125283.0, 126687.49843761754, 131145.0, 134266.32866835702, 9541.952290238643, 9826.459544725109, 11538.480768365444, 11547.4803633835, 11765.764684706259, 14976.026558273677, 14988.925055374653, 14991.775123373158, 14999.0, 15028.849711502746, 6831.351021652935, 7969.681212751541, 8396.07643159252, 8535.274501667427, 8547.658093676184, 7447.515911465737, 8579.914200858037, 8940.910590894138, 9104.954475227581, 9113.088691130833, 4524.072565124142, 4592.0, 4601.700889442175, 4609.976950115228, 4697.060587882437, 1772.6337646357483, 1797.2182100785938, 1819.1789485125737, 1903.8762480438727, 1936.7288579598867, 859.2009431228892, 896.8609865470862, 902.2105657549644, 949.1457688080644, 1010.9241806864515, 20373.898130509253, 20613.484662883548, 20762.48093797637, 21111.894440528005, 21370.0, 910.7905181808088, 966.8066386722543, 969.5540051576213, 986.5412583148727, 994.9403035817874, 10717.410542420086, 11093.394646739842, 11125.777484450266, 11196.832047519294, 11201.495932683049, 633585.0, 645314.7734261298, 647021.7648911725, 647297.7635111795, 650912.0, 116161.0, 130939.34530327478, 134301.0, 157945.0, 158346.2082689579, 1001.5893483671659, 1029.1149611334247, 1041.4116024446164, 1047.2930771729052, 1049.3494033699003, 18319.450416487525, 18911.243550257837, 19488.512787179865, 19583.60832783365, 19614.0, 58493.4150658505, 58729.82540349255, 59804.9068282608, 60454.39545604488, 60841.0, 86334.56832715796, 86970.0, 89070.55464722635, 90695.0, 90992.0, 8104.79738006531, 8194.38542109356, 8346.207110324509, 8356.247937685637, 8382.958085209535, 12027.639170824888, 12806.975441964434, 12972.0, 13018.218906865619, 13466.730665386833, 10976.0, 11129.83305250438, 11148.888511114785, 11351.0, 11499.770004600028, 9507.334486585873, 9625.32622716403, 10656.520456579317, 10850.945745271223, 11214.55141794319, 9145.634174633205, 11356.148288878201, 11422.428878555873, 11554.537818487166, 11556.479958401724, 8138.796530086795, 8286.83426331482, 8357.038940521674, 8383.622736976973, 8414.495130292202, 9474.621015159317, 11014.39420831862, 11141.441915406796, 11524.596639117926, 11595.304281743123], "value": 9722.222204283724, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1229.3115855121139, 1552.9689406211874, 1578.2818817438063, 1778.1020584604773, 1927.1424216223786, 8004.119546849849, 8532.018817835951, 8928.955355223223, 9272.582733776979, 9276.58255378508, 9157.313201509896, 9255.583498742555, 9259.907400926006, 9298.442093474396, 9315.534223288825, 2440.10936008357, 2470.6170543565777, 2472.8269021168526, 2473.492933948536, 2474.40614252579, 2400.135951057618, 2462.1259452894233, 2462.569050416179, 2463.4457247119435, 2463.963040554393, 2411.963820542693, 2437.902483900642, 2459.3359792855917, 2461.4461746107163, 2465.3097132802754, 2397.328153492435, 2423.1761201191593, 2425.866577338246, 2441.182203961675, 2441.9511609767883, 2343.683602713646, 2413.915512957038, 2416.275117464771, 2422.733499315074, 2424.818138639609, 8251.876221856677, 8509.659613615448, 9195.816083678355, 9196.0, 9318.30112741547, 5365.919511207335, 5557.249771280865, 5560.805371811967, 5607.214989901417, 5627.71861406928, 3650.5254316938626, 3655.3603119453987, 3695.0, 3739.2521495700967, 3742.045778326509, 1129.4691494997421, 1131.095123900876, 1134.8014097532898, 1142.691473302212, 1153.544349981761, 12492.875071249262, 12571.811422828665, 12591.874081259253, 12619.621411357673, 12637.43131559082, 4830.2513110467935, 4870.756462176877, 4918.803247870045, 5010.398752149766, 5043.823466178666, 10448.0, 10453.21600879937, 10466.790664186827, 10471.738206544896, 10519.631812886666, 5598.272224610774, 5601.7759289628775, 5612.775488980476, 5614.775408983676, 5626.409227031103, 5005.099082165245, 5081.5426611605135, 5109.770060347293, 5129.410117836496, 5138.486151384832, 4080.367543030835, 4083.1017176221185, 4128.566500517462, 4184.309588917795, 4184.8744537663915, 1147.977040459203, 1296.4360503180958, 1318.4660212613908, 1323.589687196972, 1345.2735522817763, 918.875951746519, 920.5708734962345, 933.6498812945146, 946.5551190940247, 979.6669132494986, 5809.477147056785, 5915.497182739429, 5964.31410387811, 6182.578007058401, 6247.875042499125, 448.97306161630405, 457.8832397738555, 459.21474278982646, 465.5367908930568, 472.02291257098165, 3908.5309762828642, 3921.941170882439, 4003.8999025024023, 4032.5160980681917, 4073.5538883695863, 10524.473776311153, 11238.269512481662, 11378.260413073123, 11400.0, 11453.0, 11149.690203238764, 11198.552057917592, 11333.716657083638, 11351.091912646969, 11383.430828458544, 8422.915770842214, 8633.136686331442, 8635.272945410943, 8648.1784230498, 8657.783555411039, 5738.282714660668, 5761.251037365116, 5875.441833025856, 5930.28836539618, 5959.791407300723, 10307.484625768531, 10329.967003299911, 10391.428471434143, 10468.0, 10512.316699414514, 10032.297739158188, 10411.11505522039, 10429.322094063862, 10627.202959777893, 10631.936806319307, 7778.727744528915, 7927.643256053607, 7950.761477155695, 7959.323457506177, 7964.0, 8389.706360277361, 8447.281981031681, 8538.44500107491, 8538.487690738575, 8587.699430519902, 7539.962300188464, 7692.115406728298, 7792.649330780242, 7833.060032795873, 7840.333571646246, 7529.736459223901, 7588.582627955516, 7594.6202689866395, 7633.427492937941, 7641.7707468776025, 7043.964780176067, 7126.608036557832, 7225.988361629271, 7228.63856807168, 7253.165885923187, 4953.529414705597, 4963.454020057863, 4992.475790041994, 5024.4473107957365, 5042.0, 4759.5240475953515, 4954.900901981868, 5100.69395836251, 5132.695809658419, 5177.042247184283], "value": 4664.3681589574835, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [295.5124045325213, 307.60011984420237, 313.0670601607211, 315.76633291364385, 320.2410287618345, 4690.077068401952, 4994.875128121799, 5221.556167725743, 5311.760970756315, 5365.302510673617, 4720.362751028611, 4770.990460016977, 4961.5286547778, 5088.592912566995, 5112.8977420451565, 3484.4250698634696, 3808.2954653389074, 3996.3215449511276, 4014.7791871447057, 4041.3533834586474, 3465.6187819339852, 3494.650534946498, 3947.151362457071, 3995.7802320872343, 4001.9199616007663, 3525.0389672674946, 3733.589305176442, 3890.280298144838, 3971.5035620547433, 3989.404238304672, 3464.834478450968, 3500.877469288588, 4001.679865610744, 4002.0, 4019.7387169834014, 3501.632328605511, 3513.2095278562374, 3524.7708898921487, 3553.928921421583, 3564.679178873888, 4747.762611869427, 5112.082968886668, 5126.948730512684, 5175.938932518825, 5184.481551844823, 4427.756473393962, 4568.588827005552, 4604.424446944132, 4617.330487079388, 4631.698939568917, 4577.29051996941, 4698.577128058491, 5197.194434862565, 5477.917831232495, 5527.010276300529, 3863.600031971847, 3885.708571857122, 3887.844486220548, 3904.9219015619815, 3923.901902452433, 5180.870478238036, 5494.587905907033, 5728.081092833906, 5794.913076303858, 5854.941450585482, 3942.940855887164, 3966.662833659171, 3970.662493688011, 3971.543272523639, 3971.6028397160053, 3504.7546671732734, 3917.7257591968287, 3956.872291396938, 4039.6970227233073, 4068.816903239361, 3696.0205545530457, 3870.9225815483533, 4434.046679963823, 4615.200191800557, 4637.976810115928, 4760.85761407368, 5315.554844771371, 5526.281583394133, 5526.364468086141, 5578.553715702734, 1145.9598914038136, 1367.2138520350838, 1367.6444124527695, 1373.3064802274787, 1374.3952660829202, 756.5385115079797, 770.3144201660526, 873.7116751471999, 873.9861760358082, 942.8067246214509, 4645.607512131255, 4775.689580177277, 5220.295260139908, 5250.606204534675, 5280.709560974106, 5422.580596813585, 5430.185472179126, 5549.809893530359, 5643.939961913954, 5741.540676745851, 4426.402435671143, 4487.4839393470165, 5197.7401129943355, 5204.7099276318295, 5212.661177023557, 2688.5832695932163, 2899.1302609217573, 2928.8974885878893, 2943.543750718642, 2944.455275773989, 5044.974775126101, 5401.4868587484125, 5450.618456707993, 5609.467100625434, 5817.418258174149, 4490.528494508095, 4627.930581041287, 5724.284464441945, 5736.62711923732, 5776.133579963039, 4626.606738427271, 5532.514515854986, 5579.856129493444, 5716.742746576414, 5730.512906402919, 5030.270610761492, 5042.722650254272, 5087.745612719275, 5215.635914834986, 5580.665160090408, 5011.974940125276, 5383.973080134574, 5497.780088796403, 5513.566472717042, 5513.972430137824, 5001.1495746574, 5765.91351129725, 5777.9133313001175, 5783.595148339744, 5794.275715535558, 3156.2267244525237, 3281.52417899408, 3729.68297694699, 3879.6314350137823, 3896.4350169224736, 4872.0, 5070.290159377616, 5575.832725018256, 5582.784997326992, 5671.517920976763, 4753.5008824072975, 4871.561559459524, 5290.232916227049, 5366.443731317874, 5441.29263195782, 5107.514786095315, 5264.814787053931, 5489.945100548944, 5629.324481062299, 5660.85847853807, 5216.582673386044, 5398.811041613525, 5529.815722789556, 5542.944570554404, 5546.528545073553, 4695.671303008757, 5401.864953376197, 5631.380548139619, 5644.9435505644415, 5661.377248502744, 5516.531094856821, 5521.585881058856, 5534.335879694462, 5548.528375088163, 5549.528290095225], "value": 4008.1137053821544, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [732.5824280160307, 794.5987276425404, 820.712750537312, 827.1480375213529, 866.3675516872687, 15272.770908436383, 15364.769528457082, 15479.922600386997, 16219.270132844036, 16377.590560236, 15209.92395038026, 15319.463818766346, 15353.462628807994, 15364.539063828075, 15373.69252614947, 742.3838214282133, 760.0878945265704, 900.3022657440487, 904.5386852705102, 920.558132096594, 919.3794188922484, 937.5499760115115, 942.0673533202149, 944.6127087893965, 944.6646440513622, 987.7431867714411, 988.9615903301541, 989.8317286061387, 991.192178374626, 998.6205242008027, 978.2516374973151, 979.9167070798991, 982.9973427104385, 984.1732944326764, 988.6440881282697, 732.143392231091, 733.4792297468804, 734.0200831889434, 736.282124928196, 736.977890663281, 15421.614459638598, 15884.602884927854, 16007.27967241477, 16067.0, 16071.116088615121, 13450.394732237073, 13493.730125397436, 13555.661108472366, 13968.022238443313, 15161.848381516154, 11806.586769463114, 12887.291198984052, 13459.798103028463, 13663.248521331323, 13906.235157066358, 3931.6264954829244, 4052.49343832021, 4112.629863312316, 4604.033153037866, 4713.811447542094, 106988.0, 107000.92999069988, 109902.45048774785, 110023.44988275088, 113979.0, 11128.38793866345, 11263.831042534368, 11383.943080284545, 11400.48697808584, 11419.371934543513, 22716.772832271796, 22718.772812271996, 22745.431364216027, 22777.544449110927, 23167.3049808506, 8075.838483230303, 8139.95930020358, 8208.348098644012, 8223.629936652866, 8240.62917168729, 4335.67482438812, 4388.692791504564, 4575.931361029588, 4659.976700116477, 4666.533346665374, 3599.2441587266967, 3727.5713292971654, 3760.6615404613717, 3762.2099359134886, 3762.3039737648073, 671.4762485261504, 674.6727836999052, 676.2966514824626, 682.576802382526, 698.6436917172279, 613.4601550635413, 674.9898751518731, 675.2133764164693, 680.5134328954821, 684.2302409788988, 8850.690225842065, 9528.285378596633, 9534.332596718303, 9716.61133554664, 9862.802743945082, 607.7933502609134, 662.4170729757782, 675.9087523184307, 684.1209046375384, 698.3679769808332, 4489.506154323022, 4498.8425405110665, 4667.0, 4690.530946905282, 4703.795637073423, 114967.0, 151835.48164518212, 162480.0, 166985.0, 167387.1630641839, 127536.0, 127835.0, 130235.34882325717, 134975.0, 138569.3071534656, 76210.61894690491, 101997.49001254946, 102271.4886425578, 104530.95469045364, 104545.54544545485, 8882.467051976902, 8940.46357218569, 8942.37403381757, 8996.86504702443, 8998.14517620825, 66560.33439665541, 66691.33271668052, 67021.3297867015, 68533.31466685269, 68969.65515172391, 66337.33662663311, 70815.64592177006, 97957.06128816147, 102346.97653023375, 104121.0, 11177.385243811668, 11343.886561134283, 11442.42787860587, 11568.942155289169, 11585.6524304271, 12811.359432028175, 12918.741625167631, 13060.732655815103, 13163.276019819003, 13960.952928530198, 12063.276203427822, 12523.0, 13064.869351306364, 13202.669933251746, 13215.933920330337, 12419.93790031044, 12599.559015434415, 12840.101192916407, 12945.09384343087, 13131.60605181846, 11596.188266821579, 11794.882051179378, 11852.288862668267, 12131.090168237593, 12573.622791316275, 10302.278840481094, 10389.584416623553, 10501.9474902625, 10844.295120817122, 11268.718282042686, 7730.497517661334, 10195.949020254851, 11035.282706624044, 11063.391513466515, 11104.944475277573], "value": 7936.329054336904, "unit": "score"}], "name": "dromaeo_css", "value": 7448.960622179903, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 167.0, 147.0, 114.0, 114.0, 114.0, 113.0, 113.0, 115.0, 113.0], "value": 126.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 107.0, 106.0, 142.0, 109.0, 108.0, 107.0, 109.0, 137.0, 109.0], "value": 117.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 182.0, 183.0, 190.0, 182.0, 181.0, 183.0, 183.0, 183.0, 183.0], "value": 183.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 58.0, 58.0, 90.0, 75.0, 76.0, 58.0, 57.0, 80.0, 56.0], "value": 68.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 68.0, 114.0, 101.0, 97.0, 100.0, 94.0, 67.0, 68.0, 89.0], "value": 88.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 87.0, 135.0, 88.0, 87.0, 84.0, 88.0, 84.0, 87.0, 84.0], "value": 91.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 92.0, 91.0, 93.0, 93.0, 92.0, 93.0, 92.0, 92.0, 92.0], "value": 92.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 85.0, 84.0, 87.0, 84.0, 99.0, 133.0, 130.0, 84.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 51.0, 53.0, 52.0, 55.0, 58.0, 58.0, 57.0, 56.0, 55.0], "value": 54.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 78.0, 73.0, 74.0, 71.0, 67.0, 69.0, 69.0, 69.0, 69.0], "value": 70.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 81.0, 81.0, 81.0, 81.0, 82.0, 77.0, 88.0, 85.0, 87.0], "value": 82.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 133.0, 136.0, 136.0, 135.0, 136.0, 137.0, 136.0, 168.0, 145.0], "value": 140.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 160.0, 159.0, 164.0, 158.0, 159.0, 160.0, 159.0, 158.0, 161.0], "value": 159.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 65.0, 66.0, 65.0, 64.0, 76.0, 57.0, 64.0, 64.0], "value": 65.2, "unit": "score"}], "name": "kraken", "value": 1436.8, "alertThreshold": 2.0}]} 15:26:12 INFO - Return code: 0 15:26:12 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:26:12 INFO - # TBPL SUCCESS # 15:26:12 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:26:12 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:26:12 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:26:12 INFO - 2017-01-09 15:26:12.120 screenresolution[1650:9847] starting screenresolution argv=screenresolution get 15:26:12 INFO - 2017-01-09 15:26:12.123 screenresolution[1650:9847] Display 0: 1600x1200x32@60 15:26:12 INFO - 2017-01-09 15:26:12.129 screenresolution[1651:9850] starting screenresolution argv=screenresolution list 15:26:12 INFO - Available Modes on Display 0 15:26:12 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:26:12 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:26:12 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:26:12 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:26:12 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:26:12 INFO - Intel Iris: 15:26:12 INFO - Chipset Model: Intel Iris 15:26:12 INFO - Type: GPU 15:26:12 INFO - Bus: Built-In 15:26:12 INFO - VRAM (Dynamic, Max): 1536 MB 15:26:12 INFO - Vendor: Intel (0x8086) 15:26:12 INFO - Device ID: 0x0a2e 15:26:12 INFO - Revision ID: 0x0009 15:26:12 INFO - Displays: 15:26:12 INFO - Display: 15:26:12 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:26:12 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:26:12 INFO - Display Serial Number: 1600x1200 60 15:26:12 INFO - Main Display: Yes 15:26:12 INFO - Mirror: Off 15:26:12 INFO - Online: Yes 15:26:12 INFO - Rotation: Supported 15:26:12 INFO - Return code: 0 15:26:12 INFO - Running post-action listener: _resource_record_post_action 15:26:12 INFO - [mozharness: 2017-01-09 23:26:12.363396Z] Finished run-tests step (success) 15:26:12 INFO - Running post-run listener: _resource_record_post_run 15:26:12 INFO - Total resource usage - Wall time: 1195s; CPU: 53.0%; Read bytes: 38597632; Write bytes: 494865920; Read time: 382; Write time: 1605 15:26:12 INFO - TinderboxPrint: CPU usage
53.2% 15:26:12 INFO - TinderboxPrint: I/O read bytes / time
38,597,632 / 382 15:26:12 INFO - TinderboxPrint: I/O write bytes / time
494,865,920 / 1,605 15:26:12 INFO - TinderboxPrint: CPU idle
2,239.1 (46.8%) 15:26:12 INFO - TinderboxPrint: CPU system
951.5 (19.9%) 15:26:12 INFO - TinderboxPrint: CPU user
1,591.1 (33.3%) 15:26:12 INFO - TinderboxPrint: Swap in / out
233,709,568 / 0 15:26:12 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 192725504; Write bytes: 188647424; Read time: 17914; Write time: 429 15:26:12 INFO - run-tests - Wall time: 1174s; CPU: 53.0%; Read bytes: 36529152; Write bytes: 294970880; Read time: 359; Write time: 1139 15:26:12 INFO - Running post-run listener: _upload_blobber_files 15:26:12 INFO - Blob upload gear active. 15:26:12 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:26:12 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 15:26:12 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'] 15:26:12 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 15:26:13 INFO - (blobuploader) - INFO - Open directory for files ... 15:26:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 15:26:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:26:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:26:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 15:26:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:26:14 INFO - (blobuploader) - INFO - Done attempting. 15:26:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 15:26:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:26:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:26:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 15:26:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:26:15 INFO - (blobuploader) - INFO - Done attempting. 15:26:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:26:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:26:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:26:17 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:26:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:26:17 INFO - (blobuploader) - INFO - Done attempting. 15:26:17 INFO - (blobuploader) - INFO - Iteration through files over. 15:26:17 INFO - Return code: 0 15:26:17 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:26:17 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:26:17 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/29d242abf81ae643f3b8ce754a7f606d56db3b9f96cee386402e1eeb87b595b209ebb1e77432e7e9b14c81ba3be1741c57decd51e5eb28d83ba07e3fd6d52f2e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/fb13f95937eed2fd6ceaf539f7059129ca2ffd3da182f942972fcfa1a2fa602906152eca0e0f37f6cb4e34572d67282838315c81a8b953b923a3147bdca8a480", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3d47f35bcf62e66625094e1cf43f321c1bfa491f5f6d818b689efe93bd76dbdd9ee12af589733cf96cd2c8616c60a20608f53851b7a6b2436caa19c7c9a50793"} 15:26:17 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:26:17 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:26:17 INFO - Contents: 15:26:17 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/29d242abf81ae643f3b8ce754a7f606d56db3b9f96cee386402e1eeb87b595b209ebb1e77432e7e9b14c81ba3be1741c57decd51e5eb28d83ba07e3fd6d52f2e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/fb13f95937eed2fd6ceaf539f7059129ca2ffd3da182f942972fcfa1a2fa602906152eca0e0f37f6cb4e34572d67282838315c81a8b953b923a3147bdca8a480", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3d47f35bcf62e66625094e1cf43f321c1bfa491f5f6d818b689efe93bd76dbdd9ee12af589733cf96cd2c8616c60a20608f53851b7a6b2436caa19c7c9a50793"} 15:26:17 INFO - Running post-run listener: copy_logs_to_upload_dir 15:26:17 INFO - Copying logs to upload dir... 15:26:17 INFO - mkdir: /builds/slave/test/build/upload/logs 15:26:17 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1256.485606 ========= master_lag: 0.65 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2017-01-09 15:26:18.248892) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-09 15:26:18.252549) ========= 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.8NJK9w26zb/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.OEBvZDg494/Listeners TMPDIR=/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/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/29d242abf81ae643f3b8ce754a7f606d56db3b9f96cee386402e1eeb87b595b209ebb1e77432e7e9b14c81ba3be1741c57decd51e5eb28d83ba07e3fd6d52f2e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/fb13f95937eed2fd6ceaf539f7059129ca2ffd3da182f942972fcfa1a2fa602906152eca0e0f37f6cb4e34572d67282838315c81a8b953b923a3147bdca8a480", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3d47f35bcf62e66625094e1cf43f321c1bfa491f5f6d818b689efe93bd76dbdd9ee12af589733cf96cd2c8616c60a20608f53851b7a6b2436caa19c7c9a50793"} build_url:https://queue.taskcluster.net/v1/task/Wl-xMYITSXKUCQXPkTssxw/artifacts/public/build/firefox-51.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011140 build_url: 'https://queue.taskcluster.net/v1/task/Wl-xMYITSXKUCQXPkTssxw/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/29d242abf81ae643f3b8ce754a7f606d56db3b9f96cee386402e1eeb87b595b209ebb1e77432e7e9b14c81ba3be1741c57decd51e5eb28d83ba07e3fd6d52f2e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/fb13f95937eed2fd6ceaf539f7059129ca2ffd3da182f942972fcfa1a2fa602906152eca0e0f37f6cb4e34572d67282838315c81a8b953b923a3147bdca8a480", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3d47f35bcf62e66625094e1cf43f321c1bfa491f5f6d818b689efe93bd76dbdd9ee12af589733cf96cd2c8616c60a20608f53851b7a6b2436caa19c7c9a50793"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-09 15:26:18.292124) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-09 15:26:18.292461) ========= 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.8NJK9w26zb/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.OEBvZDg494/Listeners TMPDIR=/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/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.005321 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-09 15:26:18.341635) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-09 15:26:18.341956) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-09 15:26:18.342277) ========= ========= Total master_lag: 0.79 =========