builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0150 starttime: 1489121105.66 results: success (0) buildid: 20170309192825 builduid: 8289c6876cfa4093ac4400d2737b928d revision: e2752c5516c107c4c8a3edf7be91b2fd15c56a3b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-09 20:45:05.655937) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-09 20:45:05.662150) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-09 20:45:05.662436) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-09 20:45:05.689736) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-09 20:45:05.690115) ========= 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.dsjHeaMubX/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.19kSzTeGsf/Listeners TMPDIR=/var/folders/f4/zwr2n_y50tg1y44pl818tgt800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-03-09 20:45:05-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 27.7M=0s 2017-03-09 20:45:05 (27.7 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.142243 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-09 20:45:05.856705) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-09 20:45:05.857022) ========= 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.dsjHeaMubX/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.19kSzTeGsf/Listeners TMPDIR=/var/folders/f4/zwr2n_y50tg1y44pl818tgt800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.026946 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-09 20:45:05.905636) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-09 20:45:05.905998) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev e2752c5516c107c4c8a3edf7be91b2fd15c56a3b --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 e2752c5516c107c4c8a3edf7be91b2fd15c56a3b --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.dsjHeaMubX/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.19kSzTeGsf/Listeners TMPDIR=/var/folders/f4/zwr2n_y50tg1y44pl818tgt800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-03-09 20:45:06,015 truncating revision to first 12 chars 2017-03-09 20:45:06,015 Setting DEBUG logging. 2017-03-09 20:45:06,016 attempt 1/10 2017-03-09 20:45:06,016 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/e2752c5516c1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-09 20:45:06,911 unpacking tar archive at: mozilla-beta-e2752c5516c1/testing/mozharness/ program finished with exit code 0 elapsedTime=1.191769 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-09 20:45:07.121316) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-09 20:45:07.121638) ========= script_repo_revision: e2752c5516c107c4c8a3edf7be91b2fd15c56a3b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-09 20:45:07.122055) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-09 20:45:07.122323) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-09 20:45:07.141891) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2017-03-09 20:45:07.142217) ========= /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.dsjHeaMubX/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.19kSzTeGsf/Listeners TMPDIR=/var/folders/f4/zwr2n_y50tg1y44pl818tgt800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 20:45:07 INFO - MultiFileLogger online at 20170309 20:45:07 in /builds/slave/test 20:45:07 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 20:45:07 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:45:07 INFO - {'append_to_log': False, 20:45:07 INFO - 'base_work_dir': '/builds/slave/test', 20:45:07 INFO - 'blob_upload_branch': 'Mozilla-Beta', 20:45:07 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:45:07 INFO - 'branch': 'Mozilla-Beta', 20:45:07 INFO - 'buildbot_json_path': 'buildprops.json', 20:45:07 INFO - 'config_files': ('talos/mac_config.py',), 20:45:07 INFO - 'default_actions': ('clobber', 20:45:07 INFO - 'read-buildbot-config', 20:45:07 INFO - 'download-and-extract', 20:45:07 INFO - 'populate-webroot', 20:45:07 INFO - 'create-virtualenv', 20:45:07 INFO - 'install', 20:45:07 INFO - 'run-tests'), 20:45:07 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:45:07 INFO - 'download_minidump_stackwalk': True, 20:45:07 INFO - 'download_symbols': 'ondemand', 20:45:07 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:45:07 INFO - 'tooltool.py': '/tools/tooltool.py', 20:45:07 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:45:07 INFO - '/tools/misc-python/virtualenv.py')}, 20:45:07 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:45:07 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:45:07 INFO - 'installer_path': 'installer.exe', 20:45:07 INFO - 'log_level': 'info', 20:45:07 INFO - 'log_name': 'talos', 20:45:07 INFO - 'log_to_console': True, 20:45:07 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 20:45:07 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 20:45:07 INFO - 'opt_config_files': (), 20:45:07 INFO - 'pip_index': False, 20:45:07 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 20:45:07 INFO - 'cmd': ('bash', 20:45:07 INFO - '-c', 20:45:07 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 20:45:07 INFO - 'enabled': True, 20:45:07 INFO - 'halt_on_failure': False, 20:45:07 INFO - 'name': 'check_screen_resolution'},), 20:45:07 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 20:45:07 INFO - 'cmd': ('bash', 20:45:07 INFO - '-c', 20:45:07 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 20:45:07 INFO - 'enabled': True, 20:45:07 INFO - 'halt_on_failure': False, 20:45:07 INFO - 'name': 'check_screen_resolution'},), 20:45:07 INFO - 'run_cmd_checks_enabled': True, 20:45:07 INFO - 'sps_profile': False, 20:45:07 INFO - 'sps_profile_interval': 0, 20:45:07 INFO - 'suite': 'dromaeojs', 20:45:07 INFO - 'system_bits': '32', 20:45:07 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:45:07 INFO - 'title': 't-yosemite-r7-0150', 20:45:07 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:45:07 INFO - 'use_talos_json': True, 20:45:07 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:45:07 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:45:07 INFO - 'work_dir': 'build'} 20:45:07 INFO - [mozharness: 2017-03-10 04:45:07.359544Z] Running clobber step. 20:45:07 INFO - Running pre-action listener: _resource_record_pre_action 20:45:07 INFO - Running main action method: clobber 20:45:07 INFO - rmtree: /builds/slave/test/build 20:45:07 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:45:09 INFO - Running post-action listener: _resource_record_post_action 20:45:09 INFO - [mozharness: 2017-03-10 04:45:09.897461Z] Finished clobber step (success) 20:45:09 INFO - [mozharness: 2017-03-10 04:45:09.897648Z] Running read-buildbot-config step. 20:45:09 INFO - Running pre-action listener: _resource_record_pre_action 20:45:09 INFO - Running main action method: read_buildbot_config 20:45:09 INFO - Using buildbot properties: 20:45:09 INFO - { 20:45:09 INFO - "project": "", 20:45:09 INFO - "product": "firefox", 20:45:09 INFO - "script_repo_revision": "production", 20:45:09 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 20:45:09 INFO - "repository": "", 20:45:09 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 20:45:09 INFO - "buildid": "20170309192825", 20:45:09 INFO - "pgo_build": "False", 20:45:09 INFO - "basedir": "/builds/slave/test", 20:45:09 INFO - "buildnumber": 1, 20:45:09 INFO - "slavename": "t-yosemite-r7-0150", 20:45:09 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 20:45:09 INFO - "platform": "yosemite_r7", 20:45:09 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 20:45:09 INFO - "branch": "mozilla-beta", 20:45:09 INFO - "repo_path": "releases/mozilla-beta", 20:45:09 INFO - "revision": "e2752c5516c107c4c8a3edf7be91b2fd15c56a3b", 20:45:09 INFO - "stage_platform": "macosx64", 20:45:09 INFO - "builduid": "8289c6876cfa4093ac4400d2737b928d", 20:45:09 INFO - "slavebuilddir": "test" 20:45:09 INFO - } 20:45:09 INFO - Found installer url https://queue.taskcluster.net/v1/task/TWx3h0TlQ4y4bu1e9lCaTw/artifacts/public/build/firefox-53.0.en-US.mac.dmg. 20:45:09 INFO - Running post-action listener: _resource_record_post_action 20:45:09 INFO - [mozharness: 2017-03-10 04:45:09.901098Z] Finished read-buildbot-config step (success) 20:45:09 INFO - [mozharness: 2017-03-10 04:45:09.901205Z] Running download-and-extract step. 20:45:09 INFO - Running pre-action listener: _resource_record_pre_action 20:45:09 INFO - Running main action method: download_and_extract 20:45:09 INFO - mkdir: /builds/slave/test/build/tests 20:45: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')]} 20:45:09 INFO - trying https://queue.taskcluster.net/v1/task/TWx3h0TlQ4y4bu1e9lCaTw/artifacts/public/build/firefox-53.0.en-US.mac.test_packages.json 20:45:09 INFO - Downloading https://queue.taskcluster.net/v1/task/TWx3h0TlQ4y4bu1e9lCaTw/artifacts/public/build/firefox-53.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0.en-US.mac.test_packages.json 20:45:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TWx3h0TlQ4y4bu1e9lCaTw/artifacts/public/build/firefox-53.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0.en-US.mac.test_packages.json'}, attempt #1 20:45:11 INFO - Downloaded 1165 bytes. 20:45:11 INFO - Reading from file /builds/slave/test/build/firefox-53.0.en-US.mac.test_packages.json 20:45:11 INFO - Using the following test package requirements: 20:45:11 INFO - {u'common': [u'firefox-53.0.en-US.mac.common.tests.zip'], 20:45:11 INFO - u'cppunittest': [u'firefox-53.0.en-US.mac.common.tests.zip', 20:45:11 INFO - u'firefox-53.0.en-US.mac.cppunittest.tests.zip'], 20:45:11 INFO - u'gtest': [u'firefox-53.0.en-US.mac.common.tests.zip', 20:45:11 INFO - u'firefox-53.0.en-US.mac.gtest.tests.zip'], 20:45:11 INFO - u'jittest': [u'firefox-53.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 20:45:11 INFO - u'mochitest': [u'firefox-53.0.en-US.mac.common.tests.zip', 20:45:11 INFO - u'firefox-53.0.en-US.mac.mochitest.tests.zip'], 20:45:11 INFO - u'mozbase': [u'firefox-53.0.en-US.mac.common.tests.zip'], 20:45:11 INFO - u'reftest': [u'firefox-53.0.en-US.mac.common.tests.zip', 20:45:11 INFO - u'firefox-53.0.en-US.mac.reftest.tests.zip'], 20:45:11 INFO - u'talos': [u'firefox-53.0.en-US.mac.common.tests.zip', 20:45:11 INFO - u'firefox-53.0.en-US.mac.talos.tests.zip'], 20:45:11 INFO - u'web-platform': [u'firefox-53.0.en-US.mac.common.tests.zip', 20:45:11 INFO - u'firefox-53.0.en-US.mac.web-platform.tests.zip'], 20:45:11 INFO - u'xpcshell': [u'firefox-53.0.en-US.mac.common.tests.zip', 20:45:11 INFO - u'firefox-53.0.en-US.mac.xpcshell.tests.zip']} 20:45:11 INFO - Downloading packages: [u'firefox-53.0.en-US.mac.common.tests.zip'] for test suite category: common 20:45:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TWx3h0TlQ4y4bu1e9lCaTw/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip 20:45:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TWx3h0TlQ4y4bu1e9lCaTw/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip'}, attempt #1 20:45:11 INFO - Fetch https://queue.taskcluster.net/v1/task/TWx3h0TlQ4y4bu1e9lCaTw/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip into memory 20:45:12 INFO - Expected file size: 16104030 20:45:12 INFO - Obtained file size: 16104030 20:45:19 INFO - Downloading packages: [u'firefox-53.0.en-US.mac.common.tests.zip', u'firefox-53.0.en-US.mac.talos.tests.zip'] for test suite category: talos 20:45:19 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TWx3h0TlQ4y4bu1e9lCaTw/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip 20:45:19 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TWx3h0TlQ4y4bu1e9lCaTw/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip'}, attempt #1 20:45:19 INFO - Fetch https://queue.taskcluster.net/v1/task/TWx3h0TlQ4y4bu1e9lCaTw/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip into memory 20:45:20 INFO - Expected file size: 16104030 20:45:20 INFO - Obtained file size: 16104030 20:45:26 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TWx3h0TlQ4y4bu1e9lCaTw/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip 20:45:26 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TWx3h0TlQ4y4bu1e9lCaTw/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip'}, attempt #1 20:45:26 INFO - Fetch https://queue.taskcluster.net/v1/task/TWx3h0TlQ4y4bu1e9lCaTw/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip into memory 20:45:28 INFO - Expected file size: 14403650 20:45:28 INFO - Obtained file size: 14403650 20:45:29 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')]} 20:45:29 INFO - trying https://queue.taskcluster.net/v1/task/TWx3h0TlQ4y4bu1e9lCaTw/artifacts/public/build/firefox-53.0.en-US.mac.dmg 20:45:29 INFO - Downloading https://queue.taskcluster.net/v1/task/TWx3h0TlQ4y4bu1e9lCaTw/artifacts/public/build/firefox-53.0.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0.en-US.mac.dmg 20:45:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TWx3h0TlQ4y4bu1e9lCaTw/artifacts/public/build/firefox-53.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0.en-US.mac.dmg'}, attempt #1 20:45:30 INFO - Downloaded 58691092 bytes. 20:45:30 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/TWx3h0TlQ4y4bu1e9lCaTw/artifacts/public/build/firefox-53.0.en-US.mac.dmg 20:45:30 INFO - mkdir: /builds/slave/test/properties 20:45:30 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:45:30 INFO - Writing to file /builds/slave/test/properties/build_url 20:45:30 INFO - Contents: 20:45:30 INFO - build_url:https://queue.taskcluster.net/v1/task/TWx3h0TlQ4y4bu1e9lCaTw/artifacts/public/build/firefox-53.0.en-US.mac.dmg 20:45:31 INFO - Running post-action listener: _resource_record_post_action 20:45:31 INFO - Running post-action listener: set_extra_try_arguments 20:45:31 INFO - [mozharness: 2017-03-10 04:45:31.528770Z] Finished download-and-extract step (success) 20:45:31 INFO - [mozharness: 2017-03-10 04:45:31.528885Z] Running populate-webroot step. 20:45:31 INFO - Running pre-action listener: _resource_record_pre_action 20:45:31 INFO - Running main action method: populate_webroot 20:45:31 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:45:31 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:45:31 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:45:31 INFO - '--tppagecycles', 20:45:31 INFO - '7'], 20:45:31 INFO - 'tests': ['tsvgm']}}, 20:45:31 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:45:31 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:45:31 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:45:31 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:45:31 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:45:31 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:45:31 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 20:45:31 INFO - 'talos_options': ['--disable-e10s'], 20:45:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:45:31 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 20:45:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:45:31 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 20:45:31 INFO - 'talos_options': ['--disable-e10s'], 20:45:31 INFO - 'tests': ['damp', 'tps']}, 20:45:31 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 20:45:31 INFO - 'tests': ['damp', 'tps']}, 20:45:31 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:45:31 INFO - 'tests': ['dromaeo_dom']}, 20:45:31 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:45:31 INFO - 'g4': {'talos_options': ['--disable-e10s'], 20:45:31 INFO - 'tests': ['basic_compositor_video']}, 20:45:31 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 20:45:31 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:45:31 INFO - 'tests': ['a11yr', 20:45:31 INFO - 'ts_paint', 20:45:31 INFO - 'tpaint', 20:45:31 INFO - 'sessionrestore', 20:45:31 INFO - 'sessionrestore_no_auto_restore', 20:45:31 INFO - 'tabpaint']}, 20:45:31 INFO - 'other-e10s': {'tests': ['a11yr', 20:45:31 INFO - 'ts_paint', 20:45:31 INFO - 'tpaint', 20:45:31 INFO - 'sessionrestore', 20:45:31 INFO - 'sessionrestore_no_auto_restore', 20:45:31 INFO - 'tabpaint']}, 20:45:31 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:45:31 INFO - 'ts_paint', 20:45:31 INFO - 'tpaint', 20:45:31 INFO - 'sessionrestore', 20:45:31 INFO - 'sessionrestore_no_auto_restore', 20:45:31 INFO - 'tabpaint']}, 20:45:31 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:45:31 INFO - 'ts_paint', 20:45:31 INFO - 'tpaint', 20:45:31 INFO - 'sessionrestore', 20:45:31 INFO - 'sessionrestore_no_auto_restore', 20:45:31 INFO - 'tabpaint']}, 20:45:31 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:45:31 INFO - 'tests': ['a11yr', 20:45:31 INFO - 'ts_paint', 20:45:31 INFO - 'tpaint', 20:45:31 INFO - 'sessionrestore', 20:45:31 INFO - 'sessionrestore_no_auto_restore', 20:45:31 INFO - 'tabpaint']}, 20:45:31 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:45:31 INFO - 'tests': ['a11yr', 20:45:31 INFO - 'ts_paint', 20:45:31 INFO - 'tpaint', 20:45:31 INFO - 'sessionrestore', 20:45:31 INFO - 'sessionrestore_no_auto_restore', 20:45:31 INFO - 'tabpaint']}, 20:45:31 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:45:31 INFO - 'tests': ['tsvgx', 20:45:31 INFO - 'tsvgr_opacity', 20:45:31 INFO - 'tart', 20:45:31 INFO - 'tscrollx', 20:45:31 INFO - 'cart', 20:45:31 INFO - 'tsvg_static']}, 20:45:31 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:45:31 INFO - 'tsvgr_opacity', 20:45:31 INFO - 'tart', 20:45:31 INFO - 'tscrollx', 20:45:31 INFO - 'cart', 20:45:31 INFO - 'tsvg_static']}, 20:45:31 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 20:45:31 INFO - 'talos_options': ['--disable-e10s'], 20:45:31 INFO - 'tests': ['tp5o']}, 20:45:31 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 20:45:31 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 20:45:31 INFO - 'talos_options': ['--disable-e10s', 20:45:31 INFO - '--xperf_path', 20:45:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:45:31 INFO - 'tests': ['tp5n']}, 20:45:31 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 20:45:31 INFO - 'talos_options': ['--xperf_path', 20:45:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:45:31 INFO - 'tests': ['tp5n']}}, 20:45:31 INFO - 'talos.zip': {'path': '', 20:45:31 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:45:31 INFO - Running post-action listener: _resource_record_post_action 20:45:31 INFO - [mozharness: 2017-03-10 04:45:31.547529Z] Finished populate-webroot step (success) 20:45:31 INFO - [mozharness: 2017-03-10 04:45:31.547623Z] Running create-virtualenv step. 20:45:31 INFO - Running pre-action listener: _resource_record_pre_action 20:45:31 INFO - Running main action method: create_virtualenv 20:45:31 INFO - Creating virtualenv /builds/slave/test/build/venv 20:45:31 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 20:45:31 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:45:31 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:45:31 INFO - Using real prefix '/tools/python27' 20:45:31 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:45:32 INFO - Installing distribute.............................................................................................................................................................................................done. 20:45:35 INFO - Installing pip.................done. 20:45:35 INFO - Return code: 0 20:45:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 20:45:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 20:45:35 INFO - Reading from file tmpfile_stdout 20:45:35 INFO - Output received: 20:45:35 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 20:45:35 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:45:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:45:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:45:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:45:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:45:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:45:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:45:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1074ffb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107502768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa5b3db3b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1072ddd30>, '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 0x107204db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1072d2be8>, '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.dsjHeaMubX/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.19kSzTeGsf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f4/zwr2n_y50tg1y44pl818tgt800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 20:45:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 20:45:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 20:45:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dsjHeaMubX/Render', 20:45:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:45:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:45:35 INFO - 'HOME': '/Users/cltbld', 20:45:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:45:35 INFO - 'LOGNAME': 'cltbld', 20:45:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:45:35 INFO - 'MOZ_NO_REMOTE': '1', 20:45:35 INFO - 'NO_EM_RESTART': '1', 20:45:35 INFO - 'PAGER': '/bin/cat', 20:45:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:45:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:45:35 INFO - 'PWD': '/builds/slave/test', 20:45:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:45:35 INFO - 'SHELL': '/bin/bash', 20:45:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.19kSzTeGsf/Listeners', 20:45:35 INFO - 'TMPDIR': '/var/folders/f4/zwr2n_y50tg1y44pl818tgt800000w/T/', 20:45:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:45:35 INFO - 'USER': 'cltbld', 20:45:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:45:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:45:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:45:35 INFO - 'XPC_FLAGS': '0x0', 20:45:35 INFO - 'XPC_SERVICE_NAME': '0', 20:45:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:45:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:45:35 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 20:45:35 INFO - Cleaning up... 20:45:35 INFO - Return code: 0 20:45:35 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 20:45:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:45:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:45:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:45:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:45:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:45:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:45:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1074ffb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107502768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa5b3db3b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1072ddd30>, '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 0x107204db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1072d2be8>, '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.dsjHeaMubX/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.19kSzTeGsf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f4/zwr2n_y50tg1y44pl818tgt800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 20:45:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 20:45:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 20:45:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dsjHeaMubX/Render', 20:45:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:45:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:45:35 INFO - 'HOME': '/Users/cltbld', 20:45:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:45:35 INFO - 'LOGNAME': 'cltbld', 20:45:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:45:35 INFO - 'MOZ_NO_REMOTE': '1', 20:45:35 INFO - 'NO_EM_RESTART': '1', 20:45:35 INFO - 'PAGER': '/bin/cat', 20:45:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:45:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:45:35 INFO - 'PWD': '/builds/slave/test', 20:45:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:45:35 INFO - 'SHELL': '/bin/bash', 20:45:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.19kSzTeGsf/Listeners', 20:45:35 INFO - 'TMPDIR': '/var/folders/f4/zwr2n_y50tg1y44pl818tgt800000w/T/', 20:45:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:45:35 INFO - 'USER': 'cltbld', 20:45:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:45:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:45:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:45:35 INFO - 'XPC_FLAGS': '0x0', 20:45:35 INFO - 'XPC_SERVICE_NAME': '0', 20:45:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:45:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:45:36 INFO - Downloading/unpacking psutil>=3.1.1 20:45:36 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 20:45:36 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 20:45:36 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 20:45:36 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 20:45:36 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 20:45:36 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 20:45:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:45:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:45:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:45:39 INFO - Installing collected packages: psutil 20:45:39 INFO - Running setup.py install for psutil 20:45:39 INFO - building 'psutil._psutil_osx' extension 20:45:39 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 20:45:40 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 20:45:40 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 20:45:40 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 20:45:40 INFO - building 'psutil._psutil_posix' extension 20:45:40 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 20:45:40 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 20:45:40 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 20:45:40 INFO - ^ 20:45:40 INFO - 1 warning generated. 20:45:40 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 20:45:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:45:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:45:40 INFO - Successfully installed psutil 20:45:40 INFO - Cleaning up... 20:45:40 INFO - Return code: 0 20:45:40 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 20:45: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')]} 20:45:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:45:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:45: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')]} 20:45:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:45:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:45:40 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 0x1074ffb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107502768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa5b3db3b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1072ddd30>, '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 0x107204db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1072d2be8>, '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.dsjHeaMubX/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.19kSzTeGsf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f4/zwr2n_y50tg1y44pl818tgt800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 20:45:40 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 20:45:40 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 20:45:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dsjHeaMubX/Render', 20:45:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:45:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:45:40 INFO - 'HOME': '/Users/cltbld', 20:45:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:45:40 INFO - 'LOGNAME': 'cltbld', 20:45:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:45:40 INFO - 'MOZ_NO_REMOTE': '1', 20:45:40 INFO - 'NO_EM_RESTART': '1', 20:45:40 INFO - 'PAGER': '/bin/cat', 20:45:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:45:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:45:40 INFO - 'PWD': '/builds/slave/test', 20:45:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:45:40 INFO - 'SHELL': '/bin/bash', 20:45:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.19kSzTeGsf/Listeners', 20:45:40 INFO - 'TMPDIR': '/var/folders/f4/zwr2n_y50tg1y44pl818tgt800000w/T/', 20:45:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:45:40 INFO - 'USER': 'cltbld', 20:45:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:45:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:45:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:45:40 INFO - 'XPC_FLAGS': '0x0', 20:45:40 INFO - 'XPC_SERVICE_NAME': '0', 20:45:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:45:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:45:41 INFO - Downloading/unpacking mozsystemmonitor==0.3 20:45:41 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 20:45:41 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 20:45:41 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 20:45:41 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 20:45:41 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 20:45:41 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 20:45:43 INFO - Downloading mozsystemmonitor-0.3.tar.gz 20:45:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:45:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 20:45:43 INFO - Installing collected packages: mozsystemmonitor 20:45:43 INFO - Running setup.py install for mozsystemmonitor 20:45:44 INFO - Successfully installed mozsystemmonitor 20:45:44 INFO - Cleaning up... 20:45:44 INFO - Return code: 0 20:45:44 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 20:45:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:45:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:45:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:45:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:45:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:45:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:45:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1074ffb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107502768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa5b3db3b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1072ddd30>, '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 0x107204db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1072d2be8>, '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.dsjHeaMubX/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.19kSzTeGsf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f4/zwr2n_y50tg1y44pl818tgt800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 20:45:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 20:45:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 20:45:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dsjHeaMubX/Render', 20:45:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:45:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:45:44 INFO - 'HOME': '/Users/cltbld', 20:45:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:45:44 INFO - 'LOGNAME': 'cltbld', 20:45:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:45:44 INFO - 'MOZ_NO_REMOTE': '1', 20:45:44 INFO - 'NO_EM_RESTART': '1', 20:45:44 INFO - 'PAGER': '/bin/cat', 20:45:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:45:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:45:44 INFO - 'PWD': '/builds/slave/test', 20:45:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:45:44 INFO - 'SHELL': '/bin/bash', 20:45:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.19kSzTeGsf/Listeners', 20:45:44 INFO - 'TMPDIR': '/var/folders/f4/zwr2n_y50tg1y44pl818tgt800000w/T/', 20:45:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:45:44 INFO - 'USER': 'cltbld', 20:45:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:45:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:45:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:45:44 INFO - 'XPC_FLAGS': '0x0', 20:45:44 INFO - 'XPC_SERVICE_NAME': '0', 20:45:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:45:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:45:44 INFO - Downloading/unpacking jsonschema==2.5.1 20:45:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:45:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:45:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:45:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:45:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:45:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:45:47 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:45:47 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 20:45:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:45:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:45:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:45:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:45:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:45:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:45:47 INFO - Downloading functools32-3.2.3-2.tar.gz 20:45:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:45:47 INFO - warning: no files found matching '*.txt' 20:45:47 INFO - no previously-included directories found matching 'build' 20:45:47 INFO - no previously-included directories found matching 'dist' 20:45:47 INFO - no previously-included directories found matching '.git*' 20:45:47 INFO - Installing collected packages: jsonschema, functools32 20:45:47 INFO - Running setup.py install for functools32 20:45:47 INFO - warning: no files found matching '*.txt' 20:45:47 INFO - no previously-included directories found matching 'build' 20:45:47 INFO - no previously-included directories found matching 'dist' 20:45:47 INFO - no previously-included directories found matching '.git*' 20:45:47 INFO - Successfully installed jsonschema functools32 20:45:47 INFO - Cleaning up... 20:45:47 INFO - Return code: 0 20:45:47 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 20:45: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')]} 20:45:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:45:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:45: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')]} 20:45:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:45:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:45: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', '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 0x1074ffb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107502768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa5b3db3b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1072ddd30>, '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 0x107204db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1072d2be8>, '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.dsjHeaMubX/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.19kSzTeGsf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f4/zwr2n_y50tg1y44pl818tgt800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 20:45: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 20:45: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 functools32==3.2.3-2 20:45:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dsjHeaMubX/Render', 20:45:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:45:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:45:47 INFO - 'HOME': '/Users/cltbld', 20:45:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:45:47 INFO - 'LOGNAME': 'cltbld', 20:45:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:45:47 INFO - 'MOZ_NO_REMOTE': '1', 20:45:47 INFO - 'NO_EM_RESTART': '1', 20:45:47 INFO - 'PAGER': '/bin/cat', 20:45:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:45:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:45:47 INFO - 'PWD': '/builds/slave/test', 20:45:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:45:47 INFO - 'SHELL': '/bin/bash', 20:45:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.19kSzTeGsf/Listeners', 20:45:47 INFO - 'TMPDIR': '/var/folders/f4/zwr2n_y50tg1y44pl818tgt800000w/T/', 20:45:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:45:47 INFO - 'USER': 'cltbld', 20:45:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:45:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:45:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:45:47 INFO - 'XPC_FLAGS': '0x0', 20:45:47 INFO - 'XPC_SERVICE_NAME': '0', 20:45:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:45:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:45:48 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 20:45:48 INFO - Cleaning up... 20:45:48 INFO - Return code: 0 20:45:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:45: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')]} 20:45:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:45:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:45: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')]} 20:45:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:45:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:45: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', '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 0x1074ffb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107502768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa5b3db3b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1072ddd30>, '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 0x107204db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1072d2be8>, '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.dsjHeaMubX/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.19kSzTeGsf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f4/zwr2n_y50tg1y44pl818tgt800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 20:45: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 20:45: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 blobuploader==1.2.4 20:45:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dsjHeaMubX/Render', 20:45:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:45:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:45:48 INFO - 'HOME': '/Users/cltbld', 20:45:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:45:48 INFO - 'LOGNAME': 'cltbld', 20:45:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:45:48 INFO - 'MOZ_NO_REMOTE': '1', 20:45:48 INFO - 'NO_EM_RESTART': '1', 20:45:48 INFO - 'PAGER': '/bin/cat', 20:45:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:45:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:45:48 INFO - 'PWD': '/builds/slave/test', 20:45:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:45:48 INFO - 'SHELL': '/bin/bash', 20:45:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.19kSzTeGsf/Listeners', 20:45:48 INFO - 'TMPDIR': '/var/folders/f4/zwr2n_y50tg1y44pl818tgt800000w/T/', 20:45:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:45:48 INFO - 'USER': 'cltbld', 20:45:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:45:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:45:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:45:48 INFO - 'XPC_FLAGS': '0x0', 20:45:48 INFO - 'XPC_SERVICE_NAME': '0', 20:45:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:45:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:45:48 INFO - Downloading/unpacking blobuploader==1.2.4 20:45: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 20:45: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 20:45: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 20:45: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 20:45: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 20:45: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 20:45:51 INFO - Downloading blobuploader-1.2.4.tar.gz 20:45:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:45:51 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:45:51 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 20:45:51 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 20:45:51 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 20:45:51 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 20:45:51 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 20:45:51 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 20:45:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:45:51 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:45:51 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 20:45:51 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 20:45:51 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 20:45:51 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 20:45:51 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 20:45:51 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 20:45:52 INFO - Downloading docopt-0.6.1.tar.gz 20:45:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:45:52 INFO - Installing collected packages: blobuploader, requests, docopt 20:45:52 INFO - Running setup.py install for blobuploader 20:45:52 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:45:52 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:45:52 INFO - Running setup.py install for requests 20:45:52 INFO - Running setup.py install for docopt 20:45:53 INFO - Successfully installed blobuploader requests docopt 20:45:53 INFO - Cleaning up... 20:45:53 INFO - Return code: 0 20:45:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:45: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')]} 20:45:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:45:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:45: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')]} 20:45:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:45:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:45:53 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 0x1074ffb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107502768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa5b3db3b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1072ddd30>, '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 0x107204db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1072d2be8>, '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.dsjHeaMubX/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.19kSzTeGsf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f4/zwr2n_y50tg1y44pl818tgt800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 20:45:53 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 20:45:53 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 20:45:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dsjHeaMubX/Render', 20:45:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:45:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:45:53 INFO - 'HOME': '/Users/cltbld', 20:45:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:45:53 INFO - 'LOGNAME': 'cltbld', 20:45:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:45:53 INFO - 'MOZ_NO_REMOTE': '1', 20:45:53 INFO - 'NO_EM_RESTART': '1', 20:45:53 INFO - 'PAGER': '/bin/cat', 20:45:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:45:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:45:53 INFO - 'PWD': '/builds/slave/test', 20:45:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:45:53 INFO - 'SHELL': '/bin/bash', 20:45:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.19kSzTeGsf/Listeners', 20:45:53 INFO - 'TMPDIR': '/var/folders/f4/zwr2n_y50tg1y44pl818tgt800000w/T/', 20:45:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:45:53 INFO - 'USER': 'cltbld', 20:45:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:45:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:45:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:45:53 INFO - 'XPC_FLAGS': '0x0', 20:45:53 INFO - 'XPC_SERVICE_NAME': '0', 20:45:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:45:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:45:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:45:53 INFO - Running setup.py (path:/var/folders/f4/zwr2n_y50tg1y44pl818tgt800000w/T/pip-dc93Hm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:45:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:45:53 INFO - Running setup.py (path:/var/folders/f4/zwr2n_y50tg1y44pl818tgt800000w/T/pip-Nba0lv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:45:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:45:53 INFO - Running setup.py (path:/var/folders/f4/zwr2n_y50tg1y44pl818tgt800000w/T/pip-VWArRZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:45:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:45:53 INFO - Running setup.py (path:/var/folders/f4/zwr2n_y50tg1y44pl818tgt800000w/T/pip-obmbs_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:45:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:45:53 INFO - Running setup.py (path:/var/folders/f4/zwr2n_y50tg1y44pl818tgt800000w/T/pip-0dioAQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:45:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:45:54 INFO - Running setup.py (path:/var/folders/f4/zwr2n_y50tg1y44pl818tgt800000w/T/pip-bHOlAH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:45:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:45:54 INFO - Running setup.py (path:/var/folders/f4/zwr2n_y50tg1y44pl818tgt800000w/T/pip-G3PQLq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:45:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:45:54 INFO - Running setup.py (path:/var/folders/f4/zwr2n_y50tg1y44pl818tgt800000w/T/pip-VQOOof-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:45:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:45:54 INFO - Running setup.py (path:/var/folders/f4/zwr2n_y50tg1y44pl818tgt800000w/T/pip-z5d6e6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:45:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:45:54 INFO - Running setup.py (path:/var/folders/f4/zwr2n_y50tg1y44pl818tgt800000w/T/pip-5L9ow6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:45:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:45:54 INFO - Running setup.py (path:/var/folders/f4/zwr2n_y50tg1y44pl818tgt800000w/T/pip-1Q8KmC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:45:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:45:54 INFO - Running setup.py (path:/var/folders/f4/zwr2n_y50tg1y44pl818tgt800000w/T/pip-15Yhn7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:45:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:45:54 INFO - Running setup.py (path:/var/folders/f4/zwr2n_y50tg1y44pl818tgt800000w/T/pip-313jOr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:45:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:45:54 INFO - Running setup.py (path:/var/folders/f4/zwr2n_y50tg1y44pl818tgt800000w/T/pip-_W2PU_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:45:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:45:54 INFO - Running setup.py (path:/var/folders/f4/zwr2n_y50tg1y44pl818tgt800000w/T/pip-t_pyxa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:45:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:45:55 INFO - Running setup.py (path:/var/folders/f4/zwr2n_y50tg1y44pl818tgt800000w/T/pip-9bmfP9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:45:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:45:55 INFO - Running setup.py (path:/var/folders/f4/zwr2n_y50tg1y44pl818tgt800000w/T/pip-FNAnw3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:45:55 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:45:55 INFO - Running setup.py install for manifestparser 20:45:55 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:45:55 INFO - Running setup.py install for mozcrash 20:45:55 INFO - Running setup.py install for mozdebug 20:45:55 INFO - Running setup.py install for mozdevice 20:45:55 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:45:55 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:45:55 INFO - Running setup.py install for mozfile 20:45:55 INFO - Running setup.py install for mozhttpd 20:45:56 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:45:56 INFO - Running setup.py install for mozinfo 20:45:56 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:45:56 INFO - Running setup.py install for mozInstall 20:45:56 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:45:56 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:45:56 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:45:56 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:45:56 INFO - Running setup.py install for mozleak 20:45:56 INFO - Running setup.py install for mozlog 20:45:56 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:45:56 INFO - Running setup.py install for moznetwork 20:45:56 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:45:56 INFO - Running setup.py install for mozprocess 20:45:57 INFO - Running setup.py install for mozprofile 20:45:57 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:45:57 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:45:57 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:45:57 INFO - Running setup.py install for mozrunner 20:45:57 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:45:57 INFO - Running setup.py install for mozscreenshot 20:45:57 INFO - Running setup.py install for moztest 20:45:57 INFO - Running setup.py install for mozversion 20:45:57 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:45:57 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:45:57 INFO - Cleaning up... 20:45:57 INFO - Return code: 0 20:45:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:45:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:45:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:45:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:45:58 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')]} 20:45:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:45:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:45:58 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 0x1074ffb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107502768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa5b3db3b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1072ddd30>, '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 0x107204db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1072d2be8>, '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.dsjHeaMubX/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.19kSzTeGsf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f4/zwr2n_y50tg1y44pl818tgt800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 20:45:58 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 20:45:58 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 20:45:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dsjHeaMubX/Render', 20:45:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:45:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:45:58 INFO - 'HOME': '/Users/cltbld', 20:45:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:45:58 INFO - 'LOGNAME': 'cltbld', 20:45:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:45:58 INFO - 'MOZ_NO_REMOTE': '1', 20:45:58 INFO - 'NO_EM_RESTART': '1', 20:45:58 INFO - 'PAGER': '/bin/cat', 20:45:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:45:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:45:58 INFO - 'PWD': '/builds/slave/test', 20:45:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:45:58 INFO - 'SHELL': '/bin/bash', 20:45:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.19kSzTeGsf/Listeners', 20:45:58 INFO - 'TMPDIR': '/var/folders/f4/zwr2n_y50tg1y44pl818tgt800000w/T/', 20:45:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:45:58 INFO - 'USER': 'cltbld', 20:45:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:45:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:45:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:45:58 INFO - 'XPC_FLAGS': '0x0', 20:45:58 INFO - 'XPC_SERVICE_NAME': '0', 20:45:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:45:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:45:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:45:58 INFO - Running setup.py (path:/var/folders/f4/zwr2n_y50tg1y44pl818tgt800000w/T/pip-qYfdAh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:45:59 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)) 20:45:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:45:59 INFO - Running setup.py (path:/var/folders/f4/zwr2n_y50tg1y44pl818tgt800000w/T/pip-ubNQaU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:45:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 20:45:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:45:59 INFO - Running setup.py (path:/var/folders/f4/zwr2n_y50tg1y44pl818tgt800000w/T/pip-7_xQT_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:45:59 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)) 20:45:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:45:59 INFO - Running setup.py (path:/var/folders/f4/zwr2n_y50tg1y44pl818tgt800000w/T/pip-RhxNdQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:45:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 20:45:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:45:59 INFO - Running setup.py (path:/var/folders/f4/zwr2n_y50tg1y44pl818tgt800000w/T/pip-vkj9ER-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:45:59 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)) 20:45:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:45:59 INFO - Running setup.py (path:/var/folders/f4/zwr2n_y50tg1y44pl818tgt800000w/T/pip-QxHZ3Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:45:59 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)) 20:45:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:45:59 INFO - Running setup.py (path:/var/folders/f4/zwr2n_y50tg1y44pl818tgt800000w/T/pip-8PTupY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:45:59 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)) 20:45:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:45:59 INFO - Running setup.py (path:/var/folders/f4/zwr2n_y50tg1y44pl818tgt800000w/T/pip-yYjpaa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:45:59 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)) 20:45:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:45:59 INFO - Running setup.py (path:/var/folders/f4/zwr2n_y50tg1y44pl818tgt800000w/T/pip-URCW0v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:45:59 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)) 20:45:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:45:59 INFO - Running setup.py (path:/var/folders/f4/zwr2n_y50tg1y44pl818tgt800000w/T/pip-GDOd7z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:45:59 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)) 20:45:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:45:59 INFO - Running setup.py (path:/var/folders/f4/zwr2n_y50tg1y44pl818tgt800000w/T/pip-UWtvfA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:46:00 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)) 20:46:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:46:00 INFO - Running setup.py (path:/var/folders/f4/zwr2n_y50tg1y44pl818tgt800000w/T/pip-u2vZXX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:46:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 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)) 20:46:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:46:00 INFO - Running setup.py (path:/var/folders/f4/zwr2n_y50tg1y44pl818tgt800000w/T/pip-plU3WM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:46:00 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)) 20:46:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:46:00 INFO - Running setup.py (path:/var/folders/f4/zwr2n_y50tg1y44pl818tgt800000w/T/pip-A8Wk50-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:46:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 20:46:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:46:00 INFO - Running setup.py (path:/var/folders/f4/zwr2n_y50tg1y44pl818tgt800000w/T/pip-9naJ1a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:46:00 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)) 20:46:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:46:00 INFO - Running setup.py (path:/var/folders/f4/zwr2n_y50tg1y44pl818tgt800000w/T/pip-GmkOYN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:46:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 20:46:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:46:00 INFO - Running setup.py (path:/var/folders/f4/zwr2n_y50tg1y44pl818tgt800000w/T/pip-Ae78tU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:46:00 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)) 20:46:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 20:46:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 20:46:00 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)) 20:46:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 20:46:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 20:46:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:46: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 20:46: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 20:46: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 20:46: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 20:46: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 20:46: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 20:46:03 INFO - Downloading blessings-1.6.tar.gz 20:46:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:46:03 INFO - Installing collected packages: blessings 20:46:03 INFO - Running setup.py install for blessings 20:46:03 INFO - Successfully installed blessings 20:46:03 INFO - Cleaning up... 20:46:04 INFO - Return code: 0 20:46:04 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:46:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:46:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:46:04 INFO - Reading from file tmpfile_stdout 20:46:04 INFO - Current package versions: 20:46:04 INFO - blessings == 1.6 20:46:04 INFO - blobuploader == 1.2.4 20:46:04 INFO - docopt == 0.6.1 20:46:04 INFO - functools32 == 3.2.3-2 20:46:04 INFO - jsonschema == 2.5.1 20:46:04 INFO - manifestparser == 1.1 20:46:04 INFO - mozInstall == 1.12 20:46:04 INFO - mozcrash == 1.0 20:46:04 INFO - mozdebug == 0.1 20:46:04 INFO - mozdevice == 0.49 20:46:04 INFO - mozfile == 1.2 20:46:04 INFO - mozhttpd == 0.7 20:46:04 INFO - mozinfo == 0.9 20:46:04 INFO - mozleak == 0.1 20:46:04 INFO - mozlog == 3.4 20:46:04 INFO - moznetwork == 0.27 20:46:04 INFO - mozprocess == 0.24 20:46:04 INFO - mozprofile == 0.28 20:46:04 INFO - mozrunner == 6.13 20:46:04 INFO - mozscreenshot == 0.1 20:46:04 INFO - mozsystemmonitor == 0.3 20:46:04 INFO - moztest == 0.8 20:46:04 INFO - mozversion == 1.4 20:46:04 INFO - psutil == 3.1.1 20:46:04 INFO - requests == 1.2.3 20:46:04 INFO - wsgiref == 0.1.2 20:46:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:46:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:46:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:46:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:46:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:46:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:46:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:46:04 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 0x1074ffb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107502768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa5b3db3b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1072ddd30>, '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 0x107204db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1072d2be8>, '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.dsjHeaMubX/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.19kSzTeGsf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f4/zwr2n_y50tg1y44pl818tgt800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 20:46:04 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 20:46:04 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 20:46:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dsjHeaMubX/Render', 20:46:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:46:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:46:04 INFO - 'HOME': '/Users/cltbld', 20:46:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:46:04 INFO - 'LOGNAME': 'cltbld', 20:46:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:46:04 INFO - 'MOZ_NO_REMOTE': '1', 20:46:04 INFO - 'NO_EM_RESTART': '1', 20:46:04 INFO - 'PAGER': '/bin/cat', 20:46:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:46:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:46:04 INFO - 'PWD': '/builds/slave/test', 20:46:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:46:04 INFO - 'SHELL': '/bin/bash', 20:46:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.19kSzTeGsf/Listeners', 20:46:04 INFO - 'TMPDIR': '/var/folders/f4/zwr2n_y50tg1y44pl818tgt800000w/T/', 20:46:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:46:04 INFO - 'USER': 'cltbld', 20:46:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:46:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:46:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:46:04 INFO - 'XPC_FLAGS': '0x0', 20:46:04 INFO - 'XPC_SERVICE_NAME': '0', 20:46:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:46:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:46:04 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)) 20:46:04 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)) 20:46:04 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)) 20:46:04 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)) 20:46:04 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)) 20:46:04 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)) 20:46:04 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)) 20:46:04 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)) 20:46:04 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)) 20:46:04 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)) 20:46:04 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)) 20:46:04 INFO - Cleaning up... 20:46:04 INFO - Return code: 0 20:46:04 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:46:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:46:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:46:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:46:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:46:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:46:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:46:04 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 0x1074ffb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107502768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa5b3db3b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1072ddd30>, '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 0x107204db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1072d2be8>, '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.dsjHeaMubX/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.19kSzTeGsf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f4/zwr2n_y50tg1y44pl818tgt800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 20:46:04 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 20:46:04 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 20:46:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dsjHeaMubX/Render', 20:46:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:46:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:46:04 INFO - 'HOME': '/Users/cltbld', 20:46:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:46:04 INFO - 'LOGNAME': 'cltbld', 20:46:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:46:04 INFO - 'MOZ_NO_REMOTE': '1', 20:46:04 INFO - 'NO_EM_RESTART': '1', 20:46:04 INFO - 'PAGER': '/bin/cat', 20:46:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:46:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:46:04 INFO - 'PWD': '/builds/slave/test', 20:46:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:46:04 INFO - 'SHELL': '/bin/bash', 20:46:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.19kSzTeGsf/Listeners', 20:46:04 INFO - 'TMPDIR': '/var/folders/f4/zwr2n_y50tg1y44pl818tgt800000w/T/', 20:46:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:46:04 INFO - 'USER': 'cltbld', 20:46:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:46:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:46:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:46:04 INFO - 'XPC_FLAGS': '0x0', 20:46:04 INFO - 'XPC_SERVICE_NAME': '0', 20:46:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:46:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:46:04 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 20:46:04 INFO - Cleaning up... 20:46:04 INFO - Return code: 0 20:46:04 INFO - Running post-action listener: _resource_record_post_action 20:46:04 INFO - Running post-action listener: _start_resource_monitoring 20:46:04 INFO - Starting resource monitoring. 20:46:04 INFO - [mozharness: 2017-03-10 04:46:04.915319Z] Finished create-virtualenv step (success) 20:46:04 INFO - [mozharness: 2017-03-10 04:46:04.916348Z] Running install step. 20:46:04 INFO - Running pre-action listener: _resource_record_pre_action 20:46:04 INFO - Running main action method: install 20:46:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:46:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:46:05 INFO - Reading from file tmpfile_stdout 20:46:05 INFO - Detecting whether we're running mozinstall >=1.0... 20:46:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:46:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:46:05 INFO - Reading from file tmpfile_stdout 20:46:05 INFO - Output received: 20:46:05 INFO - Usage: mozinstall [options] installer 20:46:05 INFO - Options: 20:46:05 INFO - -h, --help show this help message and exit 20:46:05 INFO - -d DEST, --destination=DEST 20:46:05 INFO - Directory to install application into. [default: 20:46:05 INFO - "/builds/slave/test"] 20:46:05 INFO - --app=APP Application being installed. [default: firefox] 20:46:05 INFO - mkdir: /builds/slave/test/build/application 20:46:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 20:46:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0.en-US.mac.dmg --destination /builds/slave/test/build/application 20:46:20 INFO - Reading from file tmpfile_stdout 20:46:20 INFO - Output received: 20:46:20 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 20:46:20 INFO - Running post-action listener: _resource_record_post_action 20:46:20 INFO - [mozharness: 2017-03-10 04:46:20.113149Z] Finished install step (success) 20:46:20 INFO - [mozharness: 2017-03-10 04:46:20.113325Z] Running run-tests step. 20:46:20 INFO - Running pre-action listener: _resource_record_pre_action 20:46:20 INFO - Running main action method: run_tests 20:46:20 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 20:46:20 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 20:46:20 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 20:46:20 INFO - 2017-03-09 20:46:20.127 screenresolution[1628:7323] starting screenresolution argv=screenresolution get 20:46:20 INFO - 2017-03-09 20:46:20.130 screenresolution[1628:7323] Display 0: 1600x1200x32@60 20:46:20 INFO - 2017-03-09 20:46:20.136 screenresolution[1629:7325] starting screenresolution argv=screenresolution list 20:46:20 INFO - Available Modes on Display 0 20:46:20 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 20:46:20 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 20:46:20 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 20:46:20 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 20:46:20 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 20:46:20 INFO - Intel Iris: 20:46:20 INFO - Chipset Model: Intel Iris 20:46:20 INFO - Type: GPU 20:46:20 INFO - Bus: Built-In 20:46:20 INFO - VRAM (Dynamic, Max): 1536 MB 20:46:20 INFO - Vendor: Intel (0x8086) 20:46:20 INFO - Device ID: 0x0a2e 20:46:20 INFO - Revision ID: 0x0009 20:46:20 INFO - Displays: 20:46:20 INFO - Display: 20:46:20 INFO - Resolution: 1600 x 1200 @ 60 Hz 20:46:20 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 20:46:20 INFO - Display Serial Number: 1600x1200 60 20:46:20 INFO - Main Display: Yes 20:46:20 INFO - Mirror: Off 20:46:20 INFO - Online: Yes 20:46:20 INFO - Rotation: Supported 20:46:20 INFO - Return code: 0 20:46:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:46:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:46:20 INFO - Python 2.7.3 20:46:20 INFO - Return code: 0 20:46:20 INFO - grabbing minidump binary from tooltool 20:46:20 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')]} 20:46:20 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 0x1072ddd30>, '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 0x107204db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1072d2be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:46:20 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 20:46:20 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 20:46:20 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 20:46:20 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:46:20 INFO - Return code: 0 20:46:20 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 20:46:20 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:46:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:46:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 20:46:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:46:20 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/TWx3h0TlQ4y4bu1e9lCaTw/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0150', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 20:46:20 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/TWx3h0TlQ4y4bu1e9lCaTw/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0150 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 20:46:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dsjHeaMubX/Render', 20:46:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:46:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:46:20 INFO - 'HOME': '/Users/cltbld', 20:46:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:46:20 INFO - 'LOGNAME': 'cltbld', 20:46:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:46:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 20:46:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:46:20 INFO - 'MOZ_NO_REMOTE': '1', 20:46:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:46:20 INFO - 'NO_EM_RESTART': '1', 20:46:20 INFO - 'PAGER': '/bin/cat', 20:46:20 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:46:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:46:20 INFO - 'PWD': '/builds/slave/test', 20:46:20 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:46:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:46:20 INFO - 'SHELL': '/bin/bash', 20:46:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.19kSzTeGsf/Listeners', 20:46:20 INFO - 'TMPDIR': '/var/folders/f4/zwr2n_y50tg1y44pl818tgt800000w/T/', 20:46:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:46:20 INFO - 'USER': 'cltbld', 20:46:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:46:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:46:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:46:20 INFO - 'XPC_FLAGS': '0x0', 20:46:20 INFO - 'XPC_SERVICE_NAME': '0', 20:46:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:46:20 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/TWx3h0TlQ4y4bu1e9lCaTw/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0150', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 20:46:20 INFO - mozversion application_buildid: 20170309192825 20:46:20 INFO - mozversion application_changeset: e2752c5516c107c4c8a3edf7be91b2fd15c56a3b 20:46:20 INFO - mozversion application_display_name: Firefox 20:46:20 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:46:20 INFO - mozversion application_name: Firefox 20:46:20 INFO - mozversion application_remotingname: firefox 20:46:20 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 20:46:20 INFO - mozversion application_vendor: Mozilla 20:46:20 INFO - mozversion application_version: 53.0 20:46:20 INFO - mozversion platform_buildid: 20170309192825 20:46:20 INFO - mozversion platform_changeset: e2752c5516c107c4c8a3edf7be91b2fd15c56a3b 20:46:20 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 20:46:20 INFO - mozversion platform_version: 53.0 20:46:20 INFO - using testdate: 1489121180 20:46:20 INFO - actual date: 1489121180 20:46:20 INFO - starting webserver on 'localhost:49242' 20:46:20 INFO - SUITE-START | Running 2 tests 20:46:20 INFO - TEST-START | dromaeo_css 20:46:20 INFO - operating with platform_type : mac_ 20:46:20 INFO - Initialising browser for dromaeo_css test... 20:46:20 INFO - TEST-INFO | started process 1639 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/f4/zwr2n_y50tg1y44pl818tgt800000w/T/tmp3bU4Mp/profile http://localhost:49242/getInfo.html) 20:46:23 INFO - PROCESS | 1639 | __metrics Screen width/height:1600/1200 20:46:23 INFO - PROCESS | 1639 | colorDepth:24 20:46:23 INFO - PROCESS | 1639 | Browser inner width/height: 1024/689 20:46:23 INFO - PROCESS | 1639 | __metrics 20:46:23 INFO - PROCESS | 1639 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 20:46:23 INFO - PROCESS | 1639 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:46:23 INFO - TEST-INFO | 1639: exit 0 20:46:23 INFO - Browser initialized. 20:46:23 INFO - Running cycle 1/1 for dromaeo_css test... 20:46:23 INFO - TEST-INFO | started process 1642 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/f4/zwr2n_y50tg1y44pl818tgt800000w/T/tmp3bU4Mp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:46:35 INFO - PROCESS | 1642 | RSS: Main: 167100416 20:46:35 INFO - PROCESS | 1642 | 20:49:38 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49242/tests/dromaeo/cssquery-ext.html) 20:49:40 INFO - PROCESS | 1642 | RSS: Main: 309538816 20:49:40 INFO - PROCESS | 1642 | 20:52:43 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-ext.html (next: http://localhost:49242/tests/dromaeo/cssquery-jquery.html) 20:52:43 INFO - PROCESS | 1642 | RSS: Main: 303595520 20:52:43 INFO - PROCESS | 1642 | 20:55:46 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49242/tests/dromaeo/cssquery-mootools.html) 20:55:46 INFO - PROCESS | 1642 | RSS: Main: 302788608 20:55:46 INFO - PROCESS | 1642 | 20:58:49 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49242/tests/dromaeo/cssquery-prototype.html) 20:58:49 INFO - PROCESS | 1642 | RSS: Main: 284856320 20:58:49 INFO - PROCESS | 1642 | 21:01:53 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49242/tests/dromaeo/cssquery-yui.html) 21:01:53 INFO - PROCESS | 1642 | RSS: Main: 265678848 21:01:53 INFO - PROCESS | 1642 | 21:04:56 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-yui.html (next: http://localhost:49242/tests/dromaeo/cssquery-dojo.html) 21:04:57 INFO - PROCESS | 1642 | RSS: Main: 324304896 21:04:57 INFO - PROCESS | 1642 | 21:04:57 INFO - PROCESS | 1642 | __start_tp_report 21:04:57 INFO - PROCESS | 1642 | _x_x_mozilla_page_load 21:04:57 INFO - PROCESS | 1642 | _x_x_mozilla_page_load_details 21:04:57 INFO - PROCESS | 1642 | |i|pagename|runs| 21:04:57 INFO - PROCESS | 1642 | |0;dojo.html;3475.443928971364;3480.199554102555;3484.634113418091;3521.0317162780248;3533.92932141357;5894.675792831393;5910.0543912973935;5937.346891841894;5945.316288626815;5947.078202878555;5846.415358464162;5940.04959206527;5950.9107363389585;5953.851153721159;5954.612950158236;5055.823046193384;5230.424653288144;5242.737863106849;5270.631055826094;5363.785448582072;5226.686398816083;5227.712475813829;5242.397124330693;5352.839414817562;5365.463453654643;5315.468453154673;5329.307190065286;5338.813141540047;5341.011912796145;5344.946550534503;5318.441563635821;5329.387120481156;5329.413764485904;5338.412774594792;5348.705821179834;4439.689221754478;5180.378354597435;5297.602679799031;5301.0723123453245;5344.652597581184;6004.159417681528;6011.639301641915;6014.097885317194;6015.09773533969;6028.879422411571;6166.784162554289;6205.81382558524;6223.1287619733275;6225.8132256032395;6243.188385509855;6224.906626400608;6231.065340198961;6238.1266622672865;6258.280297765769;6272.18461599989;5985.221921150266;6000.249968753906;6017.344697214989;6020.1872747179;6061.030235162397;6187.84530386744;6209.316975132731;6216.2540495140875;6311.558190926683;6342.619442833445;6141.332587233735;6145.385461453819;6198.039303907902;6245.094461303085;6256.687165641791;6197.96901015492;6204.937950620526;6207.068939658997;6207.441330280297;6212.254529456494;6166.445019948136;6234.781782637586;6239.96880015597;6247.219097612799;6262.780802671885;6149.2313460817395;6191.4118158774845;6214.906776398358;6222.408871157233;6236.812895613139;5017.397912250481;5019.648624596316;5027.170516864677;5030.7233102179;5057.241413787961;4448.266036104072;4462.821487140478;4464.628055551383;4465.977670111693;4488.192125417456;5768.480836724715;5907.556933230025;5971.044632858721;5974.2830860297045;5990.700464976734;6143.1706719592285;6193.721282542297;6197.411245931719;6199.16311297969;6223.222097237845;5901.29184497863;5901.704914754245;5901.822945311647;5916.408359164136;5943.405659434108;5416.83749487516;5454.3454785426;5466.180072989004;5474.945250547444;5496.697681627549;6337.524685648503;6351.9682401588625;6389.361063893573;6404.71178796946;6476.5466417350335;6215.627062376272;6229.750809967732;6230.314665386894;6237.563370564017;6243.43809057187;6371.39471750183;6399.776007839703;6445.742170313322;6460.935390646221;6468.870622587616;6171.753129874754;6216.906746398718;6227.034809604518;6245.500359971283;6256.092866534236;6162.599431036968;6179.196704428396;6201.193844800147;6222.160008398808;6251.468625166912;6234.501239900887;6256.874862502634;6258.43674069336;6262.718177681924;6273.15312432834;6251.4061164189325;6251.968740156452;6257.217847769029;6262.060690896402;6273.027680709497;6053.697315134314;6105.145279660762;6128.808691620048;6141.170941922962;6149.600275982047;6107.664078475549;6175.135481032748;6214.5028397727165;6218.906716399348;6236.282827474898;6137.938620613737;6163.568550201443;6185.505159587132;6187.84530386726;6197.690115494297 21:04:57 INFO - PROCESS | 1642 | |1;ext.html;486.21233601565456;507.80195723667754;519.6903802417906;524.4021815130749;535.5126834580533;32603;41813.790931045376;42891.78554107225;42943.78528107355;44738;44805.55194448055;45102.323465147965;45162.87092822681;45167;45196.3220551692;9566.33035687504;9785.902140978571;9797.657082002132;9806.607735690564;9811.116999470047;9080.727578172666;9293.488858112802;11994;12247.63257102284;12289.139760216789;12127.878721212808;12184.329861857594;12187.878121218808;12194.634160975185;12196;12038.57864974726;12122.939385303018;12124.211926224856;12126.696832579168;12173.452194651261;11939.403029848472;11981.341026243554;12058.6382408527;12064.974477169364;12076.154669173162;42697.35953960693;42905;43045.35431968523;43054.354184687254;43136.352954705704;4061.2892743770017;4121.5878412158845;4123.60825721559;4123.8556650517085;4141.91716165678;30666.080017599506;31700.207494812814;31732.682673173204;32758.017259482254;33357.499637505454;3238.8542515586855;3245.237369218232;3276.0499455157974;3321.368939901411;3401.4217583010945;494798;495955;496200;496370.5181474106;496387;62771.686141569;63135.368646313866;63324.68337658282;63349.36650633434;63352.198868068066;68134;68156.6592167036;68171;68262;68390.65804670945;17422.564435889206;17637.294508219784;17656.558586035197;17683.55791105207;17707.38024169148;12399.566015189424;13352.465901363837;13550;13580.796288055688;13618.795718064237;14756.188409637358;15218.239088045553;20064.49838754043;22841.657375139388;23085.845707714547;7229.963850180716;7670.846583068307;9022.684206052889;9229.584668689791;9299.907000929905;903.263839970422;905.2712566384124;912.543728135932;946.597695979206;949.3876449689911;31240.687593124232;31312.06063818089;31474;32405.837970809996;32972.67027329744;913.6893456224915;962.3167551038841;1139.7435576995276;1147.5811328864904;1202.0864143251017;15727.842721572637;16268.803711499033;16273.51179464618;16309.755353669705;16567.00597964126;681781;682799;683171;683354;685729;64046.35953640497;64430.677846611405;64455;64656.676716616115;64729.35270647328;1344.267374281019;1389.5483967710736;1392.317764295488;1483.0730793254215;1485.873700735428;30583.388332232786;32321.51517727283;32826.50760238646;33475.665243347255;34056.14859628529;58383.832323354145;60031.399686004326;60167;60267.69866150641;60284.39715602788;582159.0892045513;586572;587183;587623;589577;25071.749282506942;25653.743462565137;28726.281842954093;29040.56439153372;29075.127746167647;39589.80205098956;39597.80201098976;45980.7700961493;47235.291470628654;51690.22464663108;39228.21543569055;39306.60693393029;41012;41022.92539878361;41684.166316674105;40012.7999360013;40184;40600.1879962405;40966.79516602398;42054.36918446287;39443.35942377892;39447.60552394554;39912.00219994524;40304.59695403009;40420.3936940952;33016.83491582623;35098.473522897686;35607.643923560434;35631.10922226965;35883.64116358803;25779.871100645127;26120.477590447703;26168.8691556541;26666;26674.333141671614 21:04:57 INFO - PROCESS | 1642 | |2;jquery.html;352.86943830782616;402.71206087647334;405.8153540139237;415.084738152374;432.7295440349781;21388.57222855544;22212.777872221293;22762;22869.313920582368;22881.19915802947;21910.89044554775;23384.532309353803;23655.935482903267;23980.280591582236;24045.87977060112;5923.28920529536;6178.474829639486;6209.441150296472;6233.532485063615;6233.657148856811;5942.584019118642;6125.326214116466;6191.969040154793;6202.596831205957;6213.471854892339;4104.589541045902;4568.109218702354;4646.047560250157;6160.5687601867885;6194.5973511721595;4611.469680986679;6037.215162028952;6928.44572434204;6980.616066116361;7016.824579385505;5096.617753668453;5297.073012222845;5761.0494268445655;6121.173641558377;6134.17188679527;22005.449863753372;26916.865415672994;27064.45871082587;27126.32184195391;27224.59163112555;2581.8709064546697;2654.6283520307175;2674.1041751013436;2765.460735156645;2881.8414987175697;9996.300258981873;10309.896901030968;10326.380417174994;10812.72968175794;10848.349099054003;1622.1889055472263;1860.6737093880913;1862.3574866670976;1876.0900963032918;1920.596674698315;104524.47737761338;132480.33759831236;134694;138433.9234911467;139949;11988.220765650205;12042.458089385998;12093.879061209274;12233.69415764613;12411.627651170298;16335.26491307894;16335.28479509658;16385.180740962904;16398.426055088014;16402.753958690628;8825.161609647073;9063.81872362549;9086.681966131153;9181.449113053239;9218.53907304632;8910.688125915562;8925.419847709878;8925.464472131693;9078.636854525877;9117.635294588275;4782.378290822171;4891;4893.241547560134;4899.338589290472;4966.255061740696;2057.146284292032;2103.6634138538066;2103.9894800526204;2108.230495868997;2108.3674897530677;1007.677543186188;1042.2495803021811;1046.8796088449926;1065.2756125834508;1076.2304951959386;22525.774742252695;22914.770852291596;23006.42483937915;23010.65484017741;23109.191178309015;990.9355891867006;1039.153090231459;1065.5614919858285;1097.9615713449991;1115.3865374044244;10944.56221751137;11703.297802131729;11756.353400563052;11812.350320732443;11878.821817672742;741156.2942185254;744699;767878;789539;811223;126303.36848315883;159516;160834;164010;167321.16339418225;943.1134733350628;986.146982859821;989.8119357322086;996.6230540161766;1029.5881647341123;18288.268469261082;18650.626987460448;19889.303874364326;19892.403227903185;20082.799172008094;61203.69398152981;61265.387346125965;61934.69032654808;62115.06827397683;62739.05891411724;90368.54815725879;90770;91644.54177729068;93329.5333523328;94401.63995900158;7660.2722741339485;8039.397045221514;8522.616482258438;8883.200511953955;9052.728418147466;13538.661533461349;13976.371063301973;14012.78980815309;14145.222012789396;14354;11242.831357529807;11507.136964727511;11820.694964481843;11838.348890811088;11856.762864742484;11707.590234341757;11952.549727305708;12008.979236764973;12216.14486985938;12269.815952760895;8421.663133474838;8562.828743425222;8690.30477561781;8860.202581767671;8876.86684699717;13384.397702103233;13604.319784010562;14029.789553156506;14209.928950355183;14493.130412175304;12330.581983072061;12407.503699852266;12672.239665620093;12677.492900283885;12686.555970540987 21:04:57 INFO - PROCESS | 1642 | |3;mootools.html;1118.9090636629282;1285.6978610026642;1460.8027916231306;1485.2722166138594;1486.1677460622052;7645.503042302246;8024.799380015495;8270.710525131613;8348.624311905964;8514.063453020162;8389.454685445442;8460.91539084609;8462.23839854413;8481.406301558893;8482.872756908635;2387.3196139100314;2425.5027719317586;2427.7086749590076;2429.2226487524;2430.173740928084;2174.619441597722;2261.321603518946;2369.490559529701;2449.448874003344;2450.509898020403;2414.9396265093337;2415.10641062807;2427.320350301918;2427.66012758214;2428.4657375377387;2314.6875171851752;2342.672025916373;2343.789058984691;2346.21401830387;2362.126013375045;2382.5354055959097;2389.581823180936;2460.0774709483944;2460.3111128883943;2460.5447992121517;8575.614097365633;8614.483131012097;8649.351298652564;8684.261837743736;8691.869621955675;5142.177251639757;5253.52718255355;5317.893642127175;5322.574194064466;5333.759980800874;3362.3115529295706;3441.5698037745283;3461.8442170102408;3543.3799085160254;3548.2371290172737;1132.6941725734089;1139.9886001139964;1162.2387336294742;1194.4266751959021;1244.0420875925577;10703.518341674644;11025.779484410426;11186.32882027081;11191.832122518168;11284.097272218203;4541.114482675846;4625.444946606362;4664.55686709762;4669.626429885601;4676.111538807616;8886.511241881759;8926.509042002623;8930.419522731132;8941.642334306554;8945.15021072997;5226.973865130726;5227.45111763267;5230.0585894539345;5234.057869583436;5244.213367994831;4807.399075115611;4827.08285425768;4860.586850117779;4900.362952816183;4909.165441874889;3220.2754380264255;3590.994521533975;3799.810009499514;3863.285292220948;3900.5124359455067;1165.4347641394086;1171.753931674341;1174.6593487888588;1186.9643910682694;1198.80219763738;786.4337676872642;883.9469631821983;886.3972498700816;891.8171774786153;910.1535571918047;4967.7019378837385;5368.765184007622;5687.516561092353;5689.829305120853;5729.942700573024;968.3512046928433;1001.7996400719885;1029.3206483720708;1038.8753349597946;1085.5060947268973;3336.866525338959;3430.776999495025;3684.0421490412687;3718.200586873781;3793.0896584819443;9930.354526955869;10256.43589602579;10260.897391026143;10282.28024038325;10285.2800303978;9888.406695598287;10112.140468060297;10203.591856325813;10250.333728307636;10279.434631095362;7787.182345853717;7966.840663186704;8112.675492980333;8127.59362031896;8137;5385.8114965976;5453.10023846061;5528.364238112668;5573.554115670656;5611.943880561143;9163.49600771964;9230.400023998418;9359.391639543408;9406.153446189875;9503.572339244613;8137.471064380797;9376.859347109663;9392.248620110511;9508.191803696487;9539.47532885698;6877.071595334566;6968.163820341591;6991.475639327173;6998.75504357345;7012.368886800213;7756.68973241064;7998.000249968754;8134.918650813653;8188.385871059813;8206.22040906113;6138.693065346804;7131.572105673677;7211.567305961659;7228.20489746138;7352.669129889275;6659.633720145244;6824.897626535507;7127.073480447509;7193.2087470379265;7236.457265704988;5485;6406.775762848464;6435.09908612804;6498.772542960974;6516.641584712696;4930.239066122983;5009.373828271466;5009.674371165863;5056.443791183041;5144.794208231779;4904.926426103682;5027.3464449621315;5052.59579233653;5076.796928122982;5148.150555158507 21:04:57 INFO - PROCESS | 1642 | |4;prototype.html;311.5047075150511;331.4613752651939;356.96251893551175;374.0946908481475;381.266062829054;5078.64449488536;5202.580799928032;5209.426963034063;5241.3186285782895;5249.317588713467;4507.706999045068;5078.136716758151;5136.5858046717985;5190.974045129769;5208.760233099765;3229.4348489014446;3833.5049330760885;3989.2819292527333;3989.6608788253034;4007.418924255981;3279.4752839545677;3475.461303497962;3679.4296883982893;3881.146147847483;3920.5883382244883;3827.3302172119766;3932.9126635591065;3939.6651284640698;3953.6639385652256;3978.7015973801936;3937.1928754605237;3946.6842652587725;3960.2475529649273;3974.1852920151446;3982.2433737589763;3176.5552822604623;3325.9168520786934;3388.745844061705;3453.9810755827093;3492.6332735062706;4088.3867419886956;5065.302329299595;5077.669951453144;5111.49210982761;5146.408163061221;3942.14719082031;4540.704854184501;4558.766204559775;4629.86110416688;4651.930221046687;4827.686200396963;5110.156824124052;5202.739863006835;5396.622236443451;5505.807296744635;3226.306344136022;3238.5951756030495;3547.113221694576;3795.981020094882;3809.142942837867;5187.688738675653;5500.037493438632;5754.971225143848;5872;5897.3218079920925;3479.66033077262;3579.1925077835526;3585.4403334549556;3949.229900169497;3951.4863067801;3326.8854933597518;3466.6533346665133;3482.460218666111;3690.501782259414;3909.4722212500947;3846.7114966377635;3988.980055099706;4161.687873409506;4515.074409745994;4535.523770004168;4897.853064408074;5516.117421212587;5519.254900588449;5532.363778165482;5537.197106419547;1148.2708480115186;1237.9724828392414;1265.582357821935;1266.1769849597836;1287.7682017236987;756.8788993760971;866.8947092457167;870.5647176411794;873.7335112790532;883.3595643158787;4272.957270427318;4800.839622170038;4854.587360074363;4960.107180707435;4976.576990955737;4370.819878632815;4617.868622187586;5252.422233554306;5404.594655400861;5476.835694929158;4197.990918672721;4280.779977706339;5092.9745351273;5118.718470484085;5138.3577052868395;2561.9103331383685;2585.7026441959038;2636.8154229204156;2737.3293543082073;2749.175247425764;4504.864854054384;4770.546798054179;5417.729113544307;5494.725263736797;5535.833924982257;4919.926201106915;5413.404525502192;5414.673405015797;5441.972790136024;5488.286522752097;5029.491152654189;5064.41759197697;5478.506934375925;5512;5543.972280138654;4504.34686970394;5090.770915308746;5227.58179345659;5271.472852714698;5293.761780719799;4929.654924155275;5016.6237532184505;5179.766910489112;5219.5041471060185;5225.346831646044;5038.974805125951;5418.45815418455;5456.290682211287;5518.310211223597;5562;3149.811011339327;3489.4416893296952;3536.8938931832085;3579.4451859961746;3656.305301992613;4418.513963464081;4924.63065270099;5280.471952804689;5299.993001329735;5337.946620533745;4535.092981403798;4988.204246471195;5078.7206703631655;5134.229865520202;5199.324087868553;5408.45915408456;5426.864328391822;5432.456754324536;5443.346798384219;5483.7806487740045;4775.5463230993;4794.736289504111;5272.604554658339;5302.674331417145;5328.813491527778;5166.6125040621355;5196.818111366084;5289.353175451692;5380.488853558905;5400.162974738922;4282.20147538041;5235.214717792362;5241.947580524146;5320.57435405159;5344.465553444625 21:04:57 INFO - PROCESS | 1642 | |5;yui.html;723.5839392349394;728.4427413029034;747.0922828763051;818.5497976113138;836.4145098431098;14654.853451465482;14884.404623815062;15199.620009499768;15269.389224431023;15746.133962632051;14072.64818379541;14252;14338.713225735479;14371.209583472904;14452.855471445282;888.1473785166248;904.9411788233743;905.5427009360296;906.7642412972641;907.3965812734524;712.7327252280395;733.5122143774383;877.662100091463;898.7708134425712;903.701778413122;964.1563631822156;964.2189826240732;964.8070385922808;965.7440778193784;966.5650457294211;959.8560215967626;960.7357976556433;961.5865177973469;963.3834346018554;964.0744884910495;718.2960698515484;720.2833180984901;720.4092644031896;722.0252658910481;722.642292065431;15032.022918510262;15076.849231507655;15162.696746065127;15308.846911530853;15399.923000385039;14569.854301456955;14704.48534301305;14814.777778333333;14909.552713418614;14950.102993820406;9444.763880902963;11102.333859968347;11264.493097810619;11566.47950842214;11920.10599205063;3490.581130264359;3513.3851575974104;3663.523741913561;3715.16408808016;3727.813609319523;103867.96132038659;106206.46896765544;106931;109298;110962.78074438547;11271.323720576791;11400.372979486208;11473.71315717097;11676.88323116758;11997.040236781037;22924.4268893279;23128.768712312998;23442.179523716928;23483.530329393318;23560.88219558891;7468.925310746823;7497.362724168398;7521.360684341783;7577.772666820004;7718.498297610638;4074.246264441088;4162.001119731242;4168.520620128664;4174.666026717855;4187.539370669224;3423.281110966725;3511.4030614795033;3530.858765649345;3533.1343820763564;3934.901627459279;720.1753991679498;721.0662192460776;728.5118970289918;738.2469880721741;738.3871386748986;549.5521150262523;556.3407362275716;567.4240645744572;577.3568780991955;580.7705956147382;9103.772405689911;10178.643747468803;10306;10328.018838210359;10595.94702026485;660.4881217056724;676.1142902797351;688.3907741648677;690.5960013392122;700.1038670501766;4266.957330426656;4394.692371534026;5035.295058691786;5067.594592432671;5073.365829271341;88332;112650.87349126404;113393.43303283596;115806;116692.41653791677;57896.84206315934;79623;83715.5814220925;86130.56934715286;88129;58787.412125878196;68300.6584967072;75067.87398189031;77349.61325193338;77953.22046779687;9360.765980850534;10470.214733894836;10976.890231097907;11035.668929932115;11315.434228288388;43392.56607433885;46206.76896615495;48639;49786.50213497819;52074;52718.73640631772;63806.68096659487;67202.66398667975;69190.61618767495;72674.54650907058;13614.93192534031;14009.929950350182;14059.859401405854;14348.49780257686;14461.276936153361;14966.700665986837;15494.380224790882;15604;15615.687686246438;16082.43711470093;13813.723725525233;14437.85562144365;15071.246437678292;15096.849031509984;15274.694506109594;13614.795778063535;14512;14715.264236788333;14760.852391476377;15082.17048062367;13642.2496762679;14175.64560885986;14244.287785610471;14449;14604.488842890449;10922.726931826768;11264.718382040515;11388.373639449579;11651.825222621497;11713.355765432983;11041;11339;11615.531761607695;11917.821232681343;12055.819162712742 21:04:57 INFO - PROCESS | 1642 | __end_tp_report 21:04:57 INFO - PROCESS | 1642 | __start_cc_report 21:04:57 INFO - PROCESS | 1642 | _x_x_mozilla_cycle_collect,1248 21:04:57 INFO - PROCESS | 1642 | __end_cc_report 21:04:57 INFO - PROCESS | 1642 | __startTimestamp1489122297209__endTimestamp 21:04:57 INFO - PROCESS | 1642 | 21:04:57 INFO - PROCESS | 1642 | ------- Summary: start ------- 21:04:57 INFO - PROCESS | 1642 | Number of tests: 6 21:04:57 INFO - PROCESS | 1642 | 21:04:57 INFO - PROCESS | 1642 | [#0] dojo.html Cycles:165 Average:5839.12 Median:6143.17 stddev:630.19 (10.3%) stddev-sans-first:604.23 21:04:57 INFO - PROCESS | 1642 | Values: 3475.4 3480.2 3484.6 3521.0 3533.9 5894.7 5910.1 5937.3 5945.3 5947.1 5846.4 5940.0 5950.9 5953.9 5954.6 5055.8 5230.4 5242.7 5270.6 5363.8 5226.7 5227.7 5242.4 5352.8 5365.5 5315.5 5329.3 5338.8 5341.0 5344.9 5318.4 5329.4 5329.4 5338.4 5348.7 4439.7 5180.4 5297.6 5301.1 5344.7 6004.2 6011.6 6014.1 6015.1 6028.9 6166.8 6205.8 6223.1 6225.8 6243.2 6224.9 6231.1 6238.1 6258.3 6272.2 5985.2 6000.2 6017.3 6020.2 6061.0 6187.8 6209.3 6216.3 6311.6 6342.6 6141.3 6145.4 6198.0 6245.1 6256.7 6198.0 6204.9 6207.1 6207.4 6212.3 6166.4 6234.8 6240.0 6247.2 6262.8 6149.2 6191.4 6214.9 6222.4 6236.8 5017.4 5019.6 5027.2 5030.7 5057.2 4448.3 4462.8 4464.6 4466.0 4488.2 5768.5 5907.6 5971.0 5974.3 5990.7 6143.2 6193.7 6197.4 6199.2 6223.2 5901.3 5901.7 5901.8 5916.4 5943.4 5416.8 5454.3 5466.2 5474.9 5496.7 6337.5 6352.0 6389.4 6404.7 6476.5 6215.6 6229.8 6230.3 6237.6 6243.4 6371.4 6399.8 6445.7 6460.9 6468.9 6171.8 6216.9 6227.0 6245.5 6256.1 6162.6 6179.2 6201.2 6222.2 6251.5 6234.5 6256.9 6258.4 6262.7 6273.2 6251.4 6252.0 6257.2 6262.1 6273.0 6053.7 6105.1 6128.8 6141.2 6149.6 6107.7 6175.1 6214.5 6218.9 6236.3 6137.9 6163.6 6185.5 6187.8 6197.7 21:04:57 INFO - PROCESS | 1642 | 21:04:57 INFO - PROCESS | 1642 | [#1] ext.html Cycles:180 Average:73479.80 Median:40244.30 stddev:158491.48 (393.8%) stddev-sans-first:158841.34 21:04:57 INFO - PROCESS | 1642 | Values: 486.2 507.8 519.7 524.4 535.5 32603.0 41813.8 42891.8 42943.8 44738.0 44805.6 45102.3 45162.9 45167.0 45196.3 9566.3 9785.9 9797.7 9806.6 9811.1 9080.7 9293.5 11994.0 12247.6 12289.1 12127.9 12184.3 12187.9 12194.6 12196.0 12038.6 12122.9 12124.2 12126.7 12173.5 11939.4 11981.3 12058.6 12065.0 12076.2 42697.4 42905.0 43045.4 43054.4 43136.4 4061.3 4121.6 4123.6 4123.9 4141.9 30666.1 31700.2 31732.7 32758.0 33357.5 3238.9 3245.2 3276.0 3321.4 3401.4 494798.0 495955.0 496200.0 496370.5 496387.0 62771.7 63135.4 63324.7 63349.4 63352.2 68134.0 68156.7 68171.0 68262.0 68390.7 17422.6 17637.3 17656.6 17683.6 17707.4 12399.6 13352.5 13550.0 13580.8 13618.8 14756.2 15218.2 20064.5 22841.7 23085.8 7230.0 7670.8 9022.7 9229.6 9299.9 903.3 905.3 912.5 946.6 949.4 31240.7 31312.1 31474.0 32405.8 32972.7 913.7 962.3 1139.7 1147.6 1202.1 15727.8 16268.8 16273.5 16309.8 16567.0 681781.0 682799.0 683171.0 683354.0 685729.0 64046.4 64430.7 64455.0 64656.7 64729.4 1344.3 1389.5 1392.3 1483.1 1485.9 30583.4 32321.5 32826.5 33475.7 34056.1 58383.8 60031.4 60167.0 60267.7 60284.4 582159.1 586572.0 587183.0 587623.0 589577.0 25071.7 25653.7 28726.3 29040.6 29075.1 39589.8 39597.8 45980.8 47235.3 51690.2 39228.2 39306.6 41012.0 41022.9 41684.2 40012.8 40184.0 40600.2 40966.8 42054.4 39443.4 39447.6 39912.0 40304.6 40420.4 33016.8 35098.5 35607.6 35631.1 35883.6 25779.9 26120.5 26168.9 26666.0 26674.3 21:04:57 INFO - PROCESS | 1642 | 21:04:57 INFO - PROCESS | 1642 | [#2] jquery.html Cycles:180 Average:42195.69 Median:23246.86 stddev:128307.53 (551.9%) stddev-sans-first:128629.00 21:04:57 INFO - PROCESS | 1642 | Values: 352.9 402.7 405.8 415.1 432.7 21388.6 22212.8 22762.0 22869.3 22881.2 21910.9 23384.5 23655.9 23980.3 24045.9 5923.3 6178.5 6209.4 6233.5 6233.7 5942.6 6125.3 6192.0 6202.6 6213.5 4104.6 4568.1 4646.0 6160.6 6194.6 4611.5 6037.2 6928.4 6980.6 7016.8 5096.6 5297.1 5761.0 6121.2 6134.2 22005.4 26916.9 27064.5 27126.3 27224.6 2581.9 2654.6 2674.1 2765.5 2881.8 9996.3 10309.9 10326.4 10812.7 10848.3 1622.2 1860.7 1862.4 1876.1 1920.6 104524.5 132480.3 134694.0 138433.9 139949.0 11988.2 12042.5 12093.9 12233.7 12411.6 16335.3 16335.3 16385.2 16398.4 16402.8 8825.2 9063.8 9086.7 9181.4 9218.5 8910.7 8925.4 8925.5 9078.6 9117.6 4782.4 4891.0 4893.2 4899.3 4966.3 2057.1 2103.7 2104.0 2108.2 2108.4 1007.7 1042.2 1046.9 1065.3 1076.2 22525.8 22914.8 23006.4 23010.7 23109.2 990.9 1039.2 1065.6 1098.0 1115.4 10944.6 11703.3 11756.4 11812.4 11878.8 741156.3 744699.0 767878.0 789539.0 811223.0 126303.4 159516.0 160834.0 164010.0 167321.2 943.1 986.1 989.8 996.6 1029.6 18288.3 18650.6 19889.3 19892.4 20082.8 61203.7 61265.4 61934.7 62115.1 62739.1 90368.5 90770.0 91644.5 93329.5 94401.6 7660.3 8039.4 8522.6 8883.2 9052.7 13538.7 13976.4 14012.8 14145.2 14354.0 11242.8 11507.1 11820.7 11838.3 11856.8 11707.6 11952.5 12009.0 12216.1 12269.8 8421.7 8562.8 8690.3 8860.2 8876.9 13384.4 13604.3 14029.8 14209.9 14493.1 12330.6 12407.5 12672.2 12677.5 12686.6 21:04:57 INFO - PROCESS | 1642 | 21:04:57 INFO - PROCESS | 1642 | [#3] mootools.html Cycles:180 Average:5468.51 Median:5109.49 stddev:2984.90 (58.4%) stddev-sans-first:2975.37 21:04:57 INFO - PROCESS | 1642 | Values: 1118.9 1285.7 1460.8 1485.3 1486.2 7645.5 8024.8 8270.7 8348.6 8514.1 8389.5 8460.9 8462.2 8481.4 8482.9 2387.3 2425.5 2427.7 2429.2 2430.2 2174.6 2261.3 2369.5 2449.4 2450.5 2414.9 2415.1 2427.3 2427.7 2428.5 2314.7 2342.7 2343.8 2346.2 2362.1 2382.5 2389.6 2460.1 2460.3 2460.5 8575.6 8614.5 8649.4 8684.3 8691.9 5142.2 5253.5 5317.9 5322.6 5333.8 3362.3 3441.6 3461.8 3543.4 3548.2 1132.7 1140.0 1162.2 1194.4 1244.0 10703.5 11025.8 11186.3 11191.8 11284.1 4541.1 4625.4 4664.6 4669.6 4676.1 8886.5 8926.5 8930.4 8941.6 8945.2 5227.0 5227.5 5230.1 5234.1 5244.2 4807.4 4827.1 4860.6 4900.4 4909.2 3220.3 3591.0 3799.8 3863.3 3900.5 1165.4 1171.8 1174.7 1187.0 1198.8 786.4 883.9 886.4 891.8 910.2 4967.7 5368.8 5687.5 5689.8 5729.9 968.4 1001.8 1029.3 1038.9 1085.5 3336.9 3430.8 3684.0 3718.2 3793.1 9930.4 10256.4 10260.9 10282.3 10285.3 9888.4 10112.1 10203.6 10250.3 10279.4 7787.2 7966.8 8112.7 8127.6 8137.0 5385.8 5453.1 5528.4 5573.6 5611.9 9163.5 9230.4 9359.4 9406.2 9503.6 8137.5 9376.9 9392.2 9508.2 9539.5 6877.1 6968.2 6991.5 6998.8 7012.4 7756.7 7998.0 8134.9 8188.4 8206.2 6138.7 7131.6 7211.6 7228.2 7352.7 6659.6 6824.9 7127.1 7193.2 7236.5 5485.0 6406.8 6435.1 6498.8 6516.6 4930.2 5009.4 5009.7 5056.4 5144.8 4904.9 5027.3 5052.6 5076.8 5148.2 21:04:57 INFO - PROCESS | 1642 | 21:04:57 INFO - PROCESS | 1642 | [#4] prototype.html Cycles:180 Average:4306.86 Median:4927.14 stddev:1317.00 (26.7%) stddev-sans-first:1286.10 21:04:57 INFO - PROCESS | 1642 | Values: 311.5 331.5 357.0 374.1 381.3 5078.6 5202.6 5209.4 5241.3 5249.3 4507.7 5078.1 5136.6 5191.0 5208.8 3229.4 3833.5 3989.3 3989.7 4007.4 3279.5 3475.5 3679.4 3881.1 3920.6 3827.3 3932.9 3939.7 3953.7 3978.7 3937.2 3946.7 3960.2 3974.2 3982.2 3176.6 3325.9 3388.7 3454.0 3492.6 4088.4 5065.3 5077.7 5111.5 5146.4 3942.1 4540.7 4558.8 4629.9 4651.9 4827.7 5110.2 5202.7 5396.6 5505.8 3226.3 3238.6 3547.1 3796.0 3809.1 5187.7 5500.0 5755.0 5872.0 5897.3 3479.7 3579.2 3585.4 3949.2 3951.5 3326.9 3466.7 3482.5 3690.5 3909.5 3846.7 3989.0 4161.7 4515.1 4535.5 4897.9 5516.1 5519.3 5532.4 5537.2 1148.3 1238.0 1265.6 1266.2 1287.8 756.9 866.9 870.6 873.7 883.4 4273.0 4800.8 4854.6 4960.1 4976.6 4370.8 4617.9 5252.4 5404.6 5476.8 4198.0 4280.8 5093.0 5118.7 5138.4 2561.9 2585.7 2636.8 2737.3 2749.2 4504.9 4770.5 5417.7 5494.7 5535.8 4919.9 5413.4 5414.7 5442.0 5488.3 5029.5 5064.4 5478.5 5512.0 5544.0 4504.3 5090.8 5227.6 5271.5 5293.8 4929.7 5016.6 5179.8 5219.5 5225.3 5039.0 5418.5 5456.3 5518.3 5562.0 3149.8 3489.4 3536.9 3579.4 3656.3 4418.5 4924.6 5280.5 5300.0 5337.9 4535.1 4988.2 5078.7 5134.2 5199.3 5408.5 5426.9 5432.5 5443.3 5483.8 4775.5 4794.7 5272.6 5302.7 5328.8 5166.6 5196.8 5289.4 5380.5 5400.2 4282.2 5235.2 5241.9 5320.6 5344.5 21:04:57 INFO - PROCESS | 1642 | 21:04:57 INFO - PROCESS | 1642 | [#5] yui.html Cycles:180 Average:20377.82 Median:3532.00 stddev:29037.94 (822.1%) stddev-sans-first:29081.90 21:04:57 INFO - PROCESS | 1642 | Values: 723.6 728.4 747.1 818.5 836.4 14654.9 14884.4 15199.6 15269.4 15746.1 14072.6 14252.0 14338.7 14371.2 14452.9 888.1 904.9 905.5 906.8 907.4 712.7 733.5 877.7 898.8 903.7 964.2 964.2 964.8 965.7 966.6 959.9 960.7 961.6 963.4 964.1 718.3 720.3 720.4 722.0 722.6 15032.0 15076.8 15162.7 15308.8 15399.9 14569.9 14704.5 14814.8 14909.6 14950.1 9444.8 11102.3 11264.5 11566.5 11920.1 3490.6 3513.4 3663.5 3715.2 3727.8 103868.0 106206.5 106931.0 109298.0 110962.8 11271.3 11400.4 11473.7 11676.9 11997.0 22924.4 23128.8 23442.2 23483.5 23560.9 7468.9 7497.4 7521.4 7577.8 7718.5 4074.2 4162.0 4168.5 4174.7 4187.5 3423.3 3511.4 3530.9 3533.1 3934.9 720.2 721.1 728.5 738.2 738.4 549.6 556.3 567.4 577.4 580.8 9103.8 10178.6 10306.0 10328.0 10595.9 660.5 676.1 688.4 690.6 700.1 4267.0 4394.7 5035.3 5067.6 5073.4 88332.0 112650.9 113393.4 115806.0 116692.4 57896.8 79623.0 83715.6 86130.6 88129.0 58787.4 68300.7 75067.9 77349.6 77953.2 9360.8 10470.2 10976.9 11035.7 11315.4 43392.6 46206.8 48639.0 49786.5 52074.0 52718.7 63806.7 67202.7 69190.6 72674.5 13614.9 14009.9 14059.9 14348.5 14461.3 14966.7 15494.4 15604.0 15615.7 16082.4 13813.7 14437.9 15071.2 15096.8 15274.7 13614.8 14512.0 14715.3 14760.9 15082.2 13642.2 14175.6 14244.3 14449.0 14604.5 10922.7 11264.7 11388.4 11651.8 11713.4 11041.0 11339.0 11615.5 11917.8 12055.8 21:04:57 INFO - PROCESS | 1642 | -------- Summary: end -------- 21:04:57 INFO - PROCESS | 1642 | 21:04:57 INFO - TEST-INFO | 1642: exit 0 21:04:57 INFO - TEST-OK | dromaeo_css | took 1117139ms 21:04:57 INFO - TEST-START | kraken 21:04:57 INFO - operating with platform_type : mac_ 21:04:57 INFO - Initialising browser for kraken test... 21:04:57 INFO - TEST-INFO | started process 1651 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/f4/zwr2n_y50tg1y44pl818tgt800000w/T/tmpzTKfAw/profile http://localhost:49242/getInfo.html) 21:04:59 INFO - PROCESS | 1651 | __metrics Screen width/height:1600/1200 21:04:59 INFO - PROCESS | 1651 | colorDepth:24 21:04:59 INFO - PROCESS | 1651 | Browser inner width/height: 1024/689 21:04:59 INFO - PROCESS | 1651 | __metrics 21:05:00 INFO - PROCESS | 1651 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 21:05:00 INFO - PROCESS | 1651 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:05:00 INFO - TEST-INFO | 1651: exit 0 21:05:00 INFO - Browser initialized. 21:05:00 INFO - Running cycle 1/1 for kraken test... 21:05:00 INFO - TEST-INFO | started process 1653 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/f4/zwr2n_y50tg1y44pl818tgt800000w/T/tmpzTKfAw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:05:12 INFO - PROCESS | 1653 | RSS: Main: 166612992 21:05:12 INFO - PROCESS | 1653 | 21:05:15 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-beat-detection) 21:05:16 INFO - PROCESS | 1653 | RSS: Main: 214175744 21:05:16 INFO - PROCESS | 1653 | 21:05:18 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-dft) 21:05:19 INFO - PROCESS | 1653 | RSS: Main: 228302848 21:05:19 INFO - PROCESS | 1653 | 21:05:22 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-fft) 21:05:23 INFO - PROCESS | 1653 | RSS: Main: 325226496 21:05:23 INFO - PROCESS | 1653 | 21:05:25 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-oscillator) 21:05:25 INFO - PROCESS | 1653 | RSS: Main: 227205120 21:05:25 INFO - PROCESS | 1653 | 21:05:28 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49242/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:05:28 INFO - PROCESS | 1653 | RSS: Main: 227368960 21:05:28 INFO - PROCESS | 1653 | 21:05:31 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49242/tests/kraken/driver.html?testName=imaging-darkroom) 21:05:32 INFO - PROCESS | 1653 | RSS: Main: 268107776 21:05:32 INFO - PROCESS | 1653 | 21:05:35 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49242/tests/kraken/driver.html?testName=imaging-desaturate) 21:05:35 INFO - PROCESS | 1653 | RSS: Main: 270069760 21:05:35 INFO - PROCESS | 1653 | 21:05:38 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49242/tests/kraken/driver.html?testName=json-parse-financial) 21:05:39 INFO - PROCESS | 1653 | RSS: Main: 267182080 21:05:39 INFO - PROCESS | 1653 | 21:05:40 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49242/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:05:41 INFO - PROCESS | 1653 | RSS: Main: 245391360 21:05:41 INFO - PROCESS | 1653 | 21:05:43 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:05:43 INFO - PROCESS | 1653 | RSS: Main: 250380288 21:05:43 INFO - PROCESS | 1653 | 21:05:45 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:05:46 INFO - PROCESS | 1653 | RSS: Main: 256167936 21:05:46 INFO - PROCESS | 1653 | 21:05:49 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:05:50 INFO - PROCESS | 1653 | RSS: Main: 270577664 21:05:50 INFO - PROCESS | 1653 | 21:05:52 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:05:53 INFO - PROCESS | 1653 | RSS: Main: 264142848 21:05:53 INFO - PROCESS | 1653 | 21:05:55 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49242/tests/kraken/driver.html?testName=ai-astar) 21:05:55 INFO - PROCESS | 1653 | RSS: Main: 308539392 21:05:55 INFO - PROCESS | 1653 | 21:05:55 INFO - PROCESS | 1653 | __start_tp_report 21:05:55 INFO - PROCESS | 1653 | _x_x_mozilla_page_load 21:05:55 INFO - PROCESS | 1653 | _x_x_mozilla_page_load_details 21:05:55 INFO - PROCESS | 1653 | |i|pagename|runs| 21:05:55 INFO - PROCESS | 1653 | |0;ai-astar;113;164;128;113;121;167;153;113;113;112 21:05:55 INFO - PROCESS | 1653 | |1;audio-beat-detection;137;109;106;138;109;107;106;107;127;105 21:05:55 INFO - PROCESS | 1653 | |2;audio-dft;185;184;184;184;181;181;184;182;185;184 21:05:55 INFO - PROCESS | 1653 | |3;audio-fft;81;66;78;112;70;57;59;57;74;58 21:05:55 INFO - PROCESS | 1653 | |4;audio-oscillator;85;67;86;67;90;96;109;82;68;81 21:05:55 INFO - PROCESS | 1653 | |5;imaging-gaussian-blur;90;86;88;86;89;86;90;85;90;127 21:05:55 INFO - PROCESS | 1653 | |6;imaging-darkroom;95;95;95;95;95;99;141;95;95;95 21:05:55 INFO - PROCESS | 1653 | |7;imaging-desaturate;86;84;88;85;88;85;87;87;86;86 21:05:55 INFO - PROCESS | 1653 | |8;json-parse-financial;55;54;53;55;56;54;56;56;55;55 21:05:55 INFO - PROCESS | 1653 | |9;json-stringify-tinderbox;66;80;71;73;71;68;70;71;69;67 21:05:55 INFO - PROCESS | 1653 | |10;stanford-crypto-aes;83;83;84;81;81;82;82;81;83;87 21:05:55 INFO - PROCESS | 1653 | |11;stanford-crypto-ccm;131;132;129;134;135;141;134;137;198;164 21:05:55 INFO - PROCESS | 1653 | |12;stanford-crypto-pbkdf2;163;162;162;163;163;163;160;164;169;161 21:05:55 INFO - PROCESS | 1653 | |13;stanford-crypto-sha256-iterative;64;64;64;63;65;63;63;64;66;79 21:05:55 INFO - PROCESS | 1653 | __end_tp_report 21:05:55 INFO - PROCESS | 1653 | __start_cc_report 21:05:55 INFO - PROCESS | 1653 | _x_x_mozilla_cycle_collect,1980 21:05:55 INFO - PROCESS | 1653 | __end_cc_report 21:05:55 INFO - PROCESS | 1653 | __startTimestamp1489122355453__endTimestamp 21:05:55 INFO - PROCESS | 1653 | 21:05:55 INFO - PROCESS | 1653 | ------- Summary: start ------- 21:05:55 INFO - PROCESS | 1653 | Number of tests: 14 21:05:55 INFO - PROCESS | 1653 | 21:05:55 INFO - PROCESS | 1653 | [#0] ai-astar Cycles:10 Average:129.70 Median:124.50 stddev:22.65 (18.2%) stddev-sans-first:23.21 21:05:55 INFO - PROCESS | 1653 | Values: 113.0 164.0 128.0 113.0 121.0 167.0 153.0 113.0 113.0 112.0 21:05:55 INFO - PROCESS | 1653 | 21:05:55 INFO - PROCESS | 1653 | [#1] audio-beat-detection Cycles:10 Average:115.10 Median:109.00 stddev:13.41 (12.3%) stddev-sans-first:11.65 21:05:55 INFO - PROCESS | 1653 | Values: 137.0 109.0 106.0 138.0 109.0 107.0 106.0 107.0 127.0 105.0 21:05:55 INFO - PROCESS | 1653 | 21:05:55 INFO - PROCESS | 1653 | [#2] audio-dft Cycles:10 Average:183.40 Median:184.00 stddev:1.51 (0.8%) stddev-sans-first:1.48 21:05:55 INFO - PROCESS | 1653 | Values: 185.0 184.0 184.0 184.0 181.0 181.0 184.0 182.0 185.0 184.0 21:05:55 INFO - PROCESS | 1653 | 21:05:55 INFO - PROCESS | 1653 | [#3] audio-fft Cycles:10 Average:71.20 Median:68.00 stddev:16.90 (24.8%) stddev-sans-first:17.55 21:05:55 INFO - PROCESS | 1653 | Values: 81.0 66.0 78.0 112.0 70.0 57.0 59.0 57.0 74.0 58.0 21:05:55 INFO - PROCESS | 1653 | 21:05:55 INFO - PROCESS | 1653 | [#4] audio-oscillator Cycles:10 Average:83.10 Median:83.50 stddev:13.54 (16.2%) stddev-sans-first:14.34 21:05:55 INFO - PROCESS | 1653 | Values: 85.0 67.0 86.0 67.0 90.0 96.0 109.0 82.0 68.0 81.0 21:05:55 INFO - PROCESS | 1653 | 21:05:55 INFO - PROCESS | 1653 | [#5] imaging-gaussian-blur Cycles:10 Average:91.70 Median:88.50 stddev:12.55 (14.2%) stddev-sans-first:13.30 21:05:55 INFO - PROCESS | 1653 | Values: 90.0 86.0 88.0 86.0 89.0 86.0 90.0 85.0 90.0 127.0 21:05:55 INFO - PROCESS | 1653 | 21:05:55 INFO - PROCESS | 1653 | [#6] imaging-darkroom Cycles:10 Average:100.00 Median:95.00 stddev:14.46 (15.2%) stddev-sans-first:15.22 21:05:55 INFO - PROCESS | 1653 | Values: 95.0 95.0 95.0 95.0 95.0 99.0 141.0 95.0 95.0 95.0 21:05:55 INFO - PROCESS | 1653 | 21:05:55 INFO - PROCESS | 1653 | [#7] imaging-desaturate Cycles:10 Average:86.20 Median:86.50 stddev:1.32 (1.5%) stddev-sans-first:1.39 21:05:55 INFO - PROCESS | 1653 | Values: 86.0 84.0 88.0 85.0 88.0 85.0 87.0 87.0 86.0 86.0 21:05:55 INFO - PROCESS | 1653 | 21:05:55 INFO - PROCESS | 1653 | [#8] json-parse-financial Cycles:10 Average:54.90 Median:55.00 stddev:0.99 (1.8%) stddev-sans-first:1.05 21:05:55 INFO - PROCESS | 1653 | Values: 55.0 54.0 53.0 55.0 56.0 54.0 56.0 56.0 55.0 55.0 21:05:55 INFO - PROCESS | 1653 | 21:05:55 INFO - PROCESS | 1653 | [#9] json-stringify-tinderbox Cycles:10 Average:70.60 Median:71.00 stddev:3.92 (5.5%) stddev-sans-first:3.79 21:05:55 INFO - PROCESS | 1653 | Values: 66.0 80.0 71.0 73.0 71.0 68.0 70.0 71.0 69.0 67.0 21:05:55 INFO - PROCESS | 1653 | 21:05:55 INFO - PROCESS | 1653 | [#10] stanford-crypto-aes Cycles:10 Average:82.70 Median:83.00 stddev:1.83 (2.2%) stddev-sans-first:1.94 21:05:55 INFO - PROCESS | 1653 | Values: 83.0 83.0 84.0 81.0 81.0 82.0 82.0 81.0 83.0 87.0 21:05:55 INFO - PROCESS | 1653 | 21:05:55 INFO - PROCESS | 1653 | [#11] stanford-crypto-ccm Cycles:10 Average:143.50 Median:136.00 stddev:21.58 (15.9%) stddev-sans-first:22.41 21:05:55 INFO - PROCESS | 1653 | Values: 131.0 132.0 129.0 134.0 135.0 141.0 134.0 137.0 198.0 164.0 21:05:55 INFO - PROCESS | 1653 | 21:05:55 INFO - PROCESS | 1653 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.00 Median:163.00 stddev:2.40 (1.5%) stddev-sans-first:2.55 21:05:55 INFO - PROCESS | 1653 | Values: 163.0 162.0 162.0 163.0 163.0 163.0 160.0 164.0 169.0 161.0 21:05:55 INFO - PROCESS | 1653 | 21:05:55 INFO - PROCESS | 1653 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.50 Median:64.00 stddev:4.84 (7.6%) stddev-sans-first:5.10 21:05:55 INFO - PROCESS | 1653 | Values: 64.0 64.0 64.0 63.0 65.0 63.0 63.0 64.0 66.0 79.0 21:05:55 INFO - PROCESS | 1653 | -------- Summary: end -------- 21:05:55 INFO - PROCESS | 1653 | 21:05:56 INFO - TEST-INFO | 1653: exit 0 21:05:56 INFO - TEST-OK | kraken | took 58504ms 21:05:56 INFO - SUITE-END | took 1175s 21:05:56 INFO - Completed test suite (00:19:35) 21:05:56 INFO - javascript benchmark 21:05:56 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3475.443928971364, 3480.199554102555, 3484.634113418091, 3521.0317162780248, 3533.92932141357, 5894.675792831393, 5910.0543912973935, 5937.346891841894, 5945.316288626815, 5947.078202878555, 5846.415358464162, 5940.04959206527, 5950.9107363389585, 5953.851153721159, 5954.612950158236, 5055.823046193384, 5230.424653288144, 5242.737863106849, 5270.631055826094, 5363.785448582072, 5226.686398816083, 5227.712475813829, 5242.397124330693, 5352.839414817562, 5365.463453654643, 5315.468453154673, 5329.307190065286, 5338.813141540047, 5341.011912796145, 5344.946550534503, 5318.441563635821, 5329.387120481156, 5329.413764485904, 5338.412774594792, 5348.705821179834, 4439.689221754478, 5180.378354597435, 5297.602679799031, 5301.0723123453245, 5344.652597581184, 6004.159417681528, 6011.639301641915, 6014.097885317194, 6015.09773533969, 6028.879422411571, 6166.784162554289, 6205.81382558524, 6223.1287619733275, 6225.8132256032395, 6243.188385509855, 6224.906626400608, 6231.065340198961, 6238.1266622672865, 6258.280297765769, 6272.18461599989, 5985.221921150266, 6000.249968753906, 6017.344697214989, 6020.1872747179, 6061.030235162397, 6187.84530386744, 6209.316975132731, 6216.2540495140875, 6311.558190926683, 6342.619442833445, 6141.332587233735, 6145.385461453819, 6198.039303907902, 6245.094461303085, 6256.687165641791, 6197.96901015492, 6204.937950620526, 6207.068939658997, 6207.441330280297, 6212.254529456494, 6166.445019948136, 6234.781782637586, 6239.96880015597, 6247.219097612799, 6262.780802671885, 6149.2313460817395, 6191.4118158774845, 6214.906776398358, 6222.408871157233, 6236.812895613139, 5017.397912250481, 5019.648624596316, 5027.170516864677, 5030.7233102179, 5057.241413787961, 4448.266036104072, 4462.821487140478, 4464.628055551383, 4465.977670111693, 4488.192125417456, 5768.480836724715, 5907.556933230025, 5971.044632858721, 5974.2830860297045, 5990.700464976734, 6143.1706719592285, 6193.721282542297, 6197.411245931719, 6199.16311297969, 6223.222097237845, 5901.29184497863, 5901.704914754245, 5901.822945311647, 5916.408359164136, 5943.405659434108, 5416.83749487516, 5454.3454785426, 5466.180072989004, 5474.945250547444, 5496.697681627549, 6337.524685648503, 6351.9682401588625, 6389.361063893573, 6404.71178796946, 6476.5466417350335, 6215.627062376272, 6229.750809967732, 6230.314665386894, 6237.563370564017, 6243.43809057187, 6371.39471750183, 6399.776007839703, 6445.742170313322, 6460.935390646221, 6468.870622587616, 6171.753129874754, 6216.906746398718, 6227.034809604518, 6245.500359971283, 6256.092866534236, 6162.599431036968, 6179.196704428396, 6201.193844800147, 6222.160008398808, 6251.468625166912, 6234.501239900887, 6256.874862502634, 6258.43674069336, 6262.718177681924, 6273.15312432834, 6251.4061164189325, 6251.968740156452, 6257.217847769029, 6262.060690896402, 6273.027680709497, 6053.697315134314, 6105.145279660762, 6128.808691620048, 6141.170941922962, 6149.600275982047, 6107.664078475549, 6175.135481032748, 6214.5028397727165, 6218.906716399348, 6236.282827474898, 6137.938620613737, 6163.568550201443, 6185.505159587132, 6187.84530386726, 6197.690115494297], "value": 5799.282233463679, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [486.21233601565456, 507.80195723667754, 519.6903802417906, 524.4021815130749, 535.5126834580533, 32603.0, 41813.790931045376, 42891.78554107225, 42943.78528107355, 44738.0, 44805.55194448055, 45102.323465147965, 45162.87092822681, 45167.0, 45196.3220551692, 9566.33035687504, 9785.902140978571, 9797.657082002132, 9806.607735690564, 9811.116999470047, 9080.727578172666, 9293.488858112802, 11994.0, 12247.63257102284, 12289.139760216789, 12127.878721212808, 12184.329861857594, 12187.878121218808, 12194.634160975185, 12196.0, 12038.57864974726, 12122.939385303018, 12124.211926224856, 12126.696832579168, 12173.452194651261, 11939.403029848472, 11981.341026243554, 12058.6382408527, 12064.974477169364, 12076.154669173162, 42697.35953960693, 42905.0, 43045.35431968523, 43054.354184687254, 43136.352954705704, 4061.2892743770017, 4121.5878412158845, 4123.60825721559, 4123.8556650517085, 4141.91716165678, 30666.080017599506, 31700.207494812814, 31732.682673173204, 32758.017259482254, 33357.499637505454, 3238.8542515586855, 3245.237369218232, 3276.0499455157974, 3321.368939901411, 3401.4217583010945, 494798.0, 495955.0, 496200.0, 496370.5181474106, 496387.0, 62771.686141569, 63135.368646313866, 63324.68337658282, 63349.36650633434, 63352.198868068066, 68134.0, 68156.6592167036, 68171.0, 68262.0, 68390.65804670945, 17422.564435889206, 17637.294508219784, 17656.558586035197, 17683.55791105207, 17707.38024169148, 12399.566015189424, 13352.465901363837, 13550.0, 13580.796288055688, 13618.795718064237, 14756.188409637358, 15218.239088045553, 20064.49838754043, 22841.657375139388, 23085.845707714547, 7229.963850180716, 7670.846583068307, 9022.684206052889, 9229.584668689791, 9299.907000929905, 903.263839970422, 905.2712566384124, 912.543728135932, 946.597695979206, 949.3876449689911, 31240.687593124232, 31312.06063818089, 31474.0, 32405.837970809996, 32972.67027329744, 913.6893456224915, 962.3167551038841, 1139.7435576995276, 1147.5811328864904, 1202.0864143251017, 15727.842721572637, 16268.803711499033, 16273.51179464618, 16309.755353669705, 16567.00597964126, 681781.0, 682799.0, 683171.0, 683354.0, 685729.0, 64046.35953640497, 64430.677846611405, 64455.0, 64656.676716616115, 64729.35270647328, 1344.267374281019, 1389.5483967710736, 1392.317764295488, 1483.0730793254215, 1485.873700735428, 30583.388332232786, 32321.51517727283, 32826.50760238646, 33475.665243347255, 34056.14859628529, 58383.832323354145, 60031.399686004326, 60167.0, 60267.69866150641, 60284.39715602788, 582159.0892045513, 586572.0, 587183.0, 587623.0, 589577.0, 25071.749282506942, 25653.743462565137, 28726.281842954093, 29040.56439153372, 29075.127746167647, 39589.80205098956, 39597.80201098976, 45980.7700961493, 47235.291470628654, 51690.22464663108, 39228.21543569055, 39306.60693393029, 41012.0, 41022.92539878361, 41684.166316674105, 40012.7999360013, 40184.0, 40600.1879962405, 40966.79516602398, 42054.36918446287, 39443.35942377892, 39447.60552394554, 39912.00219994524, 40304.59695403009, 40420.3936940952, 33016.83491582623, 35098.473522897686, 35607.643923560434, 35631.10922226965, 35883.64116358803, 25779.871100645127, 26120.477590447703, 26168.8691556541, 26666.0, 26674.333141671614], "value": 21381.080685728055, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [352.86943830782616, 402.71206087647334, 405.8153540139237, 415.084738152374, 432.7295440349781, 21388.57222855544, 22212.777872221293, 22762.0, 22869.313920582368, 22881.19915802947, 21910.89044554775, 23384.532309353803, 23655.935482903267, 23980.280591582236, 24045.87977060112, 5923.28920529536, 6178.474829639486, 6209.441150296472, 6233.532485063615, 6233.657148856811, 5942.584019118642, 6125.326214116466, 6191.969040154793, 6202.596831205957, 6213.471854892339, 4104.589541045902, 4568.109218702354, 4646.047560250157, 6160.5687601867885, 6194.5973511721595, 4611.469680986679, 6037.215162028952, 6928.44572434204, 6980.616066116361, 7016.824579385505, 5096.617753668453, 5297.073012222845, 5761.0494268445655, 6121.173641558377, 6134.17188679527, 22005.449863753372, 26916.865415672994, 27064.45871082587, 27126.32184195391, 27224.59163112555, 2581.8709064546697, 2654.6283520307175, 2674.1041751013436, 2765.460735156645, 2881.8414987175697, 9996.300258981873, 10309.896901030968, 10326.380417174994, 10812.72968175794, 10848.349099054003, 1622.1889055472263, 1860.6737093880913, 1862.3574866670976, 1876.0900963032918, 1920.596674698315, 104524.47737761338, 132480.33759831236, 134694.0, 138433.9234911467, 139949.0, 11988.220765650205, 12042.458089385998, 12093.879061209274, 12233.69415764613, 12411.627651170298, 16335.26491307894, 16335.28479509658, 16385.180740962904, 16398.426055088014, 16402.753958690628, 8825.161609647073, 9063.81872362549, 9086.681966131153, 9181.449113053239, 9218.53907304632, 8910.688125915562, 8925.419847709878, 8925.464472131693, 9078.636854525877, 9117.635294588275, 4782.378290822171, 4891.0, 4893.241547560134, 4899.338589290472, 4966.255061740696, 2057.146284292032, 2103.6634138538066, 2103.9894800526204, 2108.230495868997, 2108.3674897530677, 1007.677543186188, 1042.2495803021811, 1046.8796088449926, 1065.2756125834508, 1076.2304951959386, 22525.774742252695, 22914.770852291596, 23006.42483937915, 23010.65484017741, 23109.191178309015, 990.9355891867006, 1039.153090231459, 1065.5614919858285, 1097.9615713449991, 1115.3865374044244, 10944.56221751137, 11703.297802131729, 11756.353400563052, 11812.350320732443, 11878.821817672742, 741156.2942185254, 744699.0, 767878.0, 789539.0, 811223.0, 126303.36848315883, 159516.0, 160834.0, 164010.0, 167321.16339418225, 943.1134733350628, 986.146982859821, 989.8119357322086, 996.6230540161766, 1029.5881647341123, 18288.268469261082, 18650.626987460448, 19889.303874364326, 19892.403227903185, 20082.799172008094, 61203.69398152981, 61265.387346125965, 61934.69032654808, 62115.06827397683, 62739.05891411724, 90368.54815725879, 90770.0, 91644.54177729068, 93329.5333523328, 94401.63995900158, 7660.2722741339485, 8039.397045221514, 8522.616482258438, 8883.200511953955, 9052.728418147466, 13538.661533461349, 13976.371063301973, 14012.78980815309, 14145.222012789396, 14354.0, 11242.831357529807, 11507.136964727511, 11820.694964481843, 11838.348890811088, 11856.762864742484, 11707.590234341757, 11952.549727305708, 12008.979236764973, 12216.14486985938, 12269.815952760895, 8421.663133474838, 8562.828743425222, 8690.30477561781, 8860.202581767671, 8876.86684699717, 13384.397702103233, 13604.319784010562, 14029.789553156506, 14209.928950355183, 14493.130412175304, 12330.581983072061, 12407.503699852266, 12672.239665620093, 12677.492900283885, 12686.555970540987], "value": 10407.047535031461, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1118.9090636629282, 1285.6978610026642, 1460.8027916231306, 1485.2722166138594, 1486.1677460622052, 7645.503042302246, 8024.799380015495, 8270.710525131613, 8348.624311905964, 8514.063453020162, 8389.454685445442, 8460.91539084609, 8462.23839854413, 8481.406301558893, 8482.872756908635, 2387.3196139100314, 2425.5027719317586, 2427.7086749590076, 2429.2226487524, 2430.173740928084, 2174.619441597722, 2261.321603518946, 2369.490559529701, 2449.448874003344, 2450.509898020403, 2414.9396265093337, 2415.10641062807, 2427.320350301918, 2427.66012758214, 2428.4657375377387, 2314.6875171851752, 2342.672025916373, 2343.789058984691, 2346.21401830387, 2362.126013375045, 2382.5354055959097, 2389.581823180936, 2460.0774709483944, 2460.3111128883943, 2460.5447992121517, 8575.614097365633, 8614.483131012097, 8649.351298652564, 8684.261837743736, 8691.869621955675, 5142.177251639757, 5253.52718255355, 5317.893642127175, 5322.574194064466, 5333.759980800874, 3362.3115529295706, 3441.5698037745283, 3461.8442170102408, 3543.3799085160254, 3548.2371290172737, 1132.6941725734089, 1139.9886001139964, 1162.2387336294742, 1194.4266751959021, 1244.0420875925577, 10703.518341674644, 11025.779484410426, 11186.32882027081, 11191.832122518168, 11284.097272218203, 4541.114482675846, 4625.444946606362, 4664.55686709762, 4669.626429885601, 4676.111538807616, 8886.511241881759, 8926.509042002623, 8930.419522731132, 8941.642334306554, 8945.15021072997, 5226.973865130726, 5227.45111763267, 5230.0585894539345, 5234.057869583436, 5244.213367994831, 4807.399075115611, 4827.08285425768, 4860.586850117779, 4900.362952816183, 4909.165441874889, 3220.2754380264255, 3590.994521533975, 3799.810009499514, 3863.285292220948, 3900.5124359455067, 1165.4347641394086, 1171.753931674341, 1174.6593487888588, 1186.9643910682694, 1198.80219763738, 786.4337676872642, 883.9469631821983, 886.3972498700816, 891.8171774786153, 910.1535571918047, 4967.7019378837385, 5368.765184007622, 5687.516561092353, 5689.829305120853, 5729.942700573024, 968.3512046928433, 1001.7996400719885, 1029.3206483720708, 1038.8753349597946, 1085.5060947268973, 3336.866525338959, 3430.776999495025, 3684.0421490412687, 3718.200586873781, 3793.0896584819443, 9930.354526955869, 10256.43589602579, 10260.897391026143, 10282.28024038325, 10285.2800303978, 9888.406695598287, 10112.140468060297, 10203.591856325813, 10250.333728307636, 10279.434631095362, 7787.182345853717, 7966.840663186704, 8112.675492980333, 8127.59362031896, 8137.0, 5385.8114965976, 5453.10023846061, 5528.364238112668, 5573.554115670656, 5611.943880561143, 9163.49600771964, 9230.400023998418, 9359.391639543408, 9406.153446189875, 9503.572339244613, 8137.471064380797, 9376.859347109663, 9392.248620110511, 9508.191803696487, 9539.47532885698, 6877.071595334566, 6968.163820341591, 6991.475639327173, 6998.75504357345, 7012.368886800213, 7756.68973241064, 7998.000249968754, 8134.918650813653, 8188.385871059813, 8206.22040906113, 6138.693065346804, 7131.572105673677, 7211.567305961659, 7228.20489746138, 7352.669129889275, 6659.633720145244, 6824.897626535507, 7127.073480447509, 7193.2087470379265, 7236.457265704988, 5485.0, 6406.775762848464, 6435.09908612804, 6498.772542960974, 6516.641584712696, 4930.239066122983, 5009.373828271466, 5009.674371165863, 5056.443791183041, 5144.794208231779, 4904.926426103682, 5027.3464449621315, 5052.59579233653, 5076.796928122982, 5148.150555158507], "value": 4445.125827491408, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [311.5047075150511, 331.4613752651939, 356.96251893551175, 374.0946908481475, 381.266062829054, 5078.64449488536, 5202.580799928032, 5209.426963034063, 5241.3186285782895, 5249.317588713467, 4507.706999045068, 5078.136716758151, 5136.5858046717985, 5190.974045129769, 5208.760233099765, 3229.4348489014446, 3833.5049330760885, 3989.2819292527333, 3989.6608788253034, 4007.418924255981, 3279.4752839545677, 3475.461303497962, 3679.4296883982893, 3881.146147847483, 3920.5883382244883, 3827.3302172119766, 3932.9126635591065, 3939.6651284640698, 3953.6639385652256, 3978.7015973801936, 3937.1928754605237, 3946.6842652587725, 3960.2475529649273, 3974.1852920151446, 3982.2433737589763, 3176.5552822604623, 3325.9168520786934, 3388.745844061705, 3453.9810755827093, 3492.6332735062706, 4088.3867419886956, 5065.302329299595, 5077.669951453144, 5111.49210982761, 5146.408163061221, 3942.14719082031, 4540.704854184501, 4558.766204559775, 4629.86110416688, 4651.930221046687, 4827.686200396963, 5110.156824124052, 5202.739863006835, 5396.622236443451, 5505.807296744635, 3226.306344136022, 3238.5951756030495, 3547.113221694576, 3795.981020094882, 3809.142942837867, 5187.688738675653, 5500.037493438632, 5754.971225143848, 5872.0, 5897.3218079920925, 3479.66033077262, 3579.1925077835526, 3585.4403334549556, 3949.229900169497, 3951.4863067801, 3326.8854933597518, 3466.6533346665133, 3482.460218666111, 3690.501782259414, 3909.4722212500947, 3846.7114966377635, 3988.980055099706, 4161.687873409506, 4515.074409745994, 4535.523770004168, 4897.853064408074, 5516.117421212587, 5519.254900588449, 5532.363778165482, 5537.197106419547, 1148.2708480115186, 1237.9724828392414, 1265.582357821935, 1266.1769849597836, 1287.7682017236987, 756.8788993760971, 866.8947092457167, 870.5647176411794, 873.7335112790532, 883.3595643158787, 4272.957270427318, 4800.839622170038, 4854.587360074363, 4960.107180707435, 4976.576990955737, 4370.819878632815, 4617.868622187586, 5252.422233554306, 5404.594655400861, 5476.835694929158, 4197.990918672721, 4280.779977706339, 5092.9745351273, 5118.718470484085, 5138.3577052868395, 2561.9103331383685, 2585.7026441959038, 2636.8154229204156, 2737.3293543082073, 2749.175247425764, 4504.864854054384, 4770.546798054179, 5417.729113544307, 5494.725263736797, 5535.833924982257, 4919.926201106915, 5413.404525502192, 5414.673405015797, 5441.972790136024, 5488.286522752097, 5029.491152654189, 5064.41759197697, 5478.506934375925, 5512.0, 5543.972280138654, 4504.34686970394, 5090.770915308746, 5227.58179345659, 5271.472852714698, 5293.761780719799, 4929.654924155275, 5016.6237532184505, 5179.766910489112, 5219.5041471060185, 5225.346831646044, 5038.974805125951, 5418.45815418455, 5456.290682211287, 5518.310211223597, 5562.0, 3149.811011339327, 3489.4416893296952, 3536.8938931832085, 3579.4451859961746, 3656.305301992613, 4418.513963464081, 4924.63065270099, 5280.471952804689, 5299.993001329735, 5337.946620533745, 4535.092981403798, 4988.204246471195, 5078.7206703631655, 5134.229865520202, 5199.324087868553, 5408.45915408456, 5426.864328391822, 5432.456754324536, 5443.346798384219, 5483.7806487740045, 4775.5463230993, 4794.736289504111, 5272.604554658339, 5302.674331417145, 5328.813491527778, 5166.6125040621355, 5196.818111366084, 5289.353175451692, 5380.488853558905, 5400.162974738922, 4282.20147538041, 5235.214717792362, 5241.947580524146, 5320.57435405159, 5344.465553444625], "value": 3903.3771224197462, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [723.5839392349394, 728.4427413029034, 747.0922828763051, 818.5497976113138, 836.4145098431098, 14654.853451465482, 14884.404623815062, 15199.620009499768, 15269.389224431023, 15746.133962632051, 14072.64818379541, 14252.0, 14338.713225735479, 14371.209583472904, 14452.855471445282, 888.1473785166248, 904.9411788233743, 905.5427009360296, 906.7642412972641, 907.3965812734524, 712.7327252280395, 733.5122143774383, 877.662100091463, 898.7708134425712, 903.701778413122, 964.1563631822156, 964.2189826240732, 964.8070385922808, 965.7440778193784, 966.5650457294211, 959.8560215967626, 960.7357976556433, 961.5865177973469, 963.3834346018554, 964.0744884910495, 718.2960698515484, 720.2833180984901, 720.4092644031896, 722.0252658910481, 722.642292065431, 15032.022918510262, 15076.849231507655, 15162.696746065127, 15308.846911530853, 15399.923000385039, 14569.854301456955, 14704.48534301305, 14814.777778333333, 14909.552713418614, 14950.102993820406, 9444.763880902963, 11102.333859968347, 11264.493097810619, 11566.47950842214, 11920.10599205063, 3490.581130264359, 3513.3851575974104, 3663.523741913561, 3715.16408808016, 3727.813609319523, 103867.96132038659, 106206.46896765544, 106931.0, 109298.0, 110962.78074438547, 11271.323720576791, 11400.372979486208, 11473.71315717097, 11676.88323116758, 11997.040236781037, 22924.4268893279, 23128.768712312998, 23442.179523716928, 23483.530329393318, 23560.88219558891, 7468.925310746823, 7497.362724168398, 7521.360684341783, 7577.772666820004, 7718.498297610638, 4074.246264441088, 4162.001119731242, 4168.520620128664, 4174.666026717855, 4187.539370669224, 3423.281110966725, 3511.4030614795033, 3530.858765649345, 3533.1343820763564, 3934.901627459279, 720.1753991679498, 721.0662192460776, 728.5118970289918, 738.2469880721741, 738.3871386748986, 549.5521150262523, 556.3407362275716, 567.4240645744572, 577.3568780991955, 580.7705956147382, 9103.772405689911, 10178.643747468803, 10306.0, 10328.018838210359, 10595.94702026485, 660.4881217056724, 676.1142902797351, 688.3907741648677, 690.5960013392122, 700.1038670501766, 4266.957330426656, 4394.692371534026, 5035.295058691786, 5067.594592432671, 5073.365829271341, 88332.0, 112650.87349126404, 113393.43303283596, 115806.0, 116692.41653791677, 57896.84206315934, 79623.0, 83715.5814220925, 86130.56934715286, 88129.0, 58787.412125878196, 68300.6584967072, 75067.87398189031, 77349.61325193338, 77953.22046779687, 9360.765980850534, 10470.214733894836, 10976.890231097907, 11035.668929932115, 11315.434228288388, 43392.56607433885, 46206.76896615495, 48639.0, 49786.50213497819, 52074.0, 52718.73640631772, 63806.68096659487, 67202.66398667975, 69190.61618767495, 72674.54650907058, 13614.93192534031, 14009.929950350182, 14059.859401405854, 14348.49780257686, 14461.276936153361, 14966.700665986837, 15494.380224790882, 15604.0, 15615.687686246438, 16082.43711470093, 13813.723725525233, 14437.85562144365, 15071.246437678292, 15096.849031509984, 15274.694506109594, 13614.795778063535, 14512.0, 14715.264236788333, 14760.852391476377, 15082.17048062367, 13642.2496762679, 14175.64560885986, 14244.287785610471, 14449.0, 14604.488842890449, 10922.726931826768, 11264.718382040515, 11388.373639449579, 11651.825222621497, 11713.355765432983, 11041.0, 11339.0, 11615.531761607695, 11917.821232681343, 12055.819162712742], "value": 7636.300306179824, "unit": "score"}], "name": "dromaeo_css", "value": 7450.155421180583, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 164.0, 128.0, 113.0, 121.0, 167.0, 153.0, 113.0, 113.0, 112.0], "value": 129.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 109.0, 106.0, 138.0, 109.0, 107.0, 106.0, 107.0, 127.0, 105.0], "value": 115.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 184.0, 184.0, 184.0, 181.0, 181.0, 184.0, 182.0, 185.0, 184.0], "value": 183.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 66.0, 78.0, 112.0, 70.0, 57.0, 59.0, 57.0, 74.0, 58.0], "value": 71.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 67.0, 86.0, 67.0, 90.0, 96.0, 109.0, 82.0, 68.0, 81.0], "value": 83.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 86.0, 88.0, 86.0, 89.0, 86.0, 90.0, 85.0, 90.0, 127.0], "value": 91.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 99.0, 141.0, 95.0, 95.0, 95.0], "value": 100.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 88.0, 85.0, 88.0, 85.0, 87.0, 87.0, 86.0, 86.0], "value": 86.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 54.0, 53.0, 55.0, 56.0, 54.0, 56.0, 56.0, 55.0, 55.0], "value": 54.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 80.0, 71.0, 73.0, 71.0, 68.0, 70.0, 71.0, 69.0, 67.0], "value": 70.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 84.0, 81.0, 81.0, 82.0, 82.0, 81.0, 83.0, 87.0], "value": 82.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 132.0, 129.0, 134.0, 135.0, 141.0, 134.0, 137.0, 198.0, 164.0], "value": 143.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 162.0, 163.0, 163.0, 163.0, 160.0, 164.0, 169.0, 161.0], "value": 163.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 64.0, 63.0, 65.0, 63.0, 63.0, 64.0, 66.0, 79.0], "value": 65.5, "unit": "score"}], "name": "kraken", "value": 1440.6000000000001, "alertThreshold": 2.0}]} 21:05:56 INFO - Return code: 0 21:05:56 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 21:05:56 INFO - # TBPL SUCCESS # 21:05:56 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 21:05:56 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 21:05:56 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 21:05:56 INFO - 2017-03-09 21:05:56.724 screenresolution[1657:9667] starting screenresolution argv=screenresolution get 21:05:56 INFO - 2017-03-09 21:05:56.726 screenresolution[1657:9667] Display 0: 1600x1200x32@60 21:05:56 INFO - 2017-03-09 21:05:56.733 screenresolution[1658:9671] starting screenresolution argv=screenresolution list 21:05:56 INFO - Available Modes on Display 0 21:05:56 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 21:05:56 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 21:05:56 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 21:05:56 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 21:05:56 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 21:05:56 INFO - Intel Iris: 21:05:56 INFO - Chipset Model: Intel Iris 21:05:56 INFO - Type: GPU 21:05:56 INFO - Bus: Built-In 21:05:56 INFO - VRAM (Dynamic, Max): 1536 MB 21:05:56 INFO - Vendor: Intel (0x8086) 21:05:56 INFO - Device ID: 0x0a2e 21:05:56 INFO - Revision ID: 0x0009 21:05:56 INFO - Displays: 21:05:56 INFO - Display: 21:05:56 INFO - Resolution: 1600 x 1200 @ 60 Hz 21:05:56 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 21:05:56 INFO - Display Serial Number: 1600x1200 60 21:05:56 INFO - Main Display: Yes 21:05:56 INFO - Mirror: Off 21:05:56 INFO - Online: Yes 21:05:56 INFO - Rotation: Supported 21:05:56 INFO - Return code: 0 21:05:56 INFO - Running post-action listener: _resource_record_post_action 21:05:56 INFO - [mozharness: 2017-03-10 05:05:56.969644Z] Finished run-tests step (success) 21:05:56 INFO - Running post-run listener: _resource_record_post_run 21:05:57 INFO - Total resource usage - Wall time: 1191s; CPU: 54.0%; Read bytes: 37209088; Write bytes: 420688896; Read time: 388; Write time: 1408 21:05:57 INFO - TinderboxPrint: CPU usage
53.7% 21:05:57 INFO - TinderboxPrint: I/O read bytes / time
37,209,088 / 388 21:05:57 INFO - TinderboxPrint: I/O write bytes / time
420,688,896 / 1,408 21:05:57 INFO - TinderboxPrint: CPU idle
2,204.3 (46.3%) 21:05:57 INFO - TinderboxPrint: CPU system
953.3 (20.0%) 21:05:57 INFO - TinderboxPrint: CPU user
1,608.1 (33.7%) 21:05:57 INFO - TinderboxPrint: Swap in / out
158,945,280 / 0 21:05:57 INFO - install - Wall time: 15s; CPU: 54.0%; Read bytes: 121610752; Write bytes: 113971200; Read time: 11067; Write time: 218 21:05:57 INFO - run-tests - Wall time: 1177s; CPU: 54.0%; Read bytes: 34636800; Write bytes: 296662016; Read time: 362; Write time: 1159 21:05:57 INFO - Running post-run listener: _upload_blobber_files 21:05:57 INFO - Blob upload gear active. 21:05:57 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 21:05:57 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 21:05:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 21:05:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 21:05:57 INFO - (blobuploader) - INFO - Open directory for files ... 21:05:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 21:05:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:05:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:05:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 21:05:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:05:59 INFO - (blobuploader) - INFO - Done attempting. 21:05:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 21:05:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:05:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:06:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 21:06:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:06:00 INFO - (blobuploader) - INFO - Done attempting. 21:06:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 21:06:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:06:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:06:01 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 21:06:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:06:01 INFO - (blobuploader) - INFO - Done attempting. 21:06:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 21:06:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:06:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:06:03 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 21:06:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:06:03 INFO - (blobuploader) - INFO - Done attempting. 21:06:03 INFO - (blobuploader) - INFO - Iteration through files over. 21:06:03 INFO - Return code: 0 21:06:03 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 21:06:03 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 21:06:03 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b44340633532c3dcf6c2d35905fae9650736bde522adda7b5e8e86c2f85b5bbaf7bf02525a409567ed8d1288ec0cf363cdcbb52972fbd19bbc4670c2d537f500", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/fe76fb6ef18e336fdea2f58de0c0e133ddb1a38f15ba24c332ea4767ed1a2f0cda60a6ec374b5437353b3aafe312512c6161a1dd46249e92b2bff6c75b44165e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0f59759096ac111b6650ed4d8e49d6b0da328ed02308358599021f8101a98a45eb3aa02a973aca551091fcbcba87cd796e1af6e709696bf433b624dcda786d07", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/11752206c6440b2c935f66353db56d4a04ce6041706d774ae97826d89d15e821fa65039aba5fea827ab85c29bea56c4392b8afce8a0440891e0051314f282171"} 21:06:03 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 21:06:03 INFO - Writing to file /builds/slave/test/properties/blobber_files 21:06:03 INFO - Contents: 21:06:03 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b44340633532c3dcf6c2d35905fae9650736bde522adda7b5e8e86c2f85b5bbaf7bf02525a409567ed8d1288ec0cf363cdcbb52972fbd19bbc4670c2d537f500", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/fe76fb6ef18e336fdea2f58de0c0e133ddb1a38f15ba24c332ea4767ed1a2f0cda60a6ec374b5437353b3aafe312512c6161a1dd46249e92b2bff6c75b44165e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0f59759096ac111b6650ed4d8e49d6b0da328ed02308358599021f8101a98a45eb3aa02a973aca551091fcbcba87cd796e1af6e709696bf433b624dcda786d07", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/11752206c6440b2c935f66353db56d4a04ce6041706d774ae97826d89d15e821fa65039aba5fea827ab85c29bea56c4392b8afce8a0440891e0051314f282171"} 21:06:03 INFO - Running post-run listener: copy_logs_to_upload_dir 21:06:03 INFO - Copying logs to upload dir... 21:06:03 INFO - mkdir: /builds/slave/test/build/upload/logs 21:06:03 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1256.466087 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2017-03-09 21:06:03.646051) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-09 21:06:03.649129) ========= 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.dsjHeaMubX/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.19kSzTeGsf/Listeners TMPDIR=/var/folders/f4/zwr2n_y50tg1y44pl818tgt800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b44340633532c3dcf6c2d35905fae9650736bde522adda7b5e8e86c2f85b5bbaf7bf02525a409567ed8d1288ec0cf363cdcbb52972fbd19bbc4670c2d537f500", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/fe76fb6ef18e336fdea2f58de0c0e133ddb1a38f15ba24c332ea4767ed1a2f0cda60a6ec374b5437353b3aafe312512c6161a1dd46249e92b2bff6c75b44165e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0f59759096ac111b6650ed4d8e49d6b0da328ed02308358599021f8101a98a45eb3aa02a973aca551091fcbcba87cd796e1af6e709696bf433b624dcda786d07", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/11752206c6440b2c935f66353db56d4a04ce6041706d774ae97826d89d15e821fa65039aba5fea827ab85c29bea56c4392b8afce8a0440891e0051314f282171"} build_url:https://queue.taskcluster.net/v1/task/TWx3h0TlQ4y4bu1e9lCaTw/artifacts/public/build/firefox-53.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010559 build_url: 'https://queue.taskcluster.net/v1/task/TWx3h0TlQ4y4bu1e9lCaTw/artifacts/public/build/firefox-53.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b44340633532c3dcf6c2d35905fae9650736bde522adda7b5e8e86c2f85b5bbaf7bf02525a409567ed8d1288ec0cf363cdcbb52972fbd19bbc4670c2d537f500", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/fe76fb6ef18e336fdea2f58de0c0e133ddb1a38f15ba24c332ea4767ed1a2f0cda60a6ec374b5437353b3aafe312512c6161a1dd46249e92b2bff6c75b44165e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0f59759096ac111b6650ed4d8e49d6b0da328ed02308358599021f8101a98a45eb3aa02a973aca551091fcbcba87cd796e1af6e709696bf433b624dcda786d07", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/11752206c6440b2c935f66353db56d4a04ce6041706d774ae97826d89d15e821fa65039aba5fea827ab85c29bea56c4392b8afce8a0440891e0051314f282171"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-09 21:06:03.683005) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-09 21:06:03.683329) ========= 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.dsjHeaMubX/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.19kSzTeGsf/Listeners TMPDIR=/var/folders/f4/zwr2n_y50tg1y44pl818tgt800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.005178 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-09 21:06:03.731895) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-09 21:06:03.732228) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-09 21:06:03.732630) ========= ========= Total master_lag: 0.17 =========